builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-009 starttime: 1469452678.23 results: success (0) buildid: 20160725020629 builduid: e9cffd69a2054ead90893fbe00f05894 revision: 517663b29d7ffc2ce91f90dc7beaac4fa35e52e5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-25 06:17:58.228289) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-25 06:17:58.228877) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-25 06:17:58.229570) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-25 06:17:58.277680) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 06:17:58.277940) ========= 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=17051fcd5208b27b50bedfeb000001dd-1469450989.154253-292069661 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-25 06:17:58-- 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.4M=0s 2016-07-25 06:17:58 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099773 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 06:17:58.396754) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 06:17:58.397057) ========= 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=17051fcd5208b27b50bedfeb000001dd-1469450989.154253-292069661 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014338 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 06:17:58.448837) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 06:17:58.449160) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 517663b29d7ffc2ce91f90dc7beaac4fa35e52e5 --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 517663b29d7ffc2ce91f90dc7beaac4fa35e52e5 --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=17051fcd5208b27b50bedfeb000001dd-1469450989.154253-292069661 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-25 06:17:58,782 truncating revision to first 12 chars 2016-07-25 06:17:58,782 Setting DEBUG logging. 2016-07-25 06:17:58,782 attempt 1/10 2016-07-25 06:17:58,782 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/517663b29d7f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-25 06:17:59,085 unpacking tar archive at: mozilla-aurora-517663b29d7f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.654358 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 06:17:59.116929) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-25 06:17:59.117243) ========= script_repo_revision: 517663b29d7ffc2ce91f90dc7beaac4fa35e52e5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-25 06:17:59.117655) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-25 06:17:59.117942) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-25 06:17:59.126593) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-07-25 06:17:59.126907) ========= /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=17051fcd5208b27b50bedfeb000001dd-1469450989.154253-292069661 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:17:59 INFO - MultiFileLogger online at 20160725 06:17:59 in /builds/slave/test 06:17:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 06:17:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:17:59 INFO - {'append_to_log': False, 06:17:59 INFO - 'base_work_dir': '/builds/slave/test', 06:17:59 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 06:17:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:17:59 INFO - 'branch': 'Mozilla-Aurora', 06:17:59 INFO - 'buildbot_json_path': 'buildprops.json', 06:17:59 INFO - 'config_files': ('talos/linux_config.py',), 06:17:59 INFO - 'default_actions': ('clobber', 06:17:59 INFO - 'read-buildbot-config', 06:17:59 INFO - 'download-and-extract', 06:17:59 INFO - 'populate-webroot', 06:17:59 INFO - 'create-virtualenv', 06:17:59 INFO - 'install', 06:17:59 INFO - 'run-tests'), 06:17:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:17:59 INFO - 'download_minidump_stackwalk': True, 06:17:59 INFO - 'download_symbols': 'ondemand', 06:17:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:17:59 INFO - 'tooltool.py': '/tools/tooltool.py', 06:17:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:17:59 INFO - '/tools/misc-python/virtualenv.py')}, 06:17:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:17:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:17:59 INFO - 'installer_path': 'installer.exe', 06:17:59 INFO - 'log_level': 'info', 06:17:59 INFO - 'log_name': 'talos', 06:17:59 INFO - 'log_to_console': True, 06:17:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:17:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:17:59 INFO - 'opt_config_files': (), 06:17:59 INFO - 'pip_index': False, 06:17:59 INFO - 'sps_profile': False, 06:17:59 INFO - 'sps_profile_interval': 0, 06:17:59 INFO - 'suite': 'dromaeojs-e10s', 06:17:59 INFO - 'system_bits': '32', 06:17:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:17:59 INFO - 'title': 'talos-linux64-ix-009', 06:17:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:17:59 INFO - 'use_talos_json': True, 06:17:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:17:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:17:59 INFO - 'work_dir': 'build'} 06:17:59 INFO - ##### 06:17:59 INFO - ##### Running clobber step. 06:17:59 INFO - ##### 06:17:59 INFO - Running pre-action listener: _resource_record_pre_action 06:17:59 INFO - Running main action method: clobber 06:17:59 INFO - rmtree: /builds/slave/test/build 06:17:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:18:00 INFO - Running post-action listener: _resource_record_post_action 06:18:00 INFO - ##### 06:18:00 INFO - ##### Finished clobber step (success) 06:18:00 INFO - ##### 06:18:00 INFO - ##### 06:18:00 INFO - ##### Running read-buildbot-config step. 06:18:00 INFO - ##### 06:18:00 INFO - Running pre-action listener: _resource_record_pre_action 06:18:00 INFO - Running main action method: read_buildbot_config 06:18:00 INFO - Using buildbot properties: 06:18:00 INFO - { 06:18:00 INFO - "project": "", 06:18:00 INFO - "product": "firefox", 06:18:00 INFO - "script_repo_revision": "production", 06:18:00 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 06:18:00 INFO - "repository": "", 06:18:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 06:18:00 INFO - "buildid": "20160725020629", 06:18:00 INFO - "pgo_build": "True", 06:18:00 INFO - "basedir": "/builds/slave/test", 06:18:00 INFO - "buildnumber": 463, 06:18:00 INFO - "slavename": "talos-linux64-ix-009", 06:18:00 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:18:00 INFO - "platform": "ubuntu64_hw", 06:18:00 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 06:18:00 INFO - "branch": "mozilla-aurora", 06:18:00 INFO - "repo_path": "releases/mozilla-aurora", 06:18:00 INFO - "revision": "517663b29d7ffc2ce91f90dc7beaac4fa35e52e5", 06:18:00 INFO - "stage_platform": "linux64-pgo", 06:18:00 INFO - "builduid": "e9cffd69a2054ead90893fbe00f05894", 06:18:00 INFO - "slavebuilddir": "test" 06:18:00 INFO - } 06:18:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 06:18:00 INFO - Running post-action listener: _resource_record_post_action 06:18:00 INFO - ##### 06:18:00 INFO - ##### Finished read-buildbot-config step (success) 06:18:00 INFO - ##### 06:18:00 INFO - ##### 06:18:00 INFO - ##### Running download-and-extract step. 06:18:00 INFO - ##### 06:18:00 INFO - Running pre-action listener: _resource_record_pre_action 06:18:00 INFO - Running main action method: download_and_extract 06:18:00 INFO - mkdir: /builds/slave/test/build/tests 06:18:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:00 INFO - https://queue.taskcluster.net/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:18:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 06:18:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 06:18:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 06:18:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:18:17 INFO - Downloaded 1361 bytes. 06:18:17 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 06:18:17 INFO - Using the following test package requirements: 06:18:17 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 06:18:17 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:18:17 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 06:18:17 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:18:17 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 06:18:17 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:18:17 INFO - u'jsshell-linux-x86_64.zip'], 06:18:17 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:18:17 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 06:18:17 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 06:18:17 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:18:17 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 06:18:17 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:18:17 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 06:18:17 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:18:17 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 06:18:17 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:18:17 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 06:18:17 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:18:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:17 INFO - https://queue.taskcluster.net/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:18:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 06:18:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 06:18:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 06:18:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:18:19 INFO - Downloaded 24494715 bytes. 06:18:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:18:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:18:20 INFO - Return code: 0 06:18:20 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:18:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:20 INFO - https://queue.taskcluster.net/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:18:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 06:18:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 06:18:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 06:18:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:18:23 INFO - Downloaded 24494715 bytes. 06:18: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'] 06:18: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 06:18:24 INFO - Return code: 0 06:18: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')]} 06:18:24 INFO - https://queue.taskcluster.net/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:18:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 06:18:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 06:18:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 06:18:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:18:25 INFO - Downloaded 10833369 bytes. 06:18:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:18:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:18:25 INFO - Return code: 0 06:18:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:25 INFO - https://queue.taskcluster.net/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:18:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 06:18:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 06:18:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 06:18:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:18:27 INFO - Downloaded 63633994 bytes. 06:18:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 06:18:27 INFO - mkdir: /builds/slave/test/properties 06:18:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:18:27 INFO - Writing to file /builds/slave/test/properties/build_url 06:18:27 INFO - Contents: 06:18:27 INFO - build_url:https://queue.taskcluster.net/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 06:18:28 INFO - Running post-action listener: _resource_record_post_action 06:18:28 INFO - Running post-action listener: set_extra_try_arguments 06:18:28 INFO - ##### 06:18:28 INFO - ##### Finished download-and-extract step (success) 06:18:28 INFO - ##### 06:18:28 INFO - ##### 06:18:28 INFO - ##### Running populate-webroot step. 06:18:28 INFO - ##### 06:18:28 INFO - Running pre-action listener: _resource_record_pre_action 06:18:28 INFO - Running main action method: populate_webroot 06:18:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:18:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:18:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:18:28 INFO - '--tppagecycles', 06:18:28 INFO - '7'], 06:18:28 INFO - 'tests': ['tsvgm']}}, 06:18:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:18:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:18:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:18:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:18:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:18:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:18:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:28 INFO - 'talos_options': ['--disable-e10s'], 06:18:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:18:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:18:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:28 INFO - 'talos_options': ['--disable-e10s'], 06:18:28 INFO - 'tests': ['damp', 'tps']}, 06:18:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:28 INFO - 'tests': ['damp', 'tps']}, 06:18:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:18:28 INFO - 'tests': ['dromaeo_dom']}, 06:18:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:18:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:18:28 INFO - 'tests': ['a11yr', 06:18:28 INFO - 'ts_paint', 06:18:28 INFO - 'tpaint', 06:18:28 INFO - 'sessionrestore', 06:18:28 INFO - 'sessionrestore_no_auto_restore', 06:18:28 INFO - 'tabpaint']}, 06:18:28 INFO - 'other-e10s': {'tests': ['a11yr', 06:18:28 INFO - 'ts_paint', 06:18:28 INFO - 'tpaint', 06:18:28 INFO - 'sessionrestore', 06:18:28 INFO - 'sessionrestore_no_auto_restore', 06:18:28 INFO - 'tabpaint']}, 06:18:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:18:28 INFO - 'ts_paint', 06:18:28 INFO - 'tpaint', 06:18:28 INFO - 'sessionrestore', 06:18:28 INFO - 'sessionrestore_no_auto_restore', 06:18:28 INFO - 'tabpaint']}, 06:18:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:18:28 INFO - 'ts_paint', 06:18:28 INFO - 'tpaint', 06:18:28 INFO - 'sessionrestore', 06:18:28 INFO - 'sessionrestore_no_auto_restore', 06:18:28 INFO - 'tabpaint']}, 06:18:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:18:28 INFO - 'tests': ['a11yr', 06:18:28 INFO - 'ts_paint', 06:18:28 INFO - 'tpaint', 06:18:28 INFO - 'sessionrestore', 06:18:28 INFO - 'sessionrestore_no_auto_restore', 06:18:28 INFO - 'tabpaint']}, 06:18:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:18:28 INFO - 'tests': ['a11yr', 06:18:28 INFO - 'ts_paint', 06:18:28 INFO - 'tpaint', 06:18:28 INFO - 'sessionrestore', 06:18:28 INFO - 'sessionrestore_no_auto_restore', 06:18:28 INFO - 'tabpaint']}, 06:18:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:18:28 INFO - 'tests': ['tsvgx', 06:18:28 INFO - 'tsvgr_opacity', 06:18:28 INFO - 'tart', 06:18:28 INFO - 'tscrollx', 06:18:28 INFO - 'cart']}, 06:18:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:18:28 INFO - 'tsvgr_opacity', 06:18:28 INFO - 'tart', 06:18:28 INFO - 'tscrollx', 06:18:28 INFO - 'cart']}, 06:18:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:28 INFO - 'talos_options': ['--disable-e10s'], 06:18:28 INFO - 'tests': ['tp5o']}, 06:18:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:28 INFO - 'tests': ['tp5o']}, 06:18:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:28 INFO - 'talos_options': ['--disable-e10s', 06:18:28 INFO - '--xperf_path', 06:18:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:18:28 INFO - 'tests': ['tp5n']}, 06:18:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:28 INFO - 'talos_options': ['--xperf_path', 06:18:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:18:28 INFO - 'tests': ['tp5n']}}, 06:18:28 INFO - 'talos.zip': {'path': '', 06:18:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:18:28 INFO - Running post-action listener: _resource_record_post_action 06:18:28 INFO - ##### 06:18:28 INFO - ##### Finished populate-webroot step (success) 06:18:28 INFO - ##### 06:18:28 INFO - ##### 06:18:28 INFO - ##### Running create-virtualenv step. 06:18:28 INFO - ##### 06:18:28 INFO - Running pre-action listener: _resource_record_pre_action 06:18:28 INFO - Running main action method: create_virtualenv 06:18:28 INFO - Creating virtualenv /builds/slave/test/build/venv 06:18:28 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:18:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:18:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:18:28 INFO - Using real prefix '/usr' 06:18:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:18:29 INFO - Installing distribute.............................................................................................................................................................................................done. 06:18:31 INFO - Installing pip.................done. 06:18:31 INFO - Return code: 0 06:18:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:18:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe2573bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1511350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a01c0>, '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 0x15a10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a1550>, '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': '17051fcd5208b27b50bedfeb000001dd-1469450989.154253-292069661', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:18:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:18:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:18:31 INFO - Using env: {'DISPLAY': ':0', 06:18:31 INFO - 'HOME': '/home/cltbld', 06:18:31 INFO - 'LANG': 'en_US.UTF-8', 06:18:31 INFO - 'LANGUAGE': 'en_US:en', 06:18:31 INFO - 'LOGNAME': 'cltbld', 06:18:31 INFO - 'MAIL': '/var/mail/cltbld', 06:18:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:31 INFO - 'MOZ_NO_REMOTE': '1', 06:18:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:31 INFO - 'NO_EM_RESTART': '1', 06:18:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:31 INFO - 'PWD': '/builds/slave/test', 06:18:31 INFO - 'SHELL': '/bin/bash', 06:18:31 INFO - 'SHLVL': '1', 06:18:31 INFO - 'TERM': 'linux', 06:18:31 INFO - 'TMOUT': '86400', 06:18:31 INFO - 'USER': 'cltbld', 06:18:31 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1469450989.154253-292069661', 06:18:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:31 INFO - '_': '/tools/buildbot/bin/python'} 06:18:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:31 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:18:31 INFO - Cleaning up... 06:18:31 INFO - Return code: 0 06:18:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:18:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbe2573bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1511350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a01c0>, '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 0x15a10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a1550>, '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': '17051fcd5208b27b50bedfeb000001dd-1469450989.154253-292069661', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:18:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:18:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:18:31 INFO - Using env: {'DISPLAY': ':0', 06:18:31 INFO - 'HOME': '/home/cltbld', 06:18:31 INFO - 'LANG': 'en_US.UTF-8', 06:18:31 INFO - 'LANGUAGE': 'en_US:en', 06:18:31 INFO - 'LOGNAME': 'cltbld', 06:18:31 INFO - 'MAIL': '/var/mail/cltbld', 06:18:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:31 INFO - 'MOZ_NO_REMOTE': '1', 06:18:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:31 INFO - 'NO_EM_RESTART': '1', 06:18:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:31 INFO - 'PWD': '/builds/slave/test', 06:18:31 INFO - 'SHELL': '/bin/bash', 06:18:31 INFO - 'SHLVL': '1', 06:18:31 INFO - 'TERM': 'linux', 06:18:31 INFO - 'TMOUT': '86400', 06:18:31 INFO - 'USER': 'cltbld', 06:18:31 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1469450989.154253-292069661', 06:18:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:31 INFO - '_': '/tools/buildbot/bin/python'} 06:18:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:31 INFO - Downloading/unpacking psutil>=3.1.1 06:18:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:18:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:18:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:18:33 INFO - Installing collected packages: psutil 06:18:33 INFO - Running setup.py install for psutil 06:18:33 INFO - building 'psutil._psutil_linux' extension 06:18:33 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 06:18:33 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:18:33 INFO - building 'psutil._psutil_posix' extension 06:18:33 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:18:33 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:18:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:18:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:18:34 INFO - Successfully installed psutil 06:18:34 INFO - Cleaning up... 06:18:34 INFO - Return code: 0 06:18:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:18:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe2573bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1511350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a01c0>, '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 0x15a10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a1550>, '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': '17051fcd5208b27b50bedfeb000001dd-1469450989.154253-292069661', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:18:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:18:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:18:34 INFO - Using env: {'DISPLAY': ':0', 06:18:34 INFO - 'HOME': '/home/cltbld', 06:18:34 INFO - 'LANG': 'en_US.UTF-8', 06:18:34 INFO - 'LANGUAGE': 'en_US:en', 06:18:34 INFO - 'LOGNAME': 'cltbld', 06:18:34 INFO - 'MAIL': '/var/mail/cltbld', 06:18:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:34 INFO - 'MOZ_NO_REMOTE': '1', 06:18:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:34 INFO - 'NO_EM_RESTART': '1', 06:18:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:34 INFO - 'PWD': '/builds/slave/test', 06:18:34 INFO - 'SHELL': '/bin/bash', 06:18:34 INFO - 'SHLVL': '1', 06:18:34 INFO - 'TERM': 'linux', 06:18:34 INFO - 'TMOUT': '86400', 06:18:34 INFO - 'USER': 'cltbld', 06:18:34 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1469450989.154253-292069661', 06:18:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:34 INFO - '_': '/tools/buildbot/bin/python'} 06:18:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:18:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:18:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:18:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:18:36 INFO - Installing collected packages: mozsystemmonitor 06:18:36 INFO - Running setup.py install for mozsystemmonitor 06:18:36 INFO - Successfully installed mozsystemmonitor 06:18:36 INFO - Cleaning up... 06:18:36 INFO - Return code: 0 06:18:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:18:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:36 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 0x7fbe2573bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1511350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a01c0>, '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 0x15a10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a1550>, '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': '17051fcd5208b27b50bedfeb000001dd-1469450989.154253-292069661', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:18:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:18:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:18:36 INFO - Using env: {'DISPLAY': ':0', 06:18:36 INFO - 'HOME': '/home/cltbld', 06:18:36 INFO - 'LANG': 'en_US.UTF-8', 06:18:36 INFO - 'LANGUAGE': 'en_US:en', 06:18:36 INFO - 'LOGNAME': 'cltbld', 06:18:36 INFO - 'MAIL': '/var/mail/cltbld', 06:18:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:36 INFO - 'MOZ_NO_REMOTE': '1', 06:18:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:36 INFO - 'NO_EM_RESTART': '1', 06:18:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:36 INFO - 'PWD': '/builds/slave/test', 06:18:36 INFO - 'SHELL': '/bin/bash', 06:18:36 INFO - 'SHLVL': '1', 06:18:36 INFO - 'TERM': 'linux', 06:18:36 INFO - 'TMOUT': '86400', 06:18:36 INFO - 'USER': 'cltbld', 06:18:36 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1469450989.154253-292069661', 06:18:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:36 INFO - '_': '/tools/buildbot/bin/python'} 06:18:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:36 INFO - Downloading/unpacking jsonschema==2.5.1 06:18:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:18:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:18: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 06:18: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 06:18: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 06:18: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 06:18: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 06:18: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 06:18:38 INFO - Downloading functools32-3.2.3-2.tar.gz 06:18:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:18:38 INFO - warning: no files found matching '*.txt' 06:18:38 INFO - no previously-included directories found matching 'build' 06:18:38 INFO - no previously-included directories found matching 'dist' 06:18:38 INFO - no previously-included directories found matching '.git*' 06:18:38 INFO - Installing collected packages: jsonschema, functools32 06:18:38 INFO - Running setup.py install for functools32 06:18:39 INFO - warning: no files found matching '*.txt' 06:18:39 INFO - no previously-included directories found matching 'build' 06:18:39 INFO - no previously-included directories found matching 'dist' 06:18:39 INFO - no previously-included directories found matching '.git*' 06:18:39 INFO - Successfully installed jsonschema functools32 06:18:39 INFO - Cleaning up... 06:18:39 INFO - Return code: 0 06:18:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:18:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:39 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 0x7fbe2573bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1511350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a01c0>, '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 0x15a10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a1550>, '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': '17051fcd5208b27b50bedfeb000001dd-1469450989.154253-292069661', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:18:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:18:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:18:39 INFO - Using env: {'DISPLAY': ':0', 06:18:39 INFO - 'HOME': '/home/cltbld', 06:18:39 INFO - 'LANG': 'en_US.UTF-8', 06:18:39 INFO - 'LANGUAGE': 'en_US:en', 06:18:39 INFO - 'LOGNAME': 'cltbld', 06:18:39 INFO - 'MAIL': '/var/mail/cltbld', 06:18:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:39 INFO - 'MOZ_NO_REMOTE': '1', 06:18:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:39 INFO - 'NO_EM_RESTART': '1', 06:18:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:39 INFO - 'PWD': '/builds/slave/test', 06:18:39 INFO - 'SHELL': '/bin/bash', 06:18:39 INFO - 'SHLVL': '1', 06:18:39 INFO - 'TERM': 'linux', 06:18:39 INFO - 'TMOUT': '86400', 06:18:39 INFO - 'USER': 'cltbld', 06:18:39 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1469450989.154253-292069661', 06:18:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:39 INFO - '_': '/tools/buildbot/bin/python'} 06:18:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:39 INFO - Downloading/unpacking blobuploader==1.2.4 06:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:41 INFO - Downloading blobuploader-1.2.4.tar.gz 06:18:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:18:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:18: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 06:18: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 06:18: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 06:18: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 06:18: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 06:18: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 06:18:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:18:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:18: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 06:18: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 06:18: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 06:18: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 06:18: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 06:18: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 06:18:41 INFO - Downloading docopt-0.6.1.tar.gz 06:18:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:18:42 INFO - Installing collected packages: blobuploader, requests, docopt 06:18:42 INFO - Running setup.py install for blobuploader 06:18:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:18:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:18:42 INFO - Running setup.py install for requests 06:18:42 INFO - Running setup.py install for docopt 06:18:42 INFO - Successfully installed blobuploader requests docopt 06:18:42 INFO - Cleaning up... 06:18:42 INFO - Return code: 0 06:18:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:18:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:42 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 0x7fbe2573bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1511350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a01c0>, '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 0x15a10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a1550>, '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': '17051fcd5208b27b50bedfeb000001dd-1469450989.154253-292069661', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:18:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:18:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:18:42 INFO - Using env: {'DISPLAY': ':0', 06:18:42 INFO - 'HOME': '/home/cltbld', 06:18:42 INFO - 'LANG': 'en_US.UTF-8', 06:18:42 INFO - 'LANGUAGE': 'en_US:en', 06:18:42 INFO - 'LOGNAME': 'cltbld', 06:18:42 INFO - 'MAIL': '/var/mail/cltbld', 06:18:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:42 INFO - 'MOZ_NO_REMOTE': '1', 06:18:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:42 INFO - 'NO_EM_RESTART': '1', 06:18:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:42 INFO - 'PWD': '/builds/slave/test', 06:18:42 INFO - 'SHELL': '/bin/bash', 06:18:42 INFO - 'SHLVL': '1', 06:18:42 INFO - 'TERM': 'linux', 06:18:42 INFO - 'TMOUT': '86400', 06:18:42 INFO - 'USER': 'cltbld', 06:18:42 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1469450989.154253-292069661', 06:18:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:42 INFO - '_': '/tools/buildbot/bin/python'} 06:18:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:18:42 INFO - Running setup.py (path:/tmp/pip-juJBoY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:18:42 INFO - Running setup.py (path:/tmp/pip-wPdpuQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:18:42 INFO - Running setup.py (path:/tmp/pip-FZmYQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:18:43 INFO - Running setup.py (path:/tmp/pip-qZpqBS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:18:43 INFO - Running setup.py (path:/tmp/pip-HaYGg_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:18:43 INFO - Running setup.py (path:/tmp/pip-bhKoKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:18:43 INFO - Running setup.py (path:/tmp/pip-gHlUyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:18:43 INFO - Running setup.py (path:/tmp/pip-5cyuoR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:18:43 INFO - Running setup.py (path:/tmp/pip-AZeM7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:18:43 INFO - Running setup.py (path:/tmp/pip-qdWWCX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:18:43 INFO - Running setup.py (path:/tmp/pip-FgwwS5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:18:43 INFO - Running setup.py (path:/tmp/pip-UfUsfb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:18:43 INFO - Running setup.py (path:/tmp/pip-4TvUGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:18:43 INFO - Running setup.py (path:/tmp/pip-j_7oeU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:18:43 INFO - Running setup.py (path:/tmp/pip-LYwOSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:18:43 INFO - Running setup.py (path:/tmp/pip-NXHnWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:18:44 INFO - Running setup.py (path:/tmp/pip-RFsxko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:18:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:18:44 INFO - Running setup.py install for manifestparser 06:18:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:18:44 INFO - Running setup.py install for mozcrash 06:18:44 INFO - Running setup.py install for mozdebug 06:18:44 INFO - Running setup.py install for mozdevice 06:18:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:18:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:18:44 INFO - Running setup.py install for mozfile 06:18:44 INFO - Running setup.py install for mozhttpd 06:18:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:18:44 INFO - Running setup.py install for mozinfo 06:18:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:18:44 INFO - Running setup.py install for mozInstall 06:18:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:18:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:18:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:18:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:18:44 INFO - Running setup.py install for mozleak 06:18:44 INFO - Running setup.py install for mozlog 06:18:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:18:45 INFO - Running setup.py install for moznetwork 06:18:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:18:45 INFO - Running setup.py install for mozprocess 06:18:45 INFO - Running setup.py install for mozprofile 06:18:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:18:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:18:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:18:45 INFO - Running setup.py install for mozrunner 06:18:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:18:45 INFO - Running setup.py install for mozscreenshot 06:18:45 INFO - Running setup.py install for moztest 06:18:45 INFO - Running setup.py install for mozversion 06:18:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:18:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:18:45 INFO - Cleaning up... 06:18:45 INFO - Return code: 0 06:18:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:18:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:45 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 0x7fbe2573bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1511350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a01c0>, '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 0x15a10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a1550>, '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': '17051fcd5208b27b50bedfeb000001dd-1469450989.154253-292069661', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:18:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:18:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:18:45 INFO - Using env: {'DISPLAY': ':0', 06:18:45 INFO - 'HOME': '/home/cltbld', 06:18:45 INFO - 'LANG': 'en_US.UTF-8', 06:18:45 INFO - 'LANGUAGE': 'en_US:en', 06:18:45 INFO - 'LOGNAME': 'cltbld', 06:18:45 INFO - 'MAIL': '/var/mail/cltbld', 06:18:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:45 INFO - 'MOZ_NO_REMOTE': '1', 06:18:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:45 INFO - 'NO_EM_RESTART': '1', 06:18:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:45 INFO - 'PWD': '/builds/slave/test', 06:18:45 INFO - 'SHELL': '/bin/bash', 06:18:45 INFO - 'SHLVL': '1', 06:18:45 INFO - 'TERM': 'linux', 06:18:45 INFO - 'TMOUT': '86400', 06:18:45 INFO - 'USER': 'cltbld', 06:18:45 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1469450989.154253-292069661', 06:18:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:45 INFO - '_': '/tools/buildbot/bin/python'} 06:18:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:18:46 INFO - Running setup.py (path:/tmp/pip-NUcUD_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:18:46 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:18:46 INFO - Running setup.py (path:/tmp/pip-AuhNtV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:18:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:18:46 INFO - Running setup.py (path:/tmp/pip-7ttbgh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:18:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:18:46 INFO - Running setup.py (path:/tmp/pip-bvCVj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:18:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:18:46 INFO - Running setup.py (path:/tmp/pip-5ITOVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:18:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:18:46 INFO - Running setup.py (path:/tmp/pip-6oQAn2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:18:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:18:46 INFO - Running setup.py (path:/tmp/pip-bs3NTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:18:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:18:46 INFO - Running setup.py (path:/tmp/pip-kG__Vy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:18:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:18:46 INFO - Running setup.py (path:/tmp/pip-PoVZPQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:18:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:18:46 INFO - Running setup.py (path:/tmp/pip-WZ7rar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:18:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:18:46 INFO - Running setup.py (path:/tmp/pip-S4yVAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:18:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:18:46 INFO - Running setup.py (path:/tmp/pip-iQBMLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:18:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:18:46 INFO - Running setup.py (path:/tmp/pip-Zkf8L2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:18:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:18:47 INFO - Running setup.py (path:/tmp/pip-XJ7ddo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:18:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:18:47 INFO - Running setup.py (path:/tmp/pip-Y8FsgL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:18:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:18:47 INFO - Running setup.py (path:/tmp/pip-CRiYvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:18:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:18:47 INFO - Running setup.py (path:/tmp/pip-5kFJ7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:18:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:18:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:18:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:18:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:18:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:18:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:18:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:18: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 06:18: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 06:18: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 06:18: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 06:18: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 06:18: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 06:18:49 INFO - Downloading blessings-1.6.tar.gz 06:18:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:18:49 INFO - Installing collected packages: blessings 06:18:49 INFO - Running setup.py install for blessings 06:18:49 INFO - Successfully installed blessings 06:18:49 INFO - Cleaning up... 06:18:49 INFO - Return code: 0 06:18:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:18:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:18:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:18:49 INFO - Reading from file tmpfile_stdout 06:18:49 INFO - Current package versions: 06:18:49 INFO - argparse == 1.2.1 06:18:49 INFO - blessings == 1.6 06:18:49 INFO - blobuploader == 1.2.4 06:18:49 INFO - docopt == 0.6.1 06:18:49 INFO - functools32 == 3.2.3-2 06:18:49 INFO - jsonschema == 2.5.1 06:18:49 INFO - manifestparser == 1.1 06:18:49 INFO - mozInstall == 1.12 06:18:49 INFO - mozcrash == 0.17 06:18:49 INFO - mozdebug == 0.1 06:18:49 INFO - mozdevice == 0.48 06:18:49 INFO - mozfile == 1.2 06:18:49 INFO - mozhttpd == 0.7 06:18:49 INFO - mozinfo == 0.9 06:18:49 INFO - mozleak == 0.1 06:18:49 INFO - mozlog == 3.2 06:18:49 INFO - moznetwork == 0.27 06:18:49 INFO - mozprocess == 0.23 06:18:49 INFO - mozprofile == 0.28 06:18:49 INFO - mozrunner == 6.12 06:18:49 INFO - mozscreenshot == 0.1 06:18:49 INFO - mozsystemmonitor == 0.3 06:18:49 INFO - moztest == 0.7 06:18:49 INFO - mozversion == 1.4 06:18:49 INFO - psutil == 3.1.1 06:18:49 INFO - requests == 1.2.3 06:18:49 INFO - wsgiref == 0.1.2 06:18:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:18: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')]} 06:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18: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')]} 06:18:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:49 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 0x7fbe2573bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1511350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a01c0>, '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 0x15a10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a1550>, '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': '17051fcd5208b27b50bedfeb000001dd-1469450989.154253-292069661', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:18:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:18:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:18:49 INFO - Using env: {'DISPLAY': ':0', 06:18:49 INFO - 'HOME': '/home/cltbld', 06:18:49 INFO - 'LANG': 'en_US.UTF-8', 06:18:49 INFO - 'LANGUAGE': 'en_US:en', 06:18:49 INFO - 'LOGNAME': 'cltbld', 06:18:49 INFO - 'MAIL': '/var/mail/cltbld', 06:18:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:49 INFO - 'MOZ_NO_REMOTE': '1', 06:18:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:49 INFO - 'NO_EM_RESTART': '1', 06:18:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:49 INFO - 'PWD': '/builds/slave/test', 06:18:49 INFO - 'SHELL': '/bin/bash', 06:18:49 INFO - 'SHLVL': '1', 06:18:49 INFO - 'TERM': 'linux', 06:18:49 INFO - 'TMOUT': '86400', 06:18:49 INFO - 'USER': 'cltbld', 06:18:49 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1469450989.154253-292069661', 06:18:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:49 INFO - '_': '/tools/buildbot/bin/python'} 06:18:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:18:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:18:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:18:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:18:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:18:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:18:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:18:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:18:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:18:49 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:18:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:18:49 INFO - Cleaning up... 06:18:49 INFO - Return code: 0 06:18:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:18: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')]} 06:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18: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')]} 06:18:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:49 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 0x7fbe2573bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1511350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a01c0>, '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 0x15a10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a1550>, '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': '17051fcd5208b27b50bedfeb000001dd-1469450989.154253-292069661', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:18:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:18:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:18:49 INFO - Using env: {'DISPLAY': ':0', 06:18:49 INFO - 'HOME': '/home/cltbld', 06:18:49 INFO - 'LANG': 'en_US.UTF-8', 06:18:49 INFO - 'LANGUAGE': 'en_US:en', 06:18:49 INFO - 'LOGNAME': 'cltbld', 06:18:49 INFO - 'MAIL': '/var/mail/cltbld', 06:18:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:49 INFO - 'MOZ_NO_REMOTE': '1', 06:18:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:49 INFO - 'NO_EM_RESTART': '1', 06:18:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:49 INFO - 'PWD': '/builds/slave/test', 06:18:49 INFO - 'SHELL': '/bin/bash', 06:18:49 INFO - 'SHLVL': '1', 06:18:49 INFO - 'TERM': 'linux', 06:18:49 INFO - 'TMOUT': '86400', 06:18:49 INFO - 'USER': 'cltbld', 06:18:49 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1469450989.154253-292069661', 06:18:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:49 INFO - '_': '/tools/buildbot/bin/python'} 06:18:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:18:50 INFO - Cleaning up... 06:18:50 INFO - Return code: 0 06:18:50 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:50 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 0x7fbe2573bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1511350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a01c0>, '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 0x15a10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a1550>, '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': '17051fcd5208b27b50bedfeb000001dd-1469450989.154253-292069661', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:18:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 06:18:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 06:18:50 INFO - Using env: {'DISPLAY': ':0', 06:18:50 INFO - 'HOME': '/home/cltbld', 06:18:50 INFO - 'LANG': 'en_US.UTF-8', 06:18:50 INFO - 'LANGUAGE': 'en_US:en', 06:18:50 INFO - 'LOGNAME': 'cltbld', 06:18:50 INFO - 'MAIL': '/var/mail/cltbld', 06:18:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:50 INFO - 'MOZ_NO_REMOTE': '1', 06:18:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:50 INFO - 'NO_EM_RESTART': '1', 06:18:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:50 INFO - 'PWD': '/builds/slave/test', 06:18:50 INFO - 'SHELL': '/bin/bash', 06:18:50 INFO - 'SHLVL': '1', 06:18:50 INFO - 'TERM': 'linux', 06:18:50 INFO - 'TMOUT': '86400', 06:18:50 INFO - 'USER': 'cltbld', 06:18:50 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1469450989.154253-292069661', 06:18:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:50 INFO - '_': '/tools/buildbot/bin/python'} 06:18:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:50 INFO - Downloading/unpacking flake8 06:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:18:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:18:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:52 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:18:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:18:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:18:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:18:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:18:53 INFO - no previously-included directories found matching 'docs/_build' 06:18:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:18:53 INFO - Running setup.py install for pep8 06:18:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:18:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:18:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:18:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:18:53 INFO - no previously-included directories found matching 'docs/_build' 06:18:53 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:18:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:18:53 INFO - Cleaning up... 06:18:53 INFO - Return code: 0 06:18:53 INFO - Running post-action listener: _resource_record_post_action 06:18:53 INFO - Running post-action listener: _start_resource_monitoring 06:18:53 INFO - Starting resource monitoring. 06:18:53 INFO - ##### 06:18:53 INFO - ##### Finished create-virtualenv step (success) 06:18:53 INFO - ##### 06:18:53 INFO - ##### 06:18:53 INFO - ##### Running install step. 06:18:53 INFO - ##### 06:18:53 INFO - Running pre-action listener: _resource_record_pre_action 06:18:53 INFO - Running main action method: install 06:18:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:18:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:18:53 INFO - Reading from file tmpfile_stdout 06:18:53 INFO - Detecting whether we're running mozinstall >=1.0... 06:18:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:18:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:18:53 INFO - Reading from file tmpfile_stdout 06:18:53 INFO - Output received: 06:18:53 INFO - Usage: mozinstall [options] installer 06:18:53 INFO - Options: 06:18:53 INFO - -h, --help show this help message and exit 06:18:53 INFO - -d DEST, --destination=DEST 06:18:53 INFO - Directory to install application into. [default: 06:18:53 INFO - "/builds/slave/test"] 06:18:53 INFO - --app=APP Application being installed. [default: firefox] 06:18:53 INFO - mkdir: /builds/slave/test/build/application 06:18:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:18:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:19:09 INFO - Reading from file tmpfile_stdout 06:19:09 INFO - Output received: 06:19:09 INFO - /builds/slave/test/build/application/firefox/firefox 06:19:09 INFO - Running post-action listener: _resource_record_post_action 06:19:09 INFO - ##### 06:19:09 INFO - ##### Finished install step (success) 06:19:09 INFO - ##### 06:19:09 INFO - ##### 06:19:09 INFO - ##### Running run-tests step. 06:19:09 INFO - ##### 06:19:09 INFO - Running pre-action listener: _resource_record_pre_action 06:19:09 INFO - Running main action method: run_tests 06:19:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:19:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:19:09 INFO - Python 2.7.3 06:19:09 INFO - Return code: 0 06:19:09 INFO - grabbing minidump binary from tooltool 06:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:19:09 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 0x15a01c0>, '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 0x15a10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a1550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:19:09 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:19:09 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 06:19:09 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 06:19:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:19:09 INFO - Return code: 0 06:19:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:19:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:19:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:19:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:19:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:19:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:19:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:19:10 INFO - Return code: 0 06:19:10 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/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 06:19:10 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/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 06:19:10 INFO - Using env: {'DISPLAY': ':0', 06:19:10 INFO - 'HOME': '/home/cltbld', 06:19:10 INFO - 'LANG': 'en_US.UTF-8', 06:19:10 INFO - 'LANGUAGE': 'en_US:en', 06:19:10 INFO - 'LOGNAME': 'cltbld', 06:19:10 INFO - 'MAIL': '/var/mail/cltbld', 06:19:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:19:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:19:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:10 INFO - 'MOZ_NO_REMOTE': '1', 06:19:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:19:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:19:10 INFO - 'NO_EM_RESTART': '1', 06:19:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:19:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:10 INFO - 'PWD': '/builds/slave/test', 06:19:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:19:10 INFO - 'SHELL': '/bin/bash', 06:19:10 INFO - 'SHLVL': '1', 06:19:10 INFO - 'TERM': 'linux', 06:19:10 INFO - 'TMOUT': '86400', 06:19:10 INFO - 'USER': 'cltbld', 06:19:10 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1469450989.154253-292069661', 06:19:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:10 INFO - '_': '/tools/buildbot/bin/python'} 06:19:10 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/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 06:19:10 INFO - mozversion application_buildid: 20160725020629 06:19:10 INFO - mozversion application_changeset: 517663b29d7ffc2ce91f90dc7beaac4fa35e52e5 06:19:10 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:19:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:19:10 INFO - mozversion application_name: Firefox 06:19:10 INFO - mozversion application_remotingname: firefox-dev 06:19:10 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:19:10 INFO - mozversion application_vendor: Mozilla 06:19:10 INFO - mozversion application_version: 49.0a2 06:19:10 INFO - mozversion platform_buildid: 20160725020629 06:19:10 INFO - mozversion platform_changeset: 517663b29d7ffc2ce91f90dc7beaac4fa35e52e5 06:19:10 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:19:10 INFO - mozversion platform_version: 49.0a2 06:19:10 INFO - using testdate: 1469452750 06:19:10 INFO - actual date: 1469452750 06:19:10 INFO - starting webserver on 'localhost:48193' 06:19:10 INFO - SUITE-START | Running 2 tests 06:19:10 INFO - TEST-START | dromaeo_css 06:19:10 INFO - operating with platform_type : linux_ 06:19:10 INFO - Initialising browser for dromaeo_css test... 06:19:10 INFO - TEST-INFO | started process 30713 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp18s74H/profile http://localhost:48193/getInfo.html) 06:19:15 INFO - PROCESS | 30713 | __metrics Screen width/height:1600/1200 06:19:15 INFO - PROCESS | 30713 | colorDepth:24 06:19:15 INFO - PROCESS | 30713 | Browser inner width/height: 1024/697 06:19:15 INFO - PROCESS | 30713 | __metrics 06:19:16 ERROR - PROCESS | 30713 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 06:19:17 INFO - TEST-INFO | 30713: exit 0 06:19:17 INFO - Browser initialized. 06:19:17 INFO - Running cycle 1/1 for dromaeo_css test... 06:19:17 INFO - TEST-INFO | started process 30842 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp18s74H/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:19:28 INFO - PROCESS | 30842 | RSS: Main: 155750400 06:19:28 INFO - PROCESS | 30842 | 06:20:18 INFO - PROCESS | 30842 | 1469452818362 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 06:22:26 INFO - PROCESS | 30842 | Cycle 1(1): loaded http://localhost:48193/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48193/tests/dromaeo/cssquery-ext.html) 06:22:27 INFO - PROCESS | 30842 | RSS: Main: 159215616 06:22:27 INFO - PROCESS | 30842 | 06:25:29 INFO - PROCESS | 30842 | Cycle 1(1): loaded http://localhost:48193/tests/dromaeo/cssquery-ext.html (next: http://localhost:48193/tests/dromaeo/cssquery-jquery.html) 06:25:30 INFO - PROCESS | 30842 | RSS: Main: 157540352 06:25:30 INFO - PROCESS | 30842 | 06:28:32 INFO - PROCESS | 30842 | Cycle 1(1): loaded http://localhost:48193/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48193/tests/dromaeo/cssquery-mootools.html) 06:28:32 INFO - PROCESS | 30842 | RSS: Main: 157450240 06:28:32 INFO - PROCESS | 30842 | 06:31:34 INFO - PROCESS | 30842 | Cycle 1(1): loaded http://localhost:48193/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48193/tests/dromaeo/cssquery-prototype.html) 06:31:35 INFO - PROCESS | 30842 | RSS: Main: 156364800 06:31:35 INFO - PROCESS | 30842 | 06:34:37 INFO - PROCESS | 30842 | Cycle 1(1): loaded http://localhost:48193/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48193/tests/dromaeo/cssquery-yui.html) 06:34:38 INFO - PROCESS | 30842 | RSS: Main: 159002624 06:34:38 INFO - PROCESS | 30842 | 06:37:40 INFO - PROCESS | 30842 | Cycle 1(1): loaded http://localhost:48193/tests/dromaeo/cssquery-yui.html (next: http://localhost:48193/tests/dromaeo/cssquery-dojo.html) 06:37:40 INFO - PROCESS | 30842 | RSS: Main: 158879744 06:37:40 INFO - PROCESS | 30842 | 06:37:40 INFO - PROCESS | 30842 | __start_tp_report 06:37:40 INFO - PROCESS | 30842 | _x_x_mozilla_page_load 06:37:40 INFO - PROCESS | 30842 | _x_x_mozilla_page_load_details 06:37:40 INFO - PROCESS | 30842 | |i|pagename|runs| 06:37:40 INFO - PROCESS | 30842 | |0;dojo.html;3361.8655253789843;3398.1674489750008;3402.625711171769;3410.6930376266146;3436.0722604896678;5667.801626943058;5679.4604512571295;5692.857678558033;5754.223179870716;5777.740001699923;5694.715264236792;5742.196092547037;5781.971090144543;5783.942160578393;5798.971005144968;5159.38087429509;5231.346081739783;5275.525202731754;5289.18017707256;5314.92027619586;5159.071367153911;5180.948190518085;5317.973410132963;5329.680219186842;5330.573554115681;5228.973855130738;5259.053370393328;5268.104422248227;5286.04851126797;5287.259783630295;5220.765065572058;5226.477352264781;5272.815451459219;5296.205569164617;5311.389190243133;5163.664361816507;5217.817376391846;5291;5295.947040529622;5305.965336759334;5426;5515.972420137914;5524.696141712204;5610.438956104398;5641.464060914206;6105.297890742577;6107.450329470369;6113.205283313141;6119.938800612026;6126.877462450726;5902.8819423611285;6174.814755557296;6190.876182476325;6192.256929168529;6192.28788689302;5564.081926482126;5606;5624.184493248456;5654.74553645087;5678.886422271531;6144.539159563051;6172;6184.103305020837;6204.193454850931;6213.409726076015;5822.650640961556;5947.197128387612;5953.136795164677;5956.731947062306;5966.075258334965;6068.696565171724;6159.969200153971;6195.1636529068;6211.006239001738;6213.65824879636;6108.969455152695;6113.480354169946;6115.724792384264;6146.262448506119;6187.907181392283;5866.8533286667325;5965.970170149121;6004.819855404345;6137.324894261627;6159.076138579249;4646.930296045562;4657.301404789241;4658.883527911829;4663.370444989883;4708.105459962596;4161.729487583298;4178.874633760992;4180.372944058416;4183.91632167355;4206.390073439334;5797.130430435384;5828.795992140254;5863.882722345615;5883.970580147072;5901.881962360729;5968.22413086296;5971.522278217819;5998.550108741862;5999.940000600025;6091.451769340781;5783.334916484658;5805.82582522525;5814.59297849155;5831.271091113611;5876.471117599351;5029.5221953914315;5138.665986710852;5143.434222235551;5166.070107380708;5191.402988656353;6410.67946602668;6499.09012738217;6536.215654121535;6545.247296560861;6553.049807777846;6221.160143380766;6230.875382492415;6232.220972378453;6251.093591429309;6266.091416744455;6194.349593292639;6222.28443728977;6238.656873871981;6477.708503117466;6487.708053137714;5912.113183022409;5915.615484993462;5926.288845338587;5952.464278214981;5963.254593175853;6016.939830601638;6030.396960303934;6040.335563088145;6043.12374705674;6063.514918806397;5845.853853653693;5892.587518873637;5934.465898069195;6010.639361638316;6025.66858822769;5958.7616495341435;5985.581009329305;6003.3996600339615;6003.489703375088;6028;5895.41045895407;5896.823095307148;5913.438223368773;5928.288605367384;5938.61399009063;5790.652516152669;5844.620099693507;5903;5984.1323008164445;6009.128676341993;5869.413058694096;5869.559783016205;5891.05743081105;5894.911576326273;5906.468417842415 06:37:40 INFO - PROCESS | 30842 | |1;ext.html;597.2802772658944;643.1381948189426;646.6088016749864;663.5719960625397;684.3567046975845;42198.78900605496;45404.77297613507;45531.77234113825;45549.316760248585;45578.316325255146;45334.77332613341;46084.53915460844;46225.30662040064;46309.30536041962;46593;8801.911980880206;9016;9082.45505269686;9087;9097.272218222559;8834.779130521756;8992.640294388217;8997;8997.595108220114;9005.234555062794;9025.774355641128;9093.681721139761;9094.454332740057;9094.909050909506;9118.133777291147;9031.95484022579;9046.457212567235;9058.411203271766;9063.229625481808;9088.50013249271;8863.11368863115;8895.911040889638;8906.332025098143;8966.596503157374;8967.551622418852;42272.365914511305;42524.36213456801;42558.78720606408;42561.148777024595;42666.78666606678;3656.213914008501;3750.8124593770203;3917.627825356615;4180.586235139355;4518.909621807578;33879.153021174425;34666.653333466595;34771.82614086939;34915.301693966234;35156.824215879016;4677.4854765975715;4693.694909830884;4711.10489007091;4797.592204662573;4847.709137451729;376113.4777304466;377654;379604;379995;382914.08542957384;38103.23793524114;58253.70873145607;58361;58643.41356586465;58897;39247.41128883069;40726.592734072874;40779;40918.1816363671;40978;17318.740218896728;17384.826151738573;17552.473425797245;17569.20938557768;17593.648127037643;14732.189729564976;14848;14851;14893.106413615218;14912.179830109231;8976.955115224513;9063.954680226556;9119.179273865251;9139.725808225763;9156.8626470603;3447.620761716209;3457.0665920201404;3471.548698669207;3515.33208690348;3535.116220944764;1080.5947769586405;1134.625573560723;1185.7213554814612;1201.1471854982885;1287.67808047988;33525.161870952936;34040.48939265913;34380.14049648779;34720.47919281213;34825;1184.5463782122802;1208.3052244959008;1262.501311981762;1270.4092596942282;1284.8329717136712;18127.456176314732;18139.72790408145;18193;18199;18244.543886402946;568467;677856;679386;687597;1114354;65008.67495662491;65641.34358656353;65797;65915.34084659188;65954;1426.3153686230667;1445.6313640021726;1456.1336005076962;1489.91060536366;1491.0680824484698;33537.83231083829;34383.828080859435;34642.65357346394;34766;34917.47623785696;56603;60651.69674151778;62631;62994.685026574574;69040;568353;572501;573151;574791;577005;47594.28608570805;48158.5184148154;48365.7908552275;48463.5153648459;48855.65734092597;52503;52777.20834187413;53515.464845351045;53749.731251343495;54180.458195419116;43420.56579434292;44031.55968440403;44313;44333.556664432945;45993.77003114963;43753.56246437622;44821.32768008417;44988;45188.322175168054;45441.77279113583;44014.55985440104;45130.323045155004;45164.54835451603;45469.31796023128;45571.54428455673;37665.43501847529;38856.222875542895;39203.607963919996;39804.2039159221;39895.40156897707;30024.399512010074;30368.240793980327;30566.694333057276;30657.386852263277;30999 06:37:40 INFO - PROCESS | 30842 | |2;jquery.html;382.85834241330696;391.99412008819854;419.2265270575788;423.4093439651685;430.838435586655;17489.562760930952;18368.632627347444;20171.697424538626;20253.797462025374;20466.795332046677;17252.39616613419;17339.826601733977;17342.479725608253;18271.817281827178;19482.220711171536;5677.403872593381;5719.714014299289;5863.8534036649;5906.704664766766;5926.97036514819;5397.568194544447;5722.427757224286;5845.503132233765;5851.8537036574;5874.1776151338845;5689.743961521721;5716.056850619663;5717.142428635717;5726.083826587746;5763.682997435139;5532.3637781655225;5905.173275741378;5919.881602367928;6001.66990815505;6009.939900600982;5641.717914104278;5726;5777.24895763548;5779.133130030487;5791.333996590404;13408.061435699505;13673.726525469436;20427.285045023502;23036.193733219425;23154.536909261722;2363.1728894886824;2423.7697418745365;2439.7438268981855;2502.87485625718;2508.5359208546297;10455.268131230818;10498.842517362245;10662.20033497483;10746.247762656618;10757.677269681923;2009.819116279542;2091.435312465626;2120.4274845791706;2144.8820314882673;2179.1936983316273;67060.66469667669;70430;72437.2756272441;77420;83705.99999999939;10533.157347412189;10945.83581246282;11020.669379918616;11121.833172502418;11307.643082830113;12978.545750898673;13601.659958501117;13786.103903246258;15668.138252396;15798.60503487399;8048.557329346825;8073.959630201812;8372.162783721578;8392.916070839336;8463.407561470762;8382.916170838336;8501.44740591872;8547.059823419419;8654.48073115615;8722;4294.463192100988;4316.287812510964;4321.9135617287475;4422.7346359218545;4441.378207051015;2022.2416593777334;2070.285751415759;2102.7815654484666;2133.775953524889;2175.9238426654993;962.8074385123003;1036.3367444835312;1042.1870940666292;1052.563186277686;1081.8377243413552;18347.449576512725;18974.43076707701;19066.237350505824;19434.8056519433;19672.606547869247;1058.433737950193;1080.065743132185;1087.6030248959073;1093.2128867215592;1102.4763237462141;10493.737656558495;10650.520726567323;10681.198910081775;10734.463276836126;10760.677179684622;530579;546573;556701;558126;563142;84214;86739.56630216808;88228;90789.54605226932;102948;1044.1177205261542;1076.1014552848303;1078.250615822012;1084.116445097259;1090.334895713614;17395.13024348752;17462.388816391365;17555.385561505285;17701.911490442464;17904.194311255764;34103.4884476738;40996.1800763989;42578.78710606427;42646.78676606597;43055.13889722125;56827.14759278532;57636;58173.709131454074;59068.704656476446;59377;8313.334933205208;8564.957175214084;8573.914260857311;8591.097934716765;8667;9564.810575142885;12422.06834487399;12471.750564988832;12569.245845249314;12671.429785659851;10973.725656858642;11123.110151187724;11296.378699171624;11313.71715707114;11317.377544235145;11074.446277686244;11145.777084458103;11207.43962801873;11278.548858045915;11409.942950285196;11184.440777961232;11261.324320540794;11281.943590281997;11308.49111789955;11778;8546.145385461405;8591.6992905248;8650.394472386872;8754.168354006359;8815.250703690259;11088.611898583511;11436.142289328167;11509.194356394972;11522.76954460923;11750.58872939443 06:37:40 INFO - PROCESS | 30842 | |3;mootools.html;1584.2870708181322;1585.056891149766;1787.2314904591028;1879.6334714730633;1901.4010586665208;7592.924070759291;8662.566871656416;8946.329025323093;9315.068493150682;9354.672586459475;9055.547222638874;9079.273658107351;9110.180083792475;9123.589438475268;9134.086591340863;2382.725986511556;2400.435897564071;2422.019082271674;2422.406510404953;2426.0780903256737;2368.4670949036417;2408.963865542018;2418.8548687078833;2421;2426.8665223412704;2346.3312955807596;2370.1704403458825;2380.2264264114146;2390.8326417150806;2395.940101497459;2280.5096904165603;2293.2203050962753;2302.1597117052324;2305.054927479742;2324.174917904145;2345.683332750074;2363.0429675981254;2363.7163540375095;2369.336585755974;2384.034466041256;9092.136247056518;9093.40892841963;9136.04071572482;9140.588673509708;9211.585478653476;5282.683039017671;5441.156620723794;5444.646098003617;5477.698726570037;5496.670199787985;3570.7143428525656;3574.2136729919375;3632.110133017428;3632.7820330780237;3646.8723594674325;1259.9857115022403;1268.7779638563215;1297.9935100324533;1300.1094250438384;1301.2322729589494;13231.669208269774;13270.66823329415;13279.46882124714;13292.069555131146;13316.334183290797;4545.36364908913;4721.362616046858;4731.33761273422;4736.100140973204;4779.139754844162;10844.078253348396;10894.945525272324;10976.286541374786;11001.669949901516;11011.119110471143;5309.601779866525;5360.571154307724;5378.731063446812;5384.273123128406;5407.540359069444;4312.094460163338;4856.8300109495995;4894.461609222983;5043.193089105725;5061.746912654353;4092.120194158211;4145.585441455831;4151.730137541111;4173.332266837291;4175.791210439465;1324.0945383589299;1347.1782212850153;1354.9932250338686;1358.7282543491342;1360.5102163221231;855.9272461840688;946.5882341181608;999.2655398282257;1075.7794652096302;1092.1099304067159;6433.935660643428;6493.350664933563;6540.411362977355;6575.638339891352;6608.173978252718;507.26446652354235;508.53977150678696;509.85978855814204;1025.5743866295404;1103.2883789955595;4424.579664931826;4481.551844815493;4500.279955207151;4510.616597589242;4514.413126293626;11386.146039046938;11590.826137607943;11667.59163429276;11679.591214307628;11730.88269117315;10884.945575272073;11409.942950285196;11415.543378264943;11556.76886462266;11744.354060526754;8544.658213671508;8674.436161649473;8681.522516261666;8701.608427620773;8705.782355441039;6224.957784194817;6436.549441539048;6463.515236357198;6486.254080780771;6615.702293396713;10104.797904042025;10203;10213.693589192337;10299.3820370778;10354.378737275787;10573;10784.784304314027;10890.782184356427;10936.56253749841;11003.889961100607;7365.52124111931;8165.550894700611;8194.09864914847;8206.753797386087;8350.624221909908;9200.585973631336;9214.539273036187;9244.260459163384;9248.398854074463;9254.722358329262;8100.473469224482;8300.169983001651;8344.16558344185;8453.070162282022;8473.237408633253;7996.92003079985;8049.718259860877;8098.959505202436;8114.472559283628;8237.341012719087;7407.629618518945;7410.073740782403;7447.106347238366;7472.626368681653;7516.549007059594;5578.163275508706;5583.944160558505;5600.215969764317;5625.915611265752;5698.515626171822;5466.753996070107;5588.329400471969;5653.067243904874;5692.6299790513485;5826.796062137805 06:37:40 INFO - PROCESS | 30842 | |4;prototype.html;337.53757352427164;342.2197389950913;348.47206482179485;356.90006798096533;359.3441968407656;5519.199716041172;5571.9721401393035;5673.546116310696;5718.542516598673;5722.22749928759;5571.220029195916;5579.214651311582;5580.441955804417;5607.467290607386;5619.634723742954;4417.624501917341;4455.621272191867;4462.754548499831;4466.932996005063;4485;4345.239583072949;4410.952771767521;4433.955660443403;4459.509453960078;4483.125790470859;4356.279269688471;4378.219830407698;4382.605565499104;4384.758838263894;4427.512973572904;4405.88985275369;4417.734935903856;4435.534268901751;4449.911001779947;4475.30632751924;3770.9818349045877;3880.941785873214;3891.4746509221177;3892.863749768773;3898.7075969302414;5413.53984911283;5414.485623865766;5440.510354068113;5453.509184173444;5471.616986810925;5007.349044624212;5041.621878359138;5057.216131499624;5058.190689489701;5106.361704786902;5588.636738611977;5869.178315035856;5876.471117599393;5895.056790913433;5905.084711869667;4280.315149576053;4286.39990401344;4287.356896465524;4290.528041915387;4314.684021373511;5965.463108320272;6038.909416358802;6080.635161890256;6112.327643959161;6132.478739307119;4344.327433937957;4346.152500262482;4362.429525370864;4363.865394997323;4364.912701745948;4340.479142502857;4436.955630443719;4437.7781110944325;4444.333349997526;4447.577480139382;4817.9518204817505;4982.302477653131;4982.5052484254575;4997.150484417658;5058.140116180258;5671.858203544862;5805.390434004453;5857.882842343214;5863.765449382062;5869.794557190563;1541.48360299301;1556.8479325299197;1557.1746974103517;1558.688262347535;1558.7895634089252;966.9371490853072;984.7341217871135;1002.4286156890503;1002.5789168549227;1007.2294694558668;5000.824971125993;5064.176896317396;5109.795608175706;5134.203028939841;5134.409542902614;5349.662584353911;5410.8917821643345;5439.292891924025;5445.700486473203;5467.223152475462;5008.6744361616375;5165.302684137669;5190.844274671766;5207.3490813648295;5242.895142097137;2874.6837847836723;2890.349671323935;2893.450244453547;2921.649402071765;2924.064299424164;5612.1581762735095;5617.634853734494;5651.463111004448;5654.264945557134;5682.261306030189;5166.741662916915;5441.700706461183;5459.3994660587305;5481.177193745224;5544.1960915667805;5529.751161197756;5656.971715141481;5658.490735833795;5664.518515926193;5670.468973377165;5194.7922083116255;5322.93541291751;5339.143558196346;5430.294061771944;5455.618106732491;5312.256284120149;5326.920096198638;5331.70675612845;5333.466653334635;5335.306410166653;5535.3357597087;5612.635178713371;5626.437356264504;5649.915251271316;5670.546356291569;3861.9806900965314;3931.4495970564717;4024.919501609893;4058.76767777727;4069.9593004070766;5255.159174532057;5430.51125398716;5454.509094181542;5998.790042348497;6160.383961603804;5958.791442299499;5987.700614969322;6004.909926351021;6015.518758499397;6016.759329626766;5873.676947767743;5883.146943693055;5902.321233058254;5912.379200184091;5918.467337939606;5660.32076150848;5830.47525722687;5857.736401861841;5888.646681199141;5893.145493903446;5936.821895343147;5946.286445626552;5987.5808693391045;6002.579819412599;6018.969905150446;5618.831435056954;5847.707614619337;5873.676947767914;5880.676562789087;5882.588218824641 06:37:40 INFO - PROCESS | 30842 | |5;yui.html;832.6752566499063;840.6091167607066;875.7460336502414;904.1275169461468;909.7134402663161;15894.284757185926;17155.914220428913;17181.22684479198;17193.226304816297;17213.913930430346;14465.132092074484;14501.202433866134;14509.129452232874;14551.054181478223;14669;849.736581659686;871.2942516561606;875.8248350329927;878.7539488943106;880.3749337970017;857.939944203906;858.5750053723416;860.5568132411813;860.9870851937226;870.1472556894247;918.6417297254076;918.9310801689867;919.9264058875308;920.1718453391934;920.3603495570582;906.1255888068013;912.16536868765;913.137085454246;914.4696076275744;916.1662886773038;668.2982867988641;669.3674477618653;670;670;670.51722759613;15153.469628563058;15302.693946121126;15303.923480382527;15314.770278445832;15388.846111538853;14371.137731736024;14438.278086095654;14514.782278265835;14814.259287035713;15170;13817.654558636115;14024.228667423287;14278.928605356907;14297.71404571913;14392.496262630862;4151.6886233532605;4164.729292595972;4168.395582640531;4225.704200705952;4240.279152544044;56521.43478565244;72771.63614181949;72785.6360718193;76751;80461.59769201117;12454.501819927282;12643.557475488315;12985.350732463528;13010.349482525837;13184.274864882524;21234.681479777817;21372.35882923515;21440.035198415797;21447.356579302646;21463.570728585342;9232.630694772268;9283.210927071139;9316.021817709043;9381.249500039981;9397.671081512115;5020.171671674206;5073.594112470993;5137.409197942285;5176.559992400688;5216.895662086737;3837.884863454101;3895.824687889052;3958.7426817256787;3958.8812335629977;3962.128331767007;679.1307126877605;680.1056610557101;692.425287011779;697.1564407067403;701.5930760159096;659.515256286629;713.1976526407791;726.4950859152838;731.8902164675235;734.2290594875466;10712.946435267773;10720.46397680113;10851.945740271249;10924;11059.22585419029;676.2898956096079;703.7501686901179;735.6174789109633;796.0685997383076;821.496661110167;5132.79468821243;5145.253938179018;5200.6619569727845;5233.241180028875;5280.419153893069;67383;92583.53708231551;110016;117536.41231793787;121502;62122.37877621166;84803.57598212094;93014.06985930189;94374;94581;85790.57104714436;86499;87459.12540874637;88362.55818720865;88627.55686221656;10333.534990925576;10559.419231942316;10933.945330273298;11040.447977601249;11091.33451992883;43695.56304436915;45146;46114.769426152656;46918.53081469142;51484.485155147966;50107;50293;55267.44732552623;74144.25855741589;77115.61442192753;13612.455501779817;13844.169349839041;13891.235982021086;13969.161850289016;14022.649433764238;15972.011103856872;16062.919685401499;16288.592785180464;16324.347026118823;16362.672746544764;14480.710385792014;14614.34235459428;14714.48499302562;14730.189839558927;15487.690246194788;14678.633034173803;14739.705205895607;15093.396264149751;15265.313060912064;15687.372505099669;14454.783178252545;14684.192369419785;14772.33524491379;15363.923180384027;15633.843661563238;10781.784364312512;10804.459777010961;11024.228304018641;11574.942125289319;11580.36308003068;11549.769004619693;12065.215760975509;12156.270623762603;12471;12544.184627999151 06:37:40 INFO - PROCESS | 30842 | __end_tp_report 06:37:40 INFO - PROCESS | 30842 | __start_cc_report 06:37:40 INFO - PROCESS | 30842 | _x_x_mozilla_cycle_collect,338 06:37:40 INFO - PROCESS | 30842 | __end_cc_report 06:37:40 INFO - PROCESS | 30842 | __startTimestamp1469453860691__endTimestamp 06:37:40 INFO - PROCESS | 30842 | 06:37:40 INFO - PROCESS | 30842 | ------- Summary: start ------- 06:37:40 INFO - PROCESS | 30842 | Number of tests: 6 06:37:40 INFO - PROCESS | 30842 | 06:37:40 INFO - PROCESS | 30842 | [#0] dojo.html Cycles:165 Average:5678.67 Median:5892.59 stddev:632.50 (10.7%) stddev-sans-first:607.76 06:37:40 INFO - PROCESS | 30842 | Values: 3361.9 3398.2 3402.6 3410.7 3436.1 5667.8 5679.5 5692.9 5754.2 5777.7 5694.7 5742.2 5782.0 5783.9 5799.0 5159.4 5231.3 5275.5 5289.2 5314.9 5159.1 5180.9 5318.0 5329.7 5330.6 5229.0 5259.1 5268.1 5286.0 5287.3 5220.8 5226.5 5272.8 5296.2 5311.4 5163.7 5217.8 5291.0 5295.9 5306.0 5426.0 5516.0 5524.7 5610.4 5641.5 6105.3 6107.5 6113.2 6119.9 6126.9 5902.9 6174.8 6190.9 6192.3 6192.3 5564.1 5606.0 5624.2 5654.7 5678.9 6144.5 6172.0 6184.1 6204.2 6213.4 5822.7 5947.2 5953.1 5956.7 5966.1 6068.7 6160.0 6195.2 6211.0 6213.7 6109.0 6113.5 6115.7 6146.3 6187.9 5866.9 5966.0 6004.8 6137.3 6159.1 4646.9 4657.3 4658.9 4663.4 4708.1 4161.7 4178.9 4180.4 4183.9 4206.4 5797.1 5828.8 5863.9 5884.0 5901.9 5968.2 5971.5 5998.6 5999.9 6091.5 5783.3 5805.8 5814.6 5831.3 5876.5 5029.5 5138.7 5143.4 5166.1 5191.4 6410.7 6499.1 6536.2 6545.2 6553.0 6221.2 6230.9 6232.2 6251.1 6266.1 6194.3 6222.3 6238.7 6477.7 6487.7 5912.1 5915.6 5926.3 5952.5 5963.3 6016.9 6030.4 6040.3 6043.1 6063.5 5845.9 5892.6 5934.5 6010.6 6025.7 5958.8 5985.6 6003.4 6003.5 6028.0 5895.4 5896.8 5913.4 5928.3 5938.6 5790.7 5844.6 5903.0 5984.1 6009.1 5869.4 5869.6 5891.1 5894.9 5906.5 06:37:40 INFO - PROCESS | 30842 | 06:37:40 INFO - PROCESS | 30842 | [#1] ext.html Cycles:180 Average:71801.74 Median:45147.44 stddev:159956.75 (354.3%) stddev-sans-first:160316.13 06:37:40 INFO - PROCESS | 30842 | Values: 597.3 643.1 646.6 663.6 684.4 42198.8 45404.8 45531.8 45549.3 45578.3 45334.8 46084.5 46225.3 46309.3 46593.0 8801.9 9016.0 9082.5 9087.0 9097.3 8834.8 8992.6 8997.0 8997.6 9005.2 9025.8 9093.7 9094.5 9094.9 9118.1 9032.0 9046.5 9058.4 9063.2 9088.5 8863.1 8895.9 8906.3 8966.6 8967.6 42272.4 42524.4 42558.8 42561.1 42666.8 3656.2 3750.8 3917.6 4180.6 4518.9 33879.2 34666.7 34771.8 34915.3 35156.8 4677.5 4693.7 4711.1 4797.6 4847.7 376113.5 377654.0 379604.0 379995.0 382914.1 38103.2 58253.7 58361.0 58643.4 58897.0 39247.4 40726.6 40779.0 40918.2 40978.0 17318.7 17384.8 17552.5 17569.2 17593.6 14732.2 14848.0 14851.0 14893.1 14912.2 8977.0 9064.0 9119.2 9139.7 9156.9 3447.6 3457.1 3471.5 3515.3 3535.1 1080.6 1134.6 1185.7 1201.1 1287.7 33525.2 34040.5 34380.1 34720.5 34825.0 1184.5 1208.3 1262.5 1270.4 1284.8 18127.5 18139.7 18193.0 18199.0 18244.5 568467.0 677856.0 679386.0 687597.0 1114354.0 65008.7 65641.3 65797.0 65915.3 65954.0 1426.3 1445.6 1456.1 1489.9 1491.1 33537.8 34383.8 34642.7 34766.0 34917.5 56603.0 60651.7 62631.0 62994.7 69040.0 568353.0 572501.0 573151.0 574791.0 577005.0 47594.3 48158.5 48365.8 48463.5 48855.7 52503.0 52777.2 53515.5 53749.7 54180.5 43420.6 44031.6 44313.0 44333.6 45993.8 43753.6 44821.3 44988.0 45188.3 45441.8 44014.6 45130.3 45164.5 45469.3 45571.5 37665.4 38856.2 39203.6 39804.2 39895.4 30024.4 30368.2 30566.7 30657.4 30999.0 06:37:40 INFO - PROCESS | 30842 | 06:37:40 INFO - PROCESS | 30842 | [#2] jquery.html Cycles:180 Average:30245.50 Median:2177.56 stddev:90486.41 (4155.4%) stddev-sans-first:90712.46 06:37:40 INFO - PROCESS | 30842 | Values: 382.9 392.0 419.2 423.4 430.8 17489.6 18368.6 20171.7 20253.8 20466.8 17252.4 17339.8 17342.5 18271.8 19482.2 5677.4 5719.7 5863.9 5906.7 5927.0 5397.6 5722.4 5845.5 5851.9 5874.2 5689.7 5716.1 5717.1 5726.1 5763.7 5532.4 5905.2 5919.9 6001.7 6009.9 5641.7 5726.0 5777.2 5779.1 5791.3 13408.1 13673.7 20427.3 23036.2 23154.5 2363.2 2423.8 2439.7 2502.9 2508.5 10455.3 10498.8 10662.2 10746.2 10757.7 2009.8 2091.4 2120.4 2144.9 2179.2 67060.7 70430.0 72437.3 77420.0 83706.0 10533.2 10945.8 11020.7 11121.8 11307.6 12978.5 13601.7 13786.1 15668.1 15798.6 8048.6 8074.0 8372.2 8392.9 8463.4 8382.9 8501.4 8547.1 8654.5 8722.0 4294.5 4316.3 4321.9 4422.7 4441.4 2022.2 2070.3 2102.8 2133.8 2175.9 962.8 1036.3 1042.2 1052.6 1081.8 18347.4 18974.4 19066.2 19434.8 19672.6 1058.4 1080.1 1087.6 1093.2 1102.5 10493.7 10650.5 10681.2 10734.5 10760.7 530579.0 546573.0 556701.0 558126.0 563142.0 84214.0 86739.6 88228.0 90789.5 102948.0 1044.1 1076.1 1078.3 1084.1 1090.3 17395.1 17462.4 17555.4 17701.9 17904.2 34103.5 40996.2 42578.8 42646.8 43055.1 56827.1 57636.0 58173.7 59068.7 59377.0 8313.3 8565.0 8573.9 8591.1 8667.0 9564.8 12422.1 12471.8 12569.2 12671.4 10973.7 11123.1 11296.4 11313.7 11317.4 11074.4 11145.8 11207.4 11278.5 11409.9 11184.4 11261.3 11281.9 11308.5 11778.0 8546.1 8591.7 8650.4 8754.2 8815.3 11088.6 11436.1 11509.2 11522.8 11750.6 06:37:40 INFO - PROCESS | 30842 | 06:37:40 INFO - PROCESS | 30842 | [#3] mootools.html Cycles:180 Average:6109.47 Median:4633.36 stddev:3495.06 (75.4%) stddev-sans-first:3488.32 06:37:40 INFO - PROCESS | 30842 | Values: 1584.3 1585.1 1787.2 1879.6 1901.4 7592.9 8662.6 8946.3 9315.1 9354.7 9055.5 9079.3 9110.2 9123.6 9134.1 2382.7 2400.4 2422.0 2422.4 2426.1 2368.5 2409.0 2418.9 2421.0 2426.9 2346.3 2370.2 2380.2 2390.8 2395.9 2280.5 2293.2 2302.2 2305.1 2324.2 2345.7 2363.0 2363.7 2369.3 2384.0 9092.1 9093.4 9136.0 9140.6 9211.6 5282.7 5441.2 5444.6 5477.7 5496.7 3570.7 3574.2 3632.1 3632.8 3646.9 1260.0 1268.8 1298.0 1300.1 1301.2 13231.7 13270.7 13279.5 13292.1 13316.3 4545.4 4721.4 4731.3 4736.1 4779.1 10844.1 10894.9 10976.3 11001.7 11011.1 5309.6 5360.6 5378.7 5384.3 5407.5 4312.1 4856.8 4894.5 5043.2 5061.7 4092.1 4145.6 4151.7 4173.3 4175.8 1324.1 1347.2 1355.0 1358.7 1360.5 855.9 946.6 999.3 1075.8 1092.1 6433.9 6493.4 6540.4 6575.6 6608.2 507.3 508.5 509.9 1025.6 1103.3 4424.6 4481.6 4500.3 4510.6 4514.4 11386.1 11590.8 11667.6 11679.6 11730.9 10884.9 11409.9 11415.5 11556.8 11744.4 8544.7 8674.4 8681.5 8701.6 8705.8 6225.0 6436.5 6463.5 6486.3 6615.7 10104.8 10203.0 10213.7 10299.4 10354.4 10573.0 10784.8 10890.8 10936.6 11003.9 7365.5 8165.6 8194.1 8206.8 8350.6 9200.6 9214.5 9244.3 9248.4 9254.7 8100.5 8300.2 8344.2 8453.1 8473.2 7996.9 8049.7 8099.0 8114.5 8237.3 7407.6 7410.1 7447.1 7472.6 7516.5 5578.2 5583.9 5600.2 5625.9 5698.5 5466.8 5588.3 5653.1 5692.6 5826.8 06:37:40 INFO - PROCESS | 30842 | 06:37:40 INFO - PROCESS | 30842 | [#4] prototype.html Cycles:180 Average:4796.60 Median:5334.39 stddev:1372.09 (25.7%) stddev-sans-first:1334.50 06:37:40 INFO - PROCESS | 30842 | Values: 337.5 342.2 348.5 356.9 359.3 5519.2 5572.0 5673.5 5718.5 5722.2 5571.2 5579.2 5580.4 5607.5 5619.6 4417.6 4455.6 4462.8 4466.9 4485.0 4345.2 4411.0 4434.0 4459.5 4483.1 4356.3 4378.2 4382.6 4384.8 4427.5 4405.9 4417.7 4435.5 4449.9 4475.3 3771.0 3880.9 3891.5 3892.9 3898.7 5413.5 5414.5 5440.5 5453.5 5471.6 5007.3 5041.6 5057.2 5058.2 5106.4 5588.6 5869.2 5876.5 5895.1 5905.1 4280.3 4286.4 4287.4 4290.5 4314.7 5965.5 6038.9 6080.6 6112.3 6132.5 4344.3 4346.2 4362.4 4363.9 4364.9 4340.5 4437.0 4437.8 4444.3 4447.6 4818.0 4982.3 4982.5 4997.2 5058.1 5671.9 5805.4 5857.9 5863.8 5869.8 1541.5 1556.8 1557.2 1558.7 1558.8 966.9 984.7 1002.4 1002.6 1007.2 5000.8 5064.2 5109.8 5134.2 5134.4 5349.7 5410.9 5439.3 5445.7 5467.2 5008.7 5165.3 5190.8 5207.3 5242.9 2874.7 2890.3 2893.5 2921.6 2924.1 5612.2 5617.6 5651.5 5654.3 5682.3 5166.7 5441.7 5459.4 5481.2 5544.2 5529.8 5657.0 5658.5 5664.5 5670.5 5194.8 5322.9 5339.1 5430.3 5455.6 5312.3 5326.9 5331.7 5333.5 5335.3 5535.3 5612.6 5626.4 5649.9 5670.5 3862.0 3931.4 4024.9 4058.8 4070.0 5255.2 5430.5 5454.5 5998.8 6160.4 5958.8 5987.7 6004.9 6015.5 6016.8 5873.7 5883.1 5902.3 5912.4 5918.5 5660.3 5830.5 5857.7 5888.6 5893.1 5936.8 5946.3 5987.6 6002.6 6019.0 5618.8 5847.7 5873.7 5880.7 5882.6 06:37:40 INFO - PROCESS | 30842 | 06:37:40 INFO - PROCESS | 30842 | [#5] yui.html Cycles:180 Average:19988.85 Median:4197.05 stddev:27167.65 (647.3%) stddev-sans-first:27205.78 06:37:40 INFO - PROCESS | 30842 | Values: 832.7 840.6 875.7 904.1 909.7 15894.3 17155.9 17181.2 17193.2 17213.9 14465.1 14501.2 14509.1 14551.1 14669.0 849.7 871.3 875.8 878.8 880.4 857.9 858.6 860.6 861.0 870.1 918.6 918.9 919.9 920.2 920.4 906.1 912.2 913.1 914.5 916.2 668.3 669.4 670.0 670.0 670.5 15153.5 15302.7 15303.9 15314.8 15388.8 14371.1 14438.3 14514.8 14814.3 15170.0 13817.7 14024.2 14278.9 14297.7 14392.5 4151.7 4164.7 4168.4 4225.7 4240.3 56521.4 72771.6 72785.6 76751.0 80461.6 12454.5 12643.6 12985.4 13010.3 13184.3 21234.7 21372.4 21440.0 21447.4 21463.6 9232.6 9283.2 9316.0 9381.2 9397.7 5020.2 5073.6 5137.4 5176.6 5216.9 3837.9 3895.8 3958.7 3958.9 3962.1 679.1 680.1 692.4 697.2 701.6 659.5 713.2 726.5 731.9 734.2 10712.9 10720.5 10851.9 10924.0 11059.2 676.3 703.8 735.6 796.1 821.5 5132.8 5145.3 5200.7 5233.2 5280.4 67383.0 92583.5 110016.0 117536.4 121502.0 62122.4 84803.6 93014.1 94374.0 94581.0 85790.6 86499.0 87459.1 88362.6 88627.6 10333.5 10559.4 10933.9 11040.4 11091.3 43695.6 45146.0 46114.8 46918.5 51484.5 50107.0 50293.0 55267.4 74144.3 77115.6 13612.5 13844.2 13891.2 13969.2 14022.6 15972.0 16062.9 16288.6 16324.3 16362.7 14480.7 14614.3 14714.5 14730.2 15487.7 14678.6 14739.7 15093.4 15265.3 15687.4 14454.8 14684.2 14772.3 15363.9 15633.8 10781.8 10804.5 11024.2 11574.9 11580.4 11549.8 12065.2 12156.3 12471.0 12544.2 06:37:40 INFO - PROCESS | 30842 | -------- Summary: end -------- 06:37:40 INFO - PROCESS | 30842 | 06:37:41 INFO - TEST-INFO | 30842: exit 0 06:37:41 INFO - TEST-OK | dromaeo_css | took 1110774ms 06:37:41 INFO - TEST-START | kraken 06:37:41 INFO - operating with platform_type : linux_ 06:37:41 INFO - Initialising browser for kraken test... 06:37:41 INFO - TEST-INFO | started process 31103 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE7EQnD/profile http://localhost:48193/getInfo.html) 06:37:45 INFO - PROCESS | 31103 | __metrics Screen width/height:1600/1200 06:37:45 INFO - PROCESS | 31103 | colorDepth:24 06:37:45 INFO - PROCESS | 31103 | Browser inner width/height: 1024/697 06:37:45 INFO - PROCESS | 31103 | __metrics 06:37:46 ERROR - PROCESS | 31103 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 06:37:47 INFO - TEST-INFO | 31103: exit 0 06:37:47 INFO - Browser initialized. 06:37:47 INFO - Running cycle 1/1 for kraken test... 06:37:47 INFO - TEST-INFO | started process 31230 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE7EQnD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:37:58 INFO - PROCESS | 31230 | RSS: Main: 155799552 06:37:58 INFO - PROCESS | 31230 | 06:38:01 INFO - PROCESS | 31230 | Cycle 1(1): loaded http://localhost:48193/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48193/tests/kraken/driver.html?testName=audio-beat-detection) 06:38:02 INFO - PROCESS | 31230 | RSS: Main: 161701888 06:38:02 INFO - PROCESS | 31230 | 06:38:05 INFO - PROCESS | 31230 | Cycle 1(1): loaded http://localhost:48193/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48193/tests/kraken/driver.html?testName=audio-dft) 06:38:05 INFO - PROCESS | 31230 | RSS: Main: 160485376 06:38:05 INFO - PROCESS | 31230 | 06:38:08 INFO - PROCESS | 31230 | Cycle 1(1): loaded http://localhost:48193/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48193/tests/kraken/driver.html?testName=audio-fft) 06:38:09 INFO - PROCESS | 31230 | RSS: Main: 161529856 06:38:09 INFO - PROCESS | 31230 | 06:38:11 INFO - PROCESS | 31230 | Cycle 1(1): loaded http://localhost:48193/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48193/tests/kraken/driver.html?testName=audio-oscillator) 06:38:11 INFO - PROCESS | 31230 | RSS: Main: 161255424 06:38:11 INFO - PROCESS | 31230 | 06:38:13 INFO - PROCESS | 31230 | Cycle 1(1): loaded http://localhost:48193/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48193/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:38:14 INFO - PROCESS | 31230 | RSS: Main: 161214464 06:38:14 INFO - PROCESS | 31230 | 06:38:17 INFO - PROCESS | 31230 | Cycle 1(1): loaded http://localhost:48193/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48193/tests/kraken/driver.html?testName=imaging-darkroom) 06:38:18 INFO - PROCESS | 31230 | RSS: Main: 160600064 06:38:18 INFO - PROCESS | 31230 | 06:38:21 INFO - PROCESS | 31230 | Cycle 1(1): loaded http://localhost:48193/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48193/tests/kraken/driver.html?testName=imaging-desaturate) 06:38:22 INFO - PROCESS | 31230 | RSS: Main: 157908992 06:38:22 INFO - PROCESS | 31230 | 06:38:25 INFO - PROCESS | 31230 | Cycle 1(1): loaded http://localhost:48193/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48193/tests/kraken/driver.html?testName=json-parse-financial) 06:38:25 INFO - PROCESS | 31230 | RSS: Main: 159121408 06:38:25 INFO - PROCESS | 31230 | 06:38:27 INFO - PROCESS | 31230 | Cycle 1(1): loaded http://localhost:48193/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48193/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:38:27 INFO - PROCESS | 31230 | RSS: Main: 159113216 06:38:27 INFO - PROCESS | 31230 | 06:38:29 INFO - PROCESS | 31230 | Cycle 1(1): loaded http://localhost:48193/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48193/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:38:30 INFO - PROCESS | 31230 | RSS: Main: 159678464 06:38:30 INFO - PROCESS | 31230 | 06:38:32 INFO - PROCESS | 31230 | Cycle 1(1): loaded http://localhost:48193/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48193/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:38:33 INFO - PROCESS | 31230 | RSS: Main: 159744000 06:38:33 INFO - PROCESS | 31230 | 06:38:35 INFO - PROCESS | 31230 | Cycle 1(1): loaded http://localhost:48193/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48193/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:38:36 INFO - PROCESS | 31230 | RSS: Main: 160018432 06:38:36 INFO - PROCESS | 31230 | 06:38:38 INFO - PROCESS | 31230 | Cycle 1(1): loaded http://localhost:48193/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48193/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:38:39 INFO - PROCESS | 31230 | RSS: Main: 159739904 06:38:39 INFO - PROCESS | 31230 | 06:38:41 INFO - PROCESS | 31230 | Cycle 1(1): loaded http://localhost:48193/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48193/tests/kraken/driver.html?testName=ai-astar) 06:38:41 INFO - PROCESS | 31230 | RSS: Main: 159973376 06:38:41 INFO - PROCESS | 31230 | 06:38:41 INFO - PROCESS | 31230 | __start_tp_report 06:38:41 INFO - PROCESS | 31230 | _x_x_mozilla_page_load 06:38:41 INFO - PROCESS | 31230 | _x_x_mozilla_page_load_details 06:38:41 INFO - PROCESS | 31230 | |i|pagename|runs| 06:38:41 INFO - PROCESS | 31230 | |0;ai-astar;112;104;111;111;111;113;112;111;112;111 06:38:41 INFO - PROCESS | 31230 | |1;audio-beat-detection;153;132;159;172;132;153;150;126;172;127 06:38:41 INFO - PROCESS | 31230 | |2;audio-dft;163;163;163;162;166;163;162;161;165;162 06:38:41 INFO - PROCESS | 31230 | |3;audio-fft;76;76;76;173;76;76;75;75;170;77 06:38:41 INFO - PROCESS | 31230 | |4;audio-oscillator;83;85;148;85;84;84;139;85;85;142 06:38:41 INFO - PROCESS | 31230 | |5;imaging-gaussian-blur;117;117;117;118;117;118;118;118;117;117 06:38:41 INFO - PROCESS | 31230 | |6;imaging-darkroom;147;147;148;147;147;148;147;147;148;148 06:38:41 INFO - PROCESS | 31230 | |7;imaging-desaturate;96;96;96;95;95;95;95;95;95;96 06:38:41 INFO - PROCESS | 31230 | |8;json-parse-financial;53;55;52;51;52;55;53;52;52;53 06:38:41 INFO - PROCESS | 31230 | |9;json-stringify-tinderbox;59;60;60;59;60;60;61;59;59;60 06:38:41 INFO - PROCESS | 31230 | |10;stanford-crypto-aes;78;77;82;76;88;78;83;77;99;78 06:38:41 INFO - PROCESS | 31230 | |11;stanford-crypto-ccm;121;124;128;116;123;119;130;120;125;126 06:38:41 INFO - PROCESS | 31230 | |12;stanford-crypto-pbkdf2;153;153;156;154;152;147;163;152;156;150 06:38:41 INFO - PROCESS | 31230 | |13;stanford-crypto-sha256-iterative;63;65;63;64;65;64;62;68;60;60 06:38:41 INFO - PROCESS | 31230 | __end_tp_report 06:38:41 INFO - PROCESS | 31230 | __start_cc_report 06:38:41 INFO - PROCESS | 31230 | _x_x_mozilla_cycle_collect,874 06:38:41 INFO - PROCESS | 31230 | __end_cc_report 06:38:41 INFO - PROCESS | 31230 | __startTimestamp1469453921347__endTimestamp 06:38:41 INFO - PROCESS | 31230 | 06:38:41 INFO - PROCESS | 31230 | ------- Summary: start ------- 06:38:41 INFO - PROCESS | 31230 | Number of tests: 14 06:38:41 INFO - PROCESS | 31230 | 06:38:41 INFO - PROCESS | 31230 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.50 stddev:2.49 (2.2%) stddev-sans-first:2.60 06:38:41 INFO - PROCESS | 31230 | Values: 112.0 104.0 111.0 111.0 111.0 113.0 112.0 111.0 112.0 111.0 06:38:41 INFO - PROCESS | 31230 | 06:38:41 INFO - PROCESS | 31230 | [#1] audio-beat-detection Cycles:10 Average:147.60 Median:153.00 stddev:17.52 (11.5%) stddev-sans-first:18.47 06:38:41 INFO - PROCESS | 31230 | Values: 153.0 132.0 159.0 172.0 132.0 153.0 150.0 126.0 172.0 127.0 06:38:41 INFO - PROCESS | 31230 | 06:38:41 INFO - PROCESS | 31230 | [#2] audio-dft Cycles:10 Average:163.00 Median:163.00 stddev:1.49 (0.9%) stddev-sans-first:1.58 06:38:41 INFO - PROCESS | 31230 | Values: 163.0 163.0 163.0 162.0 166.0 163.0 162.0 161.0 165.0 162.0 06:38:41 INFO - PROCESS | 31230 | 06:38:41 INFO - PROCESS | 31230 | [#3] audio-fft Cycles:10 Average:95.00 Median:76.00 stddev:40.33 (53.1%) stddev-sans-first:42.19 06:38:41 INFO - PROCESS | 31230 | Values: 76.0 76.0 76.0 173.0 76.0 76.0 75.0 75.0 170.0 77.0 06:38:41 INFO - PROCESS | 31230 | 06:38:41 INFO - PROCESS | 31230 | [#4] audio-oscillator Cycles:10 Average:102.00 Median:84.50 stddev:28.38 (33.6%) stddev-sans-first:29.26 06:38:41 INFO - PROCESS | 31230 | Values: 83.0 85.0 148.0 85.0 84.0 84.0 139.0 85.0 85.0 142.0 06:38:41 INFO - PROCESS | 31230 | 06:38:41 INFO - PROCESS | 31230 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 06:38:41 INFO - PROCESS | 31230 | Values: 117.0 117.0 117.0 118.0 117.0 118.0 118.0 118.0 117.0 117.0 06:38:41 INFO - PROCESS | 31230 | 06:38:41 INFO - PROCESS | 31230 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 06:38:41 INFO - PROCESS | 31230 | Values: 147.0 147.0 148.0 147.0 147.0 148.0 147.0 147.0 148.0 148.0 06:38:41 INFO - PROCESS | 31230 | 06:38:41 INFO - PROCESS | 31230 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 06:38:41 INFO - PROCESS | 31230 | Values: 96.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 06:38:41 INFO - PROCESS | 31230 | 06:38:41 INFO - PROCESS | 31230 | [#8] json-parse-financial Cycles:10 Average:52.80 Median:53.00 stddev:1.32 (2.5%) stddev-sans-first:1.39 06:38:41 INFO - PROCESS | 31230 | Values: 53.0 55.0 52.0 51.0 52.0 55.0 53.0 52.0 52.0 53.0 06:38:41 INFO - PROCESS | 31230 | 06:38:41 INFO - PROCESS | 31230 | [#9] json-stringify-tinderbox Cycles:10 Average:59.70 Median:60.00 stddev:0.67 (1.1%) stddev-sans-first:0.67 06:38:41 INFO - PROCESS | 31230 | Values: 59.0 60.0 60.0 59.0 60.0 60.0 61.0 59.0 59.0 60.0 06:38:41 INFO - PROCESS | 31230 | 06:38:41 INFO - PROCESS | 31230 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:80.00 stddev:7.14 (8.9%) stddev-sans-first:7.45 06:38:41 INFO - PROCESS | 31230 | Values: 78.0 77.0 82.0 76.0 88.0 78.0 83.0 77.0 99.0 78.0 06:38:41 INFO - PROCESS | 31230 | 06:38:41 INFO - PROCESS | 31230 | [#11] stanford-crypto-ccm Cycles:10 Average:123.20 Median:124.50 stddev:4.29 (3.4%) stddev-sans-first:4.48 06:38:41 INFO - PROCESS | 31230 | Values: 121.0 124.0 128.0 116.0 123.0 119.0 130.0 120.0 125.0 126.0 06:38:41 INFO - PROCESS | 31230 | 06:38:41 INFO - PROCESS | 31230 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.60 Median:153.50 stddev:4.25 (2.8%) stddev-sans-first:4.50 06:38:41 INFO - PROCESS | 31230 | Values: 153.0 153.0 156.0 154.0 152.0 147.0 163.0 152.0 156.0 150.0 06:38:41 INFO - PROCESS | 31230 | 06:38:41 INFO - PROCESS | 31230 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:64.00 stddev:2.41 (3.8%) stddev-sans-first:2.55 06:38:41 INFO - PROCESS | 31230 | Values: 63.0 65.0 63.0 64.0 65.0 64.0 62.0 68.0 60.0 60.0 06:38:41 INFO - PROCESS | 31230 | -------- Summary: end -------- 06:38:41 INFO - PROCESS | 31230 | 06:38:42 INFO - TEST-INFO | 31230: exit 0 06:38:42 INFO - TEST-OK | kraken | took 60871ms 06:38:42 INFO - SUITE-END | took 1171s 06:38:42 INFO - Completed test suite (00:19:31) 06:38:42 INFO - javascript benchmark 06:38:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7529.5810790088835, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3361.8655253789843, 3398.1674489750008, 3402.625711171769, 3410.6930376266146, 3436.0722604896678, 5667.801626943058, 5679.4604512571295, 5692.857678558033, 5754.223179870716, 5777.740001699923, 5694.715264236792, 5742.196092547037, 5781.971090144543, 5783.942160578393, 5798.971005144968, 5159.38087429509, 5231.346081739783, 5275.525202731754, 5289.18017707256, 5314.92027619586, 5159.071367153911, 5180.948190518085, 5317.973410132963, 5329.680219186842, 5330.573554115681, 5228.973855130738, 5259.053370393328, 5268.104422248227, 5286.04851126797, 5287.259783630295, 5220.765065572058, 5226.477352264781, 5272.815451459219, 5296.205569164617, 5311.389190243133, 5163.664361816507, 5217.817376391846, 5291.0, 5295.947040529622, 5305.965336759334, 5426.0, 5515.972420137914, 5524.696141712204, 5610.438956104398, 5641.464060914206, 6105.297890742577, 6107.450329470369, 6113.205283313141, 6119.938800612026, 6126.877462450726, 5902.8819423611285, 6174.814755557296, 6190.876182476325, 6192.256929168529, 6192.28788689302, 5564.081926482126, 5606.0, 5624.184493248456, 5654.74553645087, 5678.886422271531, 6144.539159563051, 6172.0, 6184.103305020837, 6204.193454850931, 6213.409726076015, 5822.650640961556, 5947.197128387612, 5953.136795164677, 5956.731947062306, 5966.075258334965, 6068.696565171724, 6159.969200153971, 6195.1636529068, 6211.006239001738, 6213.65824879636, 6108.969455152695, 6113.480354169946, 6115.724792384264, 6146.262448506119, 6187.907181392283, 5866.8533286667325, 5965.970170149121, 6004.819855404345, 6137.324894261627, 6159.076138579249, 4646.930296045562, 4657.301404789241, 4658.883527911829, 4663.370444989883, 4708.105459962596, 4161.729487583298, 4178.874633760992, 4180.372944058416, 4183.91632167355, 4206.390073439334, 5797.130430435384, 5828.795992140254, 5863.882722345615, 5883.970580147072, 5901.881962360729, 5968.22413086296, 5971.522278217819, 5998.550108741862, 5999.940000600025, 6091.451769340781, 5783.334916484658, 5805.82582522525, 5814.59297849155, 5831.271091113611, 5876.471117599351, 5029.5221953914315, 5138.665986710852, 5143.434222235551, 5166.070107380708, 5191.402988656353, 6410.67946602668, 6499.09012738217, 6536.215654121535, 6545.247296560861, 6553.049807777846, 6221.160143380766, 6230.875382492415, 6232.220972378453, 6251.093591429309, 6266.091416744455, 6194.349593292639, 6222.28443728977, 6238.656873871981, 6477.708503117466, 6487.708053137714, 5912.113183022409, 5915.615484993462, 5926.288845338587, 5952.464278214981, 5963.254593175853, 6016.939830601638, 6030.396960303934, 6040.335563088145, 6043.12374705674, 6063.514918806397, 5845.853853653693, 5892.587518873637, 5934.465898069195, 6010.639361638316, 6025.66858822769, 5958.7616495341435, 5985.581009329305, 6003.3996600339615, 6003.489703375088, 6028.0, 5895.41045895407, 5896.823095307148, 5913.438223368773, 5928.288605367384, 5938.61399009063, 5790.652516152669, 5844.620099693507, 5903.0, 5984.1323008164445, 6009.128676341993, 5869.413058694096, 5869.559783016205, 5891.05743081105, 5894.911576326273, 5906.468417842415], "value": 5637.390468396371, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.2802772658944, 643.1381948189426, 646.6088016749864, 663.5719960625397, 684.3567046975845, 42198.78900605496, 45404.77297613507, 45531.77234113825, 45549.316760248585, 45578.316325255146, 45334.77332613341, 46084.53915460844, 46225.30662040064, 46309.30536041962, 46593.0, 8801.911980880206, 9016.0, 9082.45505269686, 9087.0, 9097.272218222559, 8834.779130521756, 8992.640294388217, 8997.0, 8997.595108220114, 9005.234555062794, 9025.774355641128, 9093.681721139761, 9094.454332740057, 9094.909050909506, 9118.133777291147, 9031.95484022579, 9046.457212567235, 9058.411203271766, 9063.229625481808, 9088.50013249271, 8863.11368863115, 8895.911040889638, 8906.332025098143, 8966.596503157374, 8967.551622418852, 42272.365914511305, 42524.36213456801, 42558.78720606408, 42561.148777024595, 42666.78666606678, 3656.213914008501, 3750.8124593770203, 3917.627825356615, 4180.586235139355, 4518.909621807578, 33879.153021174425, 34666.653333466595, 34771.82614086939, 34915.301693966234, 35156.824215879016, 4677.4854765975715, 4693.694909830884, 4711.10489007091, 4797.592204662573, 4847.709137451729, 376113.4777304466, 377654.0, 379604.0, 379995.0, 382914.08542957384, 38103.23793524114, 58253.70873145607, 58361.0, 58643.41356586465, 58897.0, 39247.41128883069, 40726.592734072874, 40779.0, 40918.1816363671, 40978.0, 17318.740218896728, 17384.826151738573, 17552.473425797245, 17569.20938557768, 17593.648127037643, 14732.189729564976, 14848.0, 14851.0, 14893.106413615218, 14912.179830109231, 8976.955115224513, 9063.954680226556, 9119.179273865251, 9139.725808225763, 9156.8626470603, 3447.620761716209, 3457.0665920201404, 3471.548698669207, 3515.33208690348, 3535.116220944764, 1080.5947769586405, 1134.625573560723, 1185.7213554814612, 1201.1471854982885, 1287.67808047988, 33525.161870952936, 34040.48939265913, 34380.14049648779, 34720.47919281213, 34825.0, 1184.5463782122802, 1208.3052244959008, 1262.501311981762, 1270.4092596942282, 1284.8329717136712, 18127.456176314732, 18139.72790408145, 18193.0, 18199.0, 18244.543886402946, 568467.0, 677856.0, 679386.0, 687597.0, 1114354.0, 65008.67495662491, 65641.34358656353, 65797.0, 65915.34084659188, 65954.0, 1426.3153686230667, 1445.6313640021726, 1456.1336005076962, 1489.91060536366, 1491.0680824484698, 33537.83231083829, 34383.828080859435, 34642.65357346394, 34766.0, 34917.47623785696, 56603.0, 60651.69674151778, 62631.0, 62994.685026574574, 69040.0, 568353.0, 572501.0, 573151.0, 574791.0, 577005.0, 47594.28608570805, 48158.5184148154, 48365.7908552275, 48463.5153648459, 48855.65734092597, 52503.0, 52777.20834187413, 53515.464845351045, 53749.731251343495, 54180.458195419116, 43420.56579434292, 44031.55968440403, 44313.0, 44333.556664432945, 45993.77003114963, 43753.56246437622, 44821.32768008417, 44988.0, 45188.322175168054, 45441.77279113583, 44014.55985440104, 45130.323045155004, 45164.54835451603, 45469.31796023128, 45571.54428455673, 37665.43501847529, 38856.222875542895, 39203.607963919996, 39804.2039159221, 39895.40156897707, 30024.399512010074, 30368.240793980327, 30566.694333057276, 30657.386852263277, 30999.0], "value": 20910.403966211958, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.85834241330696, 391.99412008819854, 419.2265270575788, 423.4093439651685, 430.838435586655, 17489.562760930952, 18368.632627347444, 20171.697424538626, 20253.797462025374, 20466.795332046677, 17252.39616613419, 17339.826601733977, 17342.479725608253, 18271.817281827178, 19482.220711171536, 5677.403872593381, 5719.714014299289, 5863.8534036649, 5906.704664766766, 5926.97036514819, 5397.568194544447, 5722.427757224286, 5845.503132233765, 5851.8537036574, 5874.1776151338845, 5689.743961521721, 5716.056850619663, 5717.142428635717, 5726.083826587746, 5763.682997435139, 5532.3637781655225, 5905.173275741378, 5919.881602367928, 6001.66990815505, 6009.939900600982, 5641.717914104278, 5726.0, 5777.24895763548, 5779.133130030487, 5791.333996590404, 13408.061435699505, 13673.726525469436, 20427.285045023502, 23036.193733219425, 23154.536909261722, 2363.1728894886824, 2423.7697418745365, 2439.7438268981855, 2502.87485625718, 2508.5359208546297, 10455.268131230818, 10498.842517362245, 10662.20033497483, 10746.247762656618, 10757.677269681923, 2009.819116279542, 2091.435312465626, 2120.4274845791706, 2144.8820314882673, 2179.1936983316273, 67060.66469667669, 70430.0, 72437.2756272441, 77420.0, 83705.99999999939, 10533.157347412189, 10945.83581246282, 11020.669379918616, 11121.833172502418, 11307.643082830113, 12978.545750898673, 13601.659958501117, 13786.103903246258, 15668.138252396, 15798.60503487399, 8048.557329346825, 8073.959630201812, 8372.162783721578, 8392.916070839336, 8463.407561470762, 8382.916170838336, 8501.44740591872, 8547.059823419419, 8654.48073115615, 8722.0, 4294.463192100988, 4316.287812510964, 4321.9135617287475, 4422.7346359218545, 4441.378207051015, 2022.2416593777334, 2070.285751415759, 2102.7815654484666, 2133.775953524889, 2175.9238426654993, 962.8074385123003, 1036.3367444835312, 1042.1870940666292, 1052.563186277686, 1081.8377243413552, 18347.449576512725, 18974.43076707701, 19066.237350505824, 19434.8056519433, 19672.606547869247, 1058.433737950193, 1080.065743132185, 1087.6030248959073, 1093.2128867215592, 1102.4763237462141, 10493.737656558495, 10650.520726567323, 10681.198910081775, 10734.463276836126, 10760.677179684622, 530579.0, 546573.0, 556701.0, 558126.0, 563142.0, 84214.0, 86739.56630216808, 88228.0, 90789.54605226932, 102948.0, 1044.1177205261542, 1076.1014552848303, 1078.250615822012, 1084.116445097259, 1090.334895713614, 17395.13024348752, 17462.388816391365, 17555.385561505285, 17701.911490442464, 17904.194311255764, 34103.4884476738, 40996.1800763989, 42578.78710606427, 42646.78676606597, 43055.13889722125, 56827.14759278532, 57636.0, 58173.709131454074, 59068.704656476446, 59377.0, 8313.334933205208, 8564.957175214084, 8573.914260857311, 8591.097934716765, 8667.0, 9564.810575142885, 12422.06834487399, 12471.750564988832, 12569.245845249314, 12671.429785659851, 10973.725656858642, 11123.110151187724, 11296.378699171624, 11313.71715707114, 11317.377544235145, 11074.446277686244, 11145.777084458103, 11207.43962801873, 11278.548858045915, 11409.942950285196, 11184.440777961232, 11261.324320540794, 11281.943590281997, 11308.49111789955, 11778.0, 8546.145385461405, 8591.6992905248, 8650.394472386872, 8754.168354006359, 8815.250703690259, 11088.611898583511, 11436.142289328167, 11509.194356394972, 11522.76954460923, 11750.58872939443], "value": 9217.729984888763, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1584.2870708181322, 1585.056891149766, 1787.2314904591028, 1879.6334714730633, 1901.4010586665208, 7592.924070759291, 8662.566871656416, 8946.329025323093, 9315.068493150682, 9354.672586459475, 9055.547222638874, 9079.273658107351, 9110.180083792475, 9123.589438475268, 9134.086591340863, 2382.725986511556, 2400.435897564071, 2422.019082271674, 2422.406510404953, 2426.0780903256737, 2368.4670949036417, 2408.963865542018, 2418.8548687078833, 2421.0, 2426.8665223412704, 2346.3312955807596, 2370.1704403458825, 2380.2264264114146, 2390.8326417150806, 2395.940101497459, 2280.5096904165603, 2293.2203050962753, 2302.1597117052324, 2305.054927479742, 2324.174917904145, 2345.683332750074, 2363.0429675981254, 2363.7163540375095, 2369.336585755974, 2384.034466041256, 9092.136247056518, 9093.40892841963, 9136.04071572482, 9140.588673509708, 9211.585478653476, 5282.683039017671, 5441.156620723794, 5444.646098003617, 5477.698726570037, 5496.670199787985, 3570.7143428525656, 3574.2136729919375, 3632.110133017428, 3632.7820330780237, 3646.8723594674325, 1259.9857115022403, 1268.7779638563215, 1297.9935100324533, 1300.1094250438384, 1301.2322729589494, 13231.669208269774, 13270.66823329415, 13279.46882124714, 13292.069555131146, 13316.334183290797, 4545.36364908913, 4721.362616046858, 4731.33761273422, 4736.100140973204, 4779.139754844162, 10844.078253348396, 10894.945525272324, 10976.286541374786, 11001.669949901516, 11011.119110471143, 5309.601779866525, 5360.571154307724, 5378.731063446812, 5384.273123128406, 5407.540359069444, 4312.094460163338, 4856.8300109495995, 4894.461609222983, 5043.193089105725, 5061.746912654353, 4092.120194158211, 4145.585441455831, 4151.730137541111, 4173.332266837291, 4175.791210439465, 1324.0945383589299, 1347.1782212850153, 1354.9932250338686, 1358.7282543491342, 1360.5102163221231, 855.9272461840688, 946.5882341181608, 999.2655398282257, 1075.7794652096302, 1092.1099304067159, 6433.935660643428, 6493.350664933563, 6540.411362977355, 6575.638339891352, 6608.173978252718, 507.26446652354235, 508.53977150678696, 509.85978855814204, 1025.5743866295404, 1103.2883789955595, 4424.579664931826, 4481.551844815493, 4500.279955207151, 4510.616597589242, 4514.413126293626, 11386.146039046938, 11590.826137607943, 11667.59163429276, 11679.591214307628, 11730.88269117315, 10884.945575272073, 11409.942950285196, 11415.543378264943, 11556.76886462266, 11744.354060526754, 8544.658213671508, 8674.436161649473, 8681.522516261666, 8701.608427620773, 8705.782355441039, 6224.957784194817, 6436.549441539048, 6463.515236357198, 6486.254080780771, 6615.702293396713, 10104.797904042025, 10203.0, 10213.693589192337, 10299.3820370778, 10354.378737275787, 10573.0, 10784.784304314027, 10890.782184356427, 10936.56253749841, 11003.889961100607, 7365.52124111931, 8165.550894700611, 8194.09864914847, 8206.753797386087, 8350.624221909908, 9200.585973631336, 9214.539273036187, 9244.260459163384, 9248.398854074463, 9254.722358329262, 8100.473469224482, 8300.169983001651, 8344.16558344185, 8453.070162282022, 8473.237408633253, 7996.92003079985, 8049.718259860877, 8098.959505202436, 8114.472559283628, 8237.341012719087, 7407.629618518945, 7410.073740782403, 7447.106347238366, 7472.626368681653, 7516.549007059594, 5578.163275508706, 5583.944160558505, 5600.215969764317, 5625.915611265752, 5698.515626171822, 5466.753996070107, 5588.329400471969, 5653.067243904874, 5692.6299790513485, 5826.796062137805], "value": 4853.050316506623, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.53757352427164, 342.2197389950913, 348.47206482179485, 356.90006798096533, 359.3441968407656, 5519.199716041172, 5571.9721401393035, 5673.546116310696, 5718.542516598673, 5722.22749928759, 5571.220029195916, 5579.214651311582, 5580.441955804417, 5607.467290607386, 5619.634723742954, 4417.624501917341, 4455.621272191867, 4462.754548499831, 4466.932996005063, 4485.0, 4345.239583072949, 4410.952771767521, 4433.955660443403, 4459.509453960078, 4483.125790470859, 4356.279269688471, 4378.219830407698, 4382.605565499104, 4384.758838263894, 4427.512973572904, 4405.88985275369, 4417.734935903856, 4435.534268901751, 4449.911001779947, 4475.30632751924, 3770.9818349045877, 3880.941785873214, 3891.4746509221177, 3892.863749768773, 3898.7075969302414, 5413.53984911283, 5414.485623865766, 5440.510354068113, 5453.509184173444, 5471.616986810925, 5007.349044624212, 5041.621878359138, 5057.216131499624, 5058.190689489701, 5106.361704786902, 5588.636738611977, 5869.178315035856, 5876.471117599393, 5895.056790913433, 5905.084711869667, 4280.315149576053, 4286.39990401344, 4287.356896465524, 4290.528041915387, 4314.684021373511, 5965.463108320272, 6038.909416358802, 6080.635161890256, 6112.327643959161, 6132.478739307119, 4344.327433937957, 4346.152500262482, 4362.429525370864, 4363.865394997323, 4364.912701745948, 4340.479142502857, 4436.955630443719, 4437.7781110944325, 4444.333349997526, 4447.577480139382, 4817.9518204817505, 4982.302477653131, 4982.5052484254575, 4997.150484417658, 5058.140116180258, 5671.858203544862, 5805.390434004453, 5857.882842343214, 5863.765449382062, 5869.794557190563, 1541.48360299301, 1556.8479325299197, 1557.1746974103517, 1558.688262347535, 1558.7895634089252, 966.9371490853072, 984.7341217871135, 1002.4286156890503, 1002.5789168549227, 1007.2294694558668, 5000.824971125993, 5064.176896317396, 5109.795608175706, 5134.203028939841, 5134.409542902614, 5349.662584353911, 5410.8917821643345, 5439.292891924025, 5445.700486473203, 5467.223152475462, 5008.6744361616375, 5165.302684137669, 5190.844274671766, 5207.3490813648295, 5242.895142097137, 2874.6837847836723, 2890.349671323935, 2893.450244453547, 2921.649402071765, 2924.064299424164, 5612.1581762735095, 5617.634853734494, 5651.463111004448, 5654.264945557134, 5682.261306030189, 5166.741662916915, 5441.700706461183, 5459.3994660587305, 5481.177193745224, 5544.1960915667805, 5529.751161197756, 5656.971715141481, 5658.490735833795, 5664.518515926193, 5670.468973377165, 5194.7922083116255, 5322.93541291751, 5339.143558196346, 5430.294061771944, 5455.618106732491, 5312.256284120149, 5326.920096198638, 5331.70675612845, 5333.466653334635, 5335.306410166653, 5535.3357597087, 5612.635178713371, 5626.437356264504, 5649.915251271316, 5670.546356291569, 3861.9806900965314, 3931.4495970564717, 4024.919501609893, 4058.76767777727, 4069.9593004070766, 5255.159174532057, 5430.51125398716, 5454.509094181542, 5998.790042348497, 6160.383961603804, 5958.791442299499, 5987.700614969322, 6004.909926351021, 6015.518758499397, 6016.759329626766, 5873.676947767743, 5883.146943693055, 5902.321233058254, 5912.379200184091, 5918.467337939606, 5660.32076150848, 5830.47525722687, 5857.736401861841, 5888.646681199141, 5893.145493903446, 5936.821895343147, 5946.286445626552, 5987.5808693391045, 6002.579819412599, 6018.969905150446, 5618.831435056954, 5847.707614619337, 5873.676947767914, 5880.676562789087, 5882.588218824641], "value": 4363.697799202047, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [832.6752566499063, 840.6091167607066, 875.7460336502414, 904.1275169461468, 909.7134402663161, 15894.284757185926, 17155.914220428913, 17181.22684479198, 17193.226304816297, 17213.913930430346, 14465.132092074484, 14501.202433866134, 14509.129452232874, 14551.054181478223, 14669.0, 849.736581659686, 871.2942516561606, 875.8248350329927, 878.7539488943106, 880.3749337970017, 857.939944203906, 858.5750053723416, 860.5568132411813, 860.9870851937226, 870.1472556894247, 918.6417297254076, 918.9310801689867, 919.9264058875308, 920.1718453391934, 920.3603495570582, 906.1255888068013, 912.16536868765, 913.137085454246, 914.4696076275744, 916.1662886773038, 668.2982867988641, 669.3674477618653, 670.0, 670.0, 670.51722759613, 15153.469628563058, 15302.693946121126, 15303.923480382527, 15314.770278445832, 15388.846111538853, 14371.137731736024, 14438.278086095654, 14514.782278265835, 14814.259287035713, 15170.0, 13817.654558636115, 14024.228667423287, 14278.928605356907, 14297.71404571913, 14392.496262630862, 4151.6886233532605, 4164.729292595972, 4168.395582640531, 4225.704200705952, 4240.279152544044, 56521.43478565244, 72771.63614181949, 72785.6360718193, 76751.0, 80461.59769201117, 12454.501819927282, 12643.557475488315, 12985.350732463528, 13010.349482525837, 13184.274864882524, 21234.681479777817, 21372.35882923515, 21440.035198415797, 21447.356579302646, 21463.570728585342, 9232.630694772268, 9283.210927071139, 9316.021817709043, 9381.249500039981, 9397.671081512115, 5020.171671674206, 5073.594112470993, 5137.409197942285, 5176.559992400688, 5216.895662086737, 3837.884863454101, 3895.824687889052, 3958.7426817256787, 3958.8812335629977, 3962.128331767007, 679.1307126877605, 680.1056610557101, 692.425287011779, 697.1564407067403, 701.5930760159096, 659.515256286629, 713.1976526407791, 726.4950859152838, 731.8902164675235, 734.2290594875466, 10712.946435267773, 10720.46397680113, 10851.945740271249, 10924.0, 11059.22585419029, 676.2898956096079, 703.7501686901179, 735.6174789109633, 796.0685997383076, 821.496661110167, 5132.79468821243, 5145.253938179018, 5200.6619569727845, 5233.241180028875, 5280.419153893069, 67383.0, 92583.53708231551, 110016.0, 117536.41231793787, 121502.0, 62122.37877621166, 84803.57598212094, 93014.06985930189, 94374.0, 94581.0, 85790.57104714436, 86499.0, 87459.12540874637, 88362.55818720865, 88627.55686221656, 10333.534990925576, 10559.419231942316, 10933.945330273298, 11040.447977601249, 11091.33451992883, 43695.56304436915, 45146.0, 46114.769426152656, 46918.53081469142, 51484.485155147966, 50107.0, 50293.0, 55267.44732552623, 74144.25855741589, 77115.61442192753, 13612.455501779817, 13844.169349839041, 13891.235982021086, 13969.161850289016, 14022.649433764238, 15972.011103856872, 16062.919685401499, 16288.592785180464, 16324.347026118823, 16362.672746544764, 14480.710385792014, 14614.34235459428, 14714.48499302562, 14730.189839558927, 15487.690246194788, 14678.633034173803, 14739.705205895607, 15093.396264149751, 15265.313060912064, 15687.372505099669, 14454.783178252545, 14684.192369419785, 14772.33524491379, 15363.923180384027, 15633.843661563238, 10781.784364312512, 10804.459777010961, 11024.228304018641, 11574.942125289319, 11580.36308003068, 11549.769004619693, 12065.215760975509, 12156.270623762603, 12471.0, 12544.184627999151], "value": 7918.59630572096, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1512.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 104.0, 111.0, 111.0, 111.0, 113.0, 112.0, 111.0, 112.0, 111.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 132.0, 159.0, 172.0, 132.0, 153.0, 150.0, 126.0, 172.0, 127.0], "value": 147.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 162.0, 166.0, 163.0, 162.0, 161.0, 165.0, 162.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 173.0, 76.0, 76.0, 75.0, 75.0, 170.0, 77.0], "value": 95.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 148.0, 85.0, 84.0, 84.0, 139.0, 85.0, 85.0, 142.0], "value": 102.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 147.0, 147.0, 148.0, 147.0, 147.0, 148.0, 148.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 52.0, 51.0, 52.0, 55.0, 53.0, 52.0, 52.0, 53.0], "value": 52.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 60.0, 59.0, 60.0, 60.0, 61.0, 59.0, 59.0, 60.0], "value": 59.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 82.0, 76.0, 88.0, 78.0, 83.0, 77.0, 99.0, 78.0], "value": 81.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 124.0, 128.0, 116.0, 123.0, 119.0, 130.0, 120.0, 125.0, 126.0], "value": 123.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 153.0, 156.0, 154.0, 152.0, 147.0, 163.0, 152.0, 156.0, 150.0], "value": 153.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 63.0, 64.0, 65.0, 64.0, 62.0, 68.0, 60.0, 60.0], "value": 63.4, "unit": "score"}]}]} 06:38:42 INFO - Return code: 0 06:38:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:38:42 ERROR - # TBPL SUCCESS # 06:38:42 INFO - Running post-action listener: _resource_record_post_action 06:38:42 INFO - ##### 06:38:42 INFO - ##### Finished run-tests step (success) 06:38:42 INFO - ##### 06:38:42 INFO - Running post-run listener: _resource_record_post_run 06:38:42 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 506544128; Read time: 0; Write time: 496904 06:38:42 INFO - TinderboxPrint: CPU usage
13.5% 06:38:42 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 06:38:42 INFO - TinderboxPrint: I/O write bytes / time
506,544,128 / 496,904 06:38:42 INFO - TinderboxPrint: CPU idle
8,209.1 (86.5%) 06:38:42 INFO - TinderboxPrint: CPU user
1,220.3 (12.9%) 06:38:42 INFO - TinderboxPrint: Swap in / out
0 / 0 06:38:42 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 210636800; Read time: 0; Write time: 277688 06:38:42 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 247263232; Read time: 0; Write time: 202232 06:38:43 INFO - Running post-run listener: _upload_blobber_files 06:38:43 INFO - Blob upload gear active. 06:38:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:38:43 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:38:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:38:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:38:43 INFO - (blobuploader) - INFO - Open directory for files ... 06:38:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:38:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:38:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:39:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:39:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:39:01 INFO - (blobuploader) - INFO - Done attempting. 06:39:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:39:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:39:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:39:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:39:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:39:02 INFO - (blobuploader) - INFO - Done attempting. 06:39:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:39:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:39:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:39:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:39:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:39:03 INFO - (blobuploader) - INFO - Done attempting. 06:39:03 INFO - (blobuploader) - INFO - Iteration through files over. 06:39:03 INFO - Return code: 0 06:39:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:39:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:39:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ad1adcfec393b9f0e1d58c840fc1c19c499cd75d9967534623e62b5c2bee6d4ba49e7d4e8e4d279a149685db65dd58b1a68ce4eb8a9502592917b8a906ea2599", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3412c119587f7dbff1db919f0b5fbe6668c7bc5cfe8f2e4f11cb8790c6453e09f308122a5421ec0b0a2bb2ab66d780bc9dab70aad1de104171456d9af21e6120", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6036c814c61ceab84bd7e5c98972514118ef6ecafd6ee964f699d25622a2ccc578135b16d3a7a8e48c9208093fa3db117fbff2b5b4325de2b0069801d3ad63bc"} 06:39:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:39:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:39:03 INFO - Contents: 06:39:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ad1adcfec393b9f0e1d58c840fc1c19c499cd75d9967534623e62b5c2bee6d4ba49e7d4e8e4d279a149685db65dd58b1a68ce4eb8a9502592917b8a906ea2599", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3412c119587f7dbff1db919f0b5fbe6668c7bc5cfe8f2e4f11cb8790c6453e09f308122a5421ec0b0a2bb2ab66d780bc9dab70aad1de104171456d9af21e6120", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6036c814c61ceab84bd7e5c98972514118ef6ecafd6ee964f699d25622a2ccc578135b16d3a7a8e48c9208093fa3db117fbff2b5b4325de2b0069801d3ad63bc"} 06:39:03 INFO - Running post-run listener: copy_logs_to_upload_dir 06:39:03 INFO - Copying logs to upload dir... 06:39:03 INFO - mkdir: /builds/slave/test/build/upload/logs 06:39:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.105620 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-07-25 06:39:03.261108) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-25 06:39:03.266870) ========= 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=17051fcd5208b27b50bedfeb000001dd-1469450989.154253-292069661 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/ad1adcfec393b9f0e1d58c840fc1c19c499cd75d9967534623e62b5c2bee6d4ba49e7d4e8e4d279a149685db65dd58b1a68ce4eb8a9502592917b8a906ea2599", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3412c119587f7dbff1db919f0b5fbe6668c7bc5cfe8f2e4f11cb8790c6453e09f308122a5421ec0b0a2bb2ab66d780bc9dab70aad1de104171456d9af21e6120", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6036c814c61ceab84bd7e5c98972514118ef6ecafd6ee964f699d25622a2ccc578135b16d3a7a8e48c9208093fa3db117fbff2b5b4325de2b0069801d3ad63bc"} build_url:https://queue.taskcluster.net/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011264 build_url: 'https://queue.taskcluster.net/v1/task/FBJIZmzeRzWE48WjAir0jg/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/ad1adcfec393b9f0e1d58c840fc1c19c499cd75d9967534623e62b5c2bee6d4ba49e7d4e8e4d279a149685db65dd58b1a68ce4eb8a9502592917b8a906ea2599", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3412c119587f7dbff1db919f0b5fbe6668c7bc5cfe8f2e4f11cb8790c6453e09f308122a5421ec0b0a2bb2ab66d780bc9dab70aad1de104171456d9af21e6120", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6036c814c61ceab84bd7e5c98972514118ef6ecafd6ee964f699d25622a2ccc578135b16d3a7a8e48c9208093fa3db117fbff2b5b4325de2b0069801d3ad63bc"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-25 06:39:03.292148) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 06:39:03.292495) ========= 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=17051fcd5208b27b50bedfeb000001dd-1469450989.154253-292069661 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004480 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 06:39:03.376313) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-25 06:39:03.376798) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-25 06:39:03.377301) ========= ========= Total master_lag: 0.19 =========