builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-050 starttime: 1467069318.13 results: success (0) buildid: 20160627133055 builduid: 73b85cde579c488f8a1cac2d93dc8e42 revision: 87bbd3f58b4b153facdd1a2995105ae28cfbcd21 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 16:15:18.125443) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 16:15:18.125962) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 16:15:18.126284) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 16:15:18.159253) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 16:15:18.159557) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6dbc10da6d83fee962c624be000001a8-1467068234.13290-104159833 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 16:15:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-06-27 16:15:18 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.069247 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 16:15:18.271992) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 16:15:18.272342) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6dbc10da6d83fee962c624be000001a8-1467068234.13290-104159833 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017873 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 16:15:18.334020) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 16:15:18.334416) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 87bbd3f58b4b153facdd1a2995105ae28cfbcd21 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 87bbd3f58b4b153facdd1a2995105ae28cfbcd21 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6dbc10da6d83fee962c624be000001a8-1467068234.13290-104159833 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 16:15:18,501 truncating revision to first 12 chars 2016-06-27 16:15:18,502 Setting DEBUG logging. 2016-06-27 16:15:18,502 attempt 1/10 2016-06-27 16:15:18,502 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/87bbd3f58b4b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 16:15:18,841 unpacking tar archive at: mozilla-inbound-87bbd3f58b4b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.771364 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 16:15:19.123164) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 16:15:19.123667) ========= script_repo_revision: 87bbd3f58b4b153facdd1a2995105ae28cfbcd21 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 16:15:19.124099) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 16:15:19.124439) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 16:15:19.134802) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-06-27 16:15:19.135108) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6dbc10da6d83fee962c624be000001a8-1467068234.13290-104159833 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:15:19 INFO - MultiFileLogger online at 20160627 16:15:19 in /builds/slave/test 16:15:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 16:15:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:15:19 INFO - {'append_to_log': False, 16:15:19 INFO - 'base_work_dir': '/builds/slave/test', 16:15:19 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 16:15:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:15:19 INFO - 'branch': 'Mozilla-Inbound', 16:15:19 INFO - 'buildbot_json_path': 'buildprops.json', 16:15:19 INFO - 'config_files': ('talos/linux_config.py',), 16:15:19 INFO - 'default_actions': ('clobber', 16:15:19 INFO - 'read-buildbot-config', 16:15:19 INFO - 'download-and-extract', 16:15:19 INFO - 'populate-webroot', 16:15:19 INFO - 'create-virtualenv', 16:15:19 INFO - 'install', 16:15:19 INFO - 'run-tests'), 16:15:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:15:19 INFO - 'download_minidump_stackwalk': True, 16:15:19 INFO - 'download_symbols': 'ondemand', 16:15:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:15:19 INFO - 'tooltool.py': '/tools/tooltool.py', 16:15:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:15:19 INFO - '/tools/misc-python/virtualenv.py')}, 16:15:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:15:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:15:19 INFO - 'installer_path': 'installer.exe', 16:15:19 INFO - 'log_level': 'info', 16:15:19 INFO - 'log_name': 'talos', 16:15:19 INFO - 'log_to_console': True, 16:15:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:15:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:15:19 INFO - 'opt_config_files': (), 16:15:19 INFO - 'pip_index': False, 16:15:19 INFO - 'sps_profile': False, 16:15:19 INFO - 'sps_profile_interval': 0, 16:15:19 INFO - 'suite': 'dromaeojs', 16:15:19 INFO - 'system_bits': '32', 16:15:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:15:19 INFO - 'title': 'talos-linux64-ix-050', 16:15:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:15:19 INFO - 'use_talos_json': True, 16:15:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:15:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:15:19 INFO - 'work_dir': 'build'} 16:15:19 INFO - ##### 16:15:19 INFO - ##### Running clobber step. 16:15:19 INFO - ##### 16:15:19 INFO - Running pre-action listener: _resource_record_pre_action 16:15:19 INFO - Running main action method: clobber 16:15:19 INFO - rmtree: /builds/slave/test/build 16:15:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:15:19 INFO - Running post-action listener: _resource_record_post_action 16:15:19 INFO - ##### 16:15:19 INFO - ##### Finished clobber step (success) 16:15:19 INFO - ##### 16:15:19 INFO - ##### 16:15:19 INFO - ##### Running read-buildbot-config step. 16:15:19 INFO - ##### 16:15:19 INFO - Running pre-action listener: _resource_record_pre_action 16:15:19 INFO - Running main action method: read_buildbot_config 16:15:19 INFO - Using buildbot properties: 16:15:19 INFO - { 16:15:19 INFO - "project": "", 16:15:19 INFO - "product": "firefox", 16:15:19 INFO - "script_repo_revision": "production", 16:15:19 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 16:15:19 INFO - "repository": "", 16:15:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 16:15:19 INFO - "buildid": "20160627133055", 16:15:19 INFO - "pgo_build": "True", 16:15:19 INFO - "basedir": "/builds/slave/test", 16:15:19 INFO - "buildnumber": 1245, 16:15:19 INFO - "slavename": "talos-linux64-ix-050", 16:15:19 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:15:19 INFO - "platform": "ubuntu64_hw", 16:15:19 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 16:15:19 INFO - "branch": "mozilla-inbound", 16:15:19 INFO - "repo_path": "integration/mozilla-inbound", 16:15:19 INFO - "revision": "87bbd3f58b4b153facdd1a2995105ae28cfbcd21", 16:15:19 INFO - "stage_platform": "linux64-pgo", 16:15:19 INFO - "builduid": "73b85cde579c488f8a1cac2d93dc8e42", 16:15:19 INFO - "slavebuilddir": "test" 16:15:19 INFO - } 16:15:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/VNU6M3wTRaOcJMHYR8ouBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 16:15:19 INFO - Running post-action listener: _resource_record_post_action 16:15:19 INFO - ##### 16:15:19 INFO - ##### Finished read-buildbot-config step (success) 16:15:19 INFO - ##### 16:15:19 INFO - ##### 16:15:19 INFO - ##### Running download-and-extract step. 16:15:19 INFO - ##### 16:15:19 INFO - Running pre-action listener: _resource_record_pre_action 16:15:19 INFO - Running main action method: download_and_extract 16:15:19 INFO - mkdir: /builds/slave/test/build/tests 16:15:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:15:19 INFO - https://queue.taskcluster.net/v1/task/VNU6M3wTRaOcJMHYR8ouBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:15:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VNU6M3wTRaOcJMHYR8ouBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:15:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VNU6M3wTRaOcJMHYR8ouBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:15:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VNU6M3wTRaOcJMHYR8ouBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:15:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VNU6M3wTRaOcJMHYR8ouBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:15:26 INFO - Downloaded 1361 bytes. 16:15:26 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:15:26 INFO - Using the following test package requirements: 16:15:26 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:15:26 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:15:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:15:26 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:15:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:15:26 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:15:26 INFO - u'jsshell-linux-x86_64.zip'], 16:15:26 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:15:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:15:26 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:15:26 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:15:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:15:26 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:15:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:15:26 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:15:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:15:26 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:15:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:15:26 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:15:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 16:15:26 INFO - https://queue.taskcluster.net/v1/task/VNU6M3wTRaOcJMHYR8ouBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:15:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VNU6M3wTRaOcJMHYR8ouBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:15:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VNU6M3wTRaOcJMHYR8ouBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:15:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VNU6M3wTRaOcJMHYR8ouBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:15:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VNU6M3wTRaOcJMHYR8ouBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:15:28 INFO - Downloaded 24280496 bytes. 16:15:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:15:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:15:29 INFO - Return code: 0 16:15:29 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:15:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:15:29 INFO - https://queue.taskcluster.net/v1/task/VNU6M3wTRaOcJMHYR8ouBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:15:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VNU6M3wTRaOcJMHYR8ouBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:15:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VNU6M3wTRaOcJMHYR8ouBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:15:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VNU6M3wTRaOcJMHYR8ouBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:15:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VNU6M3wTRaOcJMHYR8ouBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:15:31 INFO - Downloaded 24280496 bytes. 16:15:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:15:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:15:32 INFO - Return code: 0 16:15:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:15:32 INFO - https://queue.taskcluster.net/v1/task/VNU6M3wTRaOcJMHYR8ouBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:15:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VNU6M3wTRaOcJMHYR8ouBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:15:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VNU6M3wTRaOcJMHYR8ouBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:15:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VNU6M3wTRaOcJMHYR8ouBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:15:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VNU6M3wTRaOcJMHYR8ouBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:15:33 INFO - Downloaded 14405240 bytes. 16:15:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:15:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 16:15:33 INFO - Return code: 0 16:15:33 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')]} 16:15:33 INFO - https://queue.taskcluster.net/v1/task/VNU6M3wTRaOcJMHYR8ouBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:15:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VNU6M3wTRaOcJMHYR8ouBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:15:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VNU6M3wTRaOcJMHYR8ouBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:15:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VNU6M3wTRaOcJMHYR8ouBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:15:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VNU6M3wTRaOcJMHYR8ouBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:15:35 INFO - Downloaded 60322323 bytes. 16:15:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VNU6M3wTRaOcJMHYR8ouBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:15:35 INFO - mkdir: /builds/slave/test/properties 16:15:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:15:35 INFO - Writing to file /builds/slave/test/properties/build_url 16:15:35 INFO - Contents: 16:15:35 INFO - build_url:https://queue.taskcluster.net/v1/task/VNU6M3wTRaOcJMHYR8ouBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:15:36 INFO - Running post-action listener: _resource_record_post_action 16:15:36 INFO - Running post-action listener: set_extra_try_arguments 16:15:36 INFO - ##### 16:15:36 INFO - ##### Finished download-and-extract step (success) 16:15:36 INFO - ##### 16:15:36 INFO - ##### 16:15:36 INFO - ##### Running populate-webroot step. 16:15:36 INFO - ##### 16:15:36 INFO - Running pre-action listener: _resource_record_pre_action 16:15:36 INFO - Running main action method: populate_webroot 16:15:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:15:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:15:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:15:36 INFO - '--tppagecycles', 16:15:36 INFO - '7'], 16:15:36 INFO - 'tests': ['tsvgm']}}, 16:15:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:15:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:15:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:15:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:15:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:15:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:15:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:15:36 INFO - 'talos_options': ['--disable-e10s'], 16:15:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:15:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:15:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:15:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:15:36 INFO - 'talos_options': ['--disable-e10s'], 16:15:36 INFO - 'tests': ['damp', 'tps']}, 16:15:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:15:36 INFO - 'tests': ['damp', 'tps']}, 16:15:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:15:36 INFO - 'tests': ['dromaeo_dom']}, 16:15:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:15:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:15:36 INFO - 'tests': ['basic_compositor_video']}, 16:15:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:15:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:15:36 INFO - 'tests': ['a11yr', 16:15:36 INFO - 'ts_paint', 16:15:36 INFO - 'tpaint', 16:15:36 INFO - 'sessionrestore', 16:15:36 INFO - 'sessionrestore_no_auto_restore', 16:15:36 INFO - 'tabpaint']}, 16:15:36 INFO - 'other-e10s': {'tests': ['a11yr', 16:15:36 INFO - 'ts_paint', 16:15:36 INFO - 'tpaint', 16:15:36 INFO - 'sessionrestore', 16:15:36 INFO - 'sessionrestore_no_auto_restore', 16:15:36 INFO - 'tabpaint']}, 16:15:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:15:36 INFO - 'ts_paint', 16:15:36 INFO - 'tpaint', 16:15:36 INFO - 'sessionrestore', 16:15:36 INFO - 'sessionrestore_no_auto_restore', 16:15:36 INFO - 'tabpaint']}, 16:15:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:15:36 INFO - 'ts_paint', 16:15:36 INFO - 'tpaint', 16:15:36 INFO - 'sessionrestore', 16:15:36 INFO - 'sessionrestore_no_auto_restore', 16:15:36 INFO - 'tabpaint']}, 16:15:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:15:36 INFO - 'tests': ['a11yr', 16:15:36 INFO - 'ts_paint', 16:15:36 INFO - 'tpaint', 16:15:36 INFO - 'sessionrestore', 16:15:36 INFO - 'sessionrestore_no_auto_restore', 16:15:36 INFO - 'tabpaint']}, 16:15:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:15:36 INFO - 'tests': ['a11yr', 16:15:36 INFO - 'ts_paint', 16:15:36 INFO - 'tpaint', 16:15:36 INFO - 'sessionrestore', 16:15:36 INFO - 'sessionrestore_no_auto_restore', 16:15:36 INFO - 'tabpaint']}, 16:15:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:15:36 INFO - 'tests': ['tsvgx', 16:15:36 INFO - 'tsvgr_opacity', 16:15:36 INFO - 'tart', 16:15:36 INFO - 'tscrollx', 16:15:36 INFO - 'cart']}, 16:15:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:15:36 INFO - 'tsvgr_opacity', 16:15:36 INFO - 'tart', 16:15:36 INFO - 'tscrollx', 16:15:36 INFO - 'cart']}, 16:15:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:15:36 INFO - 'talos_options': ['--disable-e10s'], 16:15:36 INFO - 'tests': ['tp5o']}, 16:15:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:15:36 INFO - 'tests': ['tp5o']}, 16:15:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:15:36 INFO - 'talos_options': ['--disable-e10s', 16:15:36 INFO - '--xperf_path', 16:15:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:15:36 INFO - 'tests': ['tp5n']}, 16:15:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:15:36 INFO - 'talos_options': ['--xperf_path', 16:15:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:15:36 INFO - 'tests': ['tp5n']}}, 16:15:36 INFO - 'talos.zip': {'path': '', 16:15:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:15:36 INFO - Running post-action listener: _resource_record_post_action 16:15:36 INFO - ##### 16:15:36 INFO - ##### Finished populate-webroot step (success) 16:15:36 INFO - ##### 16:15:36 INFO - ##### 16:15:36 INFO - ##### Running create-virtualenv step. 16:15:36 INFO - ##### 16:15:36 INFO - Running pre-action listener: _resource_record_pre_action 16:15:36 INFO - Running main action method: create_virtualenv 16:15:36 INFO - Creating virtualenv /builds/slave/test/build/venv 16:15:36 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 16:15:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:15:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:15:36 INFO - Using real prefix '/usr' 16:15:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:15:37 INFO - Installing distribute.............................................................................................................................................................................................done. 16:15:39 INFO - Installing pip.................done. 16:15:39 INFO - Return code: 0 16:15:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:15: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')]} 16:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15: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')]} 16:15:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7b16e63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f7a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252f980>, '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 0x2578a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2578f10>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467068234.13290-104159833', '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 16:15: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', 'pip>=1.5'] in /builds/slave/test/build 16:15: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 pip>=1.5 16:15:39 INFO - Using env: {'DISPLAY': ':0', 16:15:39 INFO - 'HOME': '/home/cltbld', 16:15:39 INFO - 'LANG': 'en_US.UTF-8', 16:15:39 INFO - 'LANGUAGE': 'en_US:en', 16:15:39 INFO - 'LOGNAME': 'cltbld', 16:15:39 INFO - 'MAIL': '/var/mail/cltbld', 16:15:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:39 INFO - 'MOZ_NO_REMOTE': '1', 16:15:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:39 INFO - 'NO_EM_RESTART': '1', 16:15:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:39 INFO - 'PWD': '/builds/slave/test', 16:15:39 INFO - 'SHELL': '/bin/bash', 16:15:39 INFO - 'SHLVL': '1', 16:15:39 INFO - 'TERM': 'linux', 16:15:39 INFO - 'TMOUT': '86400', 16:15:39 INFO - 'USER': 'cltbld', 16:15:39 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467068234.13290-104159833', 16:15:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:39 INFO - '_': '/tools/buildbot/bin/python'} 16:15:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:39 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 16:15:39 INFO - Cleaning up... 16:15:39 INFO - Return code: 0 16:15:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:15: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')]} 16:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15: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')]} 16:15:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15: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', '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 0x7f7b16e63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f7a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252f980>, '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 0x2578a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2578f10>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467068234.13290-104159833', '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 16:15: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', 'psutil>=3.1.1'] in /builds/slave/test/build 16:15: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 psutil>=3.1.1 16:15:39 INFO - Using env: {'DISPLAY': ':0', 16:15:39 INFO - 'HOME': '/home/cltbld', 16:15:39 INFO - 'LANG': 'en_US.UTF-8', 16:15:39 INFO - 'LANGUAGE': 'en_US:en', 16:15:39 INFO - 'LOGNAME': 'cltbld', 16:15:39 INFO - 'MAIL': '/var/mail/cltbld', 16:15:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:39 INFO - 'MOZ_NO_REMOTE': '1', 16:15:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:39 INFO - 'NO_EM_RESTART': '1', 16:15:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:39 INFO - 'PWD': '/builds/slave/test', 16:15:39 INFO - 'SHELL': '/bin/bash', 16:15:39 INFO - 'SHLVL': '1', 16:15:39 INFO - 'TERM': 'linux', 16:15:39 INFO - 'TMOUT': '86400', 16:15:39 INFO - 'USER': 'cltbld', 16:15:39 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467068234.13290-104159833', 16:15:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:39 INFO - '_': '/tools/buildbot/bin/python'} 16:15:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:39 INFO - Downloading/unpacking psutil>=3.1.1 16:15: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 16:15: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 16:15: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 16:15: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 16:15: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 16:15: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 16:15:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:15:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:15:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:15:41 INFO - Installing collected packages: psutil 16:15:41 INFO - Running setup.py install for psutil 16:15:41 INFO - building 'psutil._psutil_linux' extension 16:15:41 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 16:15:41 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 16:15:41 INFO - building 'psutil._psutil_posix' extension 16:15:41 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 16:15:41 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 16:15:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:15:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:15:41 INFO - Successfully installed psutil 16:15:41 INFO - Cleaning up... 16:15:42 INFO - Return code: 0 16:15:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:15: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')]} 16:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15: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')]} 16:15:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:42 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 0x7f7b16e63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f7a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252f980>, '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 0x2578a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2578f10>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467068234.13290-104159833', '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 16:15:42 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 16:15:42 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 16:15:42 INFO - Using env: {'DISPLAY': ':0', 16:15:42 INFO - 'HOME': '/home/cltbld', 16:15:42 INFO - 'LANG': 'en_US.UTF-8', 16:15:42 INFO - 'LANGUAGE': 'en_US:en', 16:15:42 INFO - 'LOGNAME': 'cltbld', 16:15:42 INFO - 'MAIL': '/var/mail/cltbld', 16:15:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:42 INFO - 'MOZ_NO_REMOTE': '1', 16:15:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:42 INFO - 'NO_EM_RESTART': '1', 16:15:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:42 INFO - 'PWD': '/builds/slave/test', 16:15:42 INFO - 'SHELL': '/bin/bash', 16:15:42 INFO - 'SHLVL': '1', 16:15:42 INFO - 'TERM': 'linux', 16:15:42 INFO - 'TMOUT': '86400', 16:15:42 INFO - 'USER': 'cltbld', 16:15:42 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467068234.13290-104159833', 16:15:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:42 INFO - '_': '/tools/buildbot/bin/python'} 16:15:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:15:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:15:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:15:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:15:44 INFO - Installing collected packages: mozsystemmonitor 16:15:44 INFO - Running setup.py install for mozsystemmonitor 16:15:44 INFO - Successfully installed mozsystemmonitor 16:15:44 INFO - Cleaning up... 16:15:44 INFO - Return code: 0 16:15:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:15:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:15:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:44 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 0x7f7b16e63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f7a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252f980>, '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 0x2578a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2578f10>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467068234.13290-104159833', '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 16:15:44 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 16:15:44 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 16:15:44 INFO - Using env: {'DISPLAY': ':0', 16:15:44 INFO - 'HOME': '/home/cltbld', 16:15:44 INFO - 'LANG': 'en_US.UTF-8', 16:15:44 INFO - 'LANGUAGE': 'en_US:en', 16:15:44 INFO - 'LOGNAME': 'cltbld', 16:15:44 INFO - 'MAIL': '/var/mail/cltbld', 16:15:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:44 INFO - 'MOZ_NO_REMOTE': '1', 16:15:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:44 INFO - 'NO_EM_RESTART': '1', 16:15:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:44 INFO - 'PWD': '/builds/slave/test', 16:15:44 INFO - 'SHELL': '/bin/bash', 16:15:44 INFO - 'SHLVL': '1', 16:15:44 INFO - 'TERM': 'linux', 16:15:44 INFO - 'TMOUT': '86400', 16:15:44 INFO - 'USER': 'cltbld', 16:15:44 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467068234.13290-104159833', 16:15:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:44 INFO - '_': '/tools/buildbot/bin/python'} 16:15:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:44 INFO - Downloading/unpacking jsonschema==2.5.1 16:15:44 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 16:15:44 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 16:15:44 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 16:15:44 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 16:15:44 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 16:15:44 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 16:15:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:15:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:15:46 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 16:15:46 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 16:15:46 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 16:15:46 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 16:15:46 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 16:15:46 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 16:15:46 INFO - Downloading functools32-3.2.3-2.tar.gz 16:15:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:15:46 INFO - warning: no files found matching '*.txt' 16:15:46 INFO - no previously-included directories found matching 'build' 16:15:46 INFO - no previously-included directories found matching 'dist' 16:15:46 INFO - no previously-included directories found matching '.git*' 16:15:46 INFO - Installing collected packages: jsonschema, functools32 16:15:46 INFO - Running setup.py install for functools32 16:15:46 INFO - warning: no files found matching '*.txt' 16:15:46 INFO - no previously-included directories found matching 'build' 16:15:46 INFO - no previously-included directories found matching 'dist' 16:15:46 INFO - no previously-included directories found matching '.git*' 16:15:46 INFO - Successfully installed jsonschema functools32 16:15:46 INFO - Cleaning up... 16:15:46 INFO - Return code: 0 16:15:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:15:46 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')]} 16:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:46 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')]} 16:15:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:46 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 0x7f7b16e63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f7a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252f980>, '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 0x2578a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2578f10>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467068234.13290-104159833', '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 16:15:46 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 16:15:46 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 16:15:46 INFO - Using env: {'DISPLAY': ':0', 16:15:46 INFO - 'HOME': '/home/cltbld', 16:15:46 INFO - 'LANG': 'en_US.UTF-8', 16:15:46 INFO - 'LANGUAGE': 'en_US:en', 16:15:46 INFO - 'LOGNAME': 'cltbld', 16:15:46 INFO - 'MAIL': '/var/mail/cltbld', 16:15:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:46 INFO - 'MOZ_NO_REMOTE': '1', 16:15:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:46 INFO - 'NO_EM_RESTART': '1', 16:15:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:46 INFO - 'PWD': '/builds/slave/test', 16:15:46 INFO - 'SHELL': '/bin/bash', 16:15:46 INFO - 'SHLVL': '1', 16:15:46 INFO - 'TERM': 'linux', 16:15:46 INFO - 'TMOUT': '86400', 16:15:46 INFO - 'USER': 'cltbld', 16:15:46 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467068234.13290-104159833', 16:15:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:46 INFO - '_': '/tools/buildbot/bin/python'} 16:15:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:47 INFO - Downloading/unpacking blobuploader==1.2.4 16:15: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 16:15: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 16:15: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 16:15: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 16:15: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 16:15: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 16:15:49 INFO - Downloading blobuploader-1.2.4.tar.gz 16:15:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:15:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:15:49 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 16:15:49 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 16:15:49 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 16:15:49 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 16:15:49 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 16:15:49 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 16:15:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:15:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:15:49 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 16:15:49 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 16:15:49 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 16:15:49 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 16:15:49 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 16:15:49 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 16:15:49 INFO - Downloading docopt-0.6.1.tar.gz 16:15:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:15:49 INFO - Installing collected packages: blobuploader, requests, docopt 16:15:49 INFO - Running setup.py install for blobuploader 16:15:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:15:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:15:49 INFO - Running setup.py install for requests 16:15:50 INFO - Running setup.py install for docopt 16:15:50 INFO - Successfully installed blobuploader requests docopt 16:15:50 INFO - Cleaning up... 16:15:50 INFO - Return code: 0 16:15:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:15: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')]} 16:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15: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')]} 16:15:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:50 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 0x7f7b16e63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f7a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252f980>, '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 0x2578a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2578f10>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467068234.13290-104159833', '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 16:15:50 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 16:15:50 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 16:15:50 INFO - Using env: {'DISPLAY': ':0', 16:15:50 INFO - 'HOME': '/home/cltbld', 16:15:50 INFO - 'LANG': 'en_US.UTF-8', 16:15:50 INFO - 'LANGUAGE': 'en_US:en', 16:15:50 INFO - 'LOGNAME': 'cltbld', 16:15:50 INFO - 'MAIL': '/var/mail/cltbld', 16:15:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:50 INFO - 'MOZ_NO_REMOTE': '1', 16:15:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:50 INFO - 'NO_EM_RESTART': '1', 16:15:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:50 INFO - 'PWD': '/builds/slave/test', 16:15:50 INFO - 'SHELL': '/bin/bash', 16:15:50 INFO - 'SHLVL': '1', 16:15:50 INFO - 'TERM': 'linux', 16:15:50 INFO - 'TMOUT': '86400', 16:15:50 INFO - 'USER': 'cltbld', 16:15:50 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467068234.13290-104159833', 16:15:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:50 INFO - '_': '/tools/buildbot/bin/python'} 16:15:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:15:50 INFO - Running setup.py (path:/tmp/pip-paGoam-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:15:50 INFO - Running setup.py (path:/tmp/pip-iYipUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:15:50 INFO - Running setup.py (path:/tmp/pip-tKVwqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:15:50 INFO - Running setup.py (path:/tmp/pip-elFW7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:15:50 INFO - Running setup.py (path:/tmp/pip-2MRYrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:15:50 INFO - Running setup.py (path:/tmp/pip-t0YrOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:15:51 INFO - Running setup.py (path:/tmp/pip-XuVd2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:15:51 INFO - Running setup.py (path:/tmp/pip-GplX8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:15:51 INFO - Running setup.py (path:/tmp/pip-XSC2sb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:15:51 INFO - Running setup.py (path:/tmp/pip-Ucrt__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:15:51 INFO - Running setup.py (path:/tmp/pip-GjUrXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:15:51 INFO - Running setup.py (path:/tmp/pip-ncosf3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:15:51 INFO - Running setup.py (path:/tmp/pip-DahvqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:15:51 INFO - Running setup.py (path:/tmp/pip-lkbLfF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:15:51 INFO - Running setup.py (path:/tmp/pip-AuUFnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:15:51 INFO - Running setup.py (path:/tmp/pip-eJa9Ab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:15:51 INFO - Running setup.py (path:/tmp/pip-SaqcPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:15:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:15:51 INFO - Running setup.py install for manifestparser 16:15:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:15:51 INFO - Running setup.py install for mozcrash 16:15:52 INFO - Running setup.py install for mozdebug 16:15:52 INFO - Running setup.py install for mozdevice 16:15:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:15:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:15:52 INFO - Running setup.py install for mozfile 16:15:52 INFO - Running setup.py install for mozhttpd 16:15:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:15:52 INFO - Running setup.py install for mozinfo 16:15:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:15:52 INFO - Running setup.py install for mozInstall 16:15:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:15:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:15:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:15:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:15:52 INFO - Running setup.py install for mozleak 16:15:52 INFO - Running setup.py install for mozlog 16:15:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:15:52 INFO - Running setup.py install for moznetwork 16:15:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:15:52 INFO - Running setup.py install for mozprocess 16:15:53 INFO - Running setup.py install for mozprofile 16:15:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:15:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:15:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:15:53 INFO - Running setup.py install for mozrunner 16:15:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:15:53 INFO - Running setup.py install for mozscreenshot 16:15:53 INFO - Running setup.py install for moztest 16:15:53 INFO - Running setup.py install for mozversion 16:15:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:15:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:15:53 INFO - Cleaning up... 16:15:53 INFO - Return code: 0 16:15:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:15:53 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')]} 16:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:53 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')]} 16:15:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:53 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 0x7f7b16e63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f7a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252f980>, '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 0x2578a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2578f10>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467068234.13290-104159833', '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 16:15:53 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 16:15:53 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 16:15:53 INFO - Using env: {'DISPLAY': ':0', 16:15:53 INFO - 'HOME': '/home/cltbld', 16:15:53 INFO - 'LANG': 'en_US.UTF-8', 16:15:53 INFO - 'LANGUAGE': 'en_US:en', 16:15:53 INFO - 'LOGNAME': 'cltbld', 16:15:53 INFO - 'MAIL': '/var/mail/cltbld', 16:15:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:53 INFO - 'MOZ_NO_REMOTE': '1', 16:15:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:53 INFO - 'NO_EM_RESTART': '1', 16:15:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:53 INFO - 'PWD': '/builds/slave/test', 16:15:53 INFO - 'SHELL': '/bin/bash', 16:15:53 INFO - 'SHLVL': '1', 16:15:53 INFO - 'TERM': 'linux', 16:15:53 INFO - 'TMOUT': '86400', 16:15:53 INFO - 'USER': 'cltbld', 16:15:53 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467068234.13290-104159833', 16:15:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:53 INFO - '_': '/tools/buildbot/bin/python'} 16:15:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:15:53 INFO - Running setup.py (path:/tmp/pip-_eYI54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:15:53 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)) 16:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:15:53 INFO - Running setup.py (path:/tmp/pip-v0e8CT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:15:53 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)) 16:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:15:53 INFO - Running setup.py (path:/tmp/pip-umuRv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:15:54 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)) 16:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:15:54 INFO - Running setup.py (path:/tmp/pip-VebzQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:15:54 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)) 16:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:15:54 INFO - Running setup.py (path:/tmp/pip-m4VCZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:15:54 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)) 16:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:15:54 INFO - Running setup.py (path:/tmp/pip-Etlcxx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:15:54 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)) 16:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:15:54 INFO - Running setup.py (path:/tmp/pip-yr66HE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:15:54 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)) 16:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:15:54 INFO - Running setup.py (path:/tmp/pip-AZh6fQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:15:54 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)) 16:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:15:54 INFO - Running setup.py (path:/tmp/pip-dybQOP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:15:54 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)) 16:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:15:54 INFO - Running setup.py (path:/tmp/pip-8QJIg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:15:54 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)) 16:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:15:54 INFO - Running setup.py (path:/tmp/pip-Rg5Q_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:15:54 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)) 16:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:15:54 INFO - Running setup.py (path:/tmp/pip-nXnrO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:15:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:15:54 INFO - Running setup.py (path:/tmp/pip-N5IcPH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:15:54 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)) 16:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:15:54 INFO - Running setup.py (path:/tmp/pip-MHMqYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:15:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:15:54 INFO - Running setup.py (path:/tmp/pip-AcHx2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:15:54 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)) 16:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:15:54 INFO - Running setup.py (path:/tmp/pip-KWpiNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:15:54 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)) 16:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:15:54 INFO - Running setup.py (path:/tmp/pip-f3emIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:15:55 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)) 16:15:55 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)) 16:15:55 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)) 16:15:55 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)) 16:15:55 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)) 16:15:55 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)) 16:15:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:15:55 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 16:15:55 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 16:15:55 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 16:15:55 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 16:15:55 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 16:15:55 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 16:15:56 INFO - Downloading blessings-1.6.tar.gz 16:15:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:15:57 INFO - Installing collected packages: blessings 16:15:57 INFO - Running setup.py install for blessings 16:15:57 INFO - Successfully installed blessings 16:15:57 INFO - Cleaning up... 16:15:57 INFO - Return code: 0 16:15:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:15:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:15:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:15:57 INFO - Reading from file tmpfile_stdout 16:15:57 INFO - Current package versions: 16:15:57 INFO - argparse == 1.2.1 16:15:57 INFO - blessings == 1.6 16:15:57 INFO - blobuploader == 1.2.4 16:15:57 INFO - docopt == 0.6.1 16:15:57 INFO - functools32 == 3.2.3-2 16:15:57 INFO - jsonschema == 2.5.1 16:15:57 INFO - manifestparser == 1.1 16:15:57 INFO - mozInstall == 1.12 16:15:57 INFO - mozcrash == 0.17 16:15:57 INFO - mozdebug == 0.1 16:15:57 INFO - mozdevice == 0.48 16:15:57 INFO - mozfile == 1.2 16:15:57 INFO - mozhttpd == 0.7 16:15:57 INFO - mozinfo == 0.9 16:15:57 INFO - mozleak == 0.1 16:15:57 INFO - mozlog == 3.2 16:15:57 INFO - moznetwork == 0.27 16:15:57 INFO - mozprocess == 0.22 16:15:57 INFO - mozprofile == 0.28 16:15:57 INFO - mozrunner == 6.11 16:15:57 INFO - mozscreenshot == 0.1 16:15:57 INFO - mozsystemmonitor == 0.3 16:15:57 INFO - moztest == 0.7 16:15:57 INFO - mozversion == 1.4 16:15:57 INFO - psutil == 3.1.1 16:15:57 INFO - requests == 1.2.3 16:15:57 INFO - wsgiref == 0.1.2 16:15:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:15:57 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')]} 16:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:57 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')]} 16:15:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:57 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 0x7f7b16e63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f7a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252f980>, '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 0x2578a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2578f10>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467068234.13290-104159833', '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 16:15:57 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 16:15:57 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 16:15:57 INFO - Using env: {'DISPLAY': ':0', 16:15:57 INFO - 'HOME': '/home/cltbld', 16:15:57 INFO - 'LANG': 'en_US.UTF-8', 16:15:57 INFO - 'LANGUAGE': 'en_US:en', 16:15:57 INFO - 'LOGNAME': 'cltbld', 16:15:57 INFO - 'MAIL': '/var/mail/cltbld', 16:15:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:57 INFO - 'MOZ_NO_REMOTE': '1', 16:15:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:57 INFO - 'NO_EM_RESTART': '1', 16:15:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:57 INFO - 'PWD': '/builds/slave/test', 16:15:57 INFO - 'SHELL': '/bin/bash', 16:15:57 INFO - 'SHLVL': '1', 16:15:57 INFO - 'TERM': 'linux', 16:15:57 INFO - 'TMOUT': '86400', 16:15:57 INFO - 'USER': 'cltbld', 16:15:57 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467068234.13290-104159833', 16:15:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:57 INFO - '_': '/tools/buildbot/bin/python'} 16:15:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:57 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)) 16:15:57 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)) 16:15:57 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)) 16:15:57 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)) 16:15:57 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)) 16:15:57 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)) 16:15:57 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)) 16:15:57 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)) 16:15:57 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)) 16:15:57 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)) 16:15:57 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)) 16:15:57 INFO - Cleaning up... 16:15:57 INFO - Return code: 0 16:15:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:15:57 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')]} 16:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:57 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')]} 16:15:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:57 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 0x7f7b16e63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f7a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252f980>, '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 0x2578a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2578f10>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467068234.13290-104159833', '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 16:15:57 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 16:15:57 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 16:15:57 INFO - Using env: {'DISPLAY': ':0', 16:15:57 INFO - 'HOME': '/home/cltbld', 16:15:57 INFO - 'LANG': 'en_US.UTF-8', 16:15:57 INFO - 'LANGUAGE': 'en_US:en', 16:15:57 INFO - 'LOGNAME': 'cltbld', 16:15:57 INFO - 'MAIL': '/var/mail/cltbld', 16:15:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:57 INFO - 'MOZ_NO_REMOTE': '1', 16:15:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:57 INFO - 'NO_EM_RESTART': '1', 16:15:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:57 INFO - 'PWD': '/builds/slave/test', 16:15:57 INFO - 'SHELL': '/bin/bash', 16:15:57 INFO - 'SHLVL': '1', 16:15:57 INFO - 'TERM': 'linux', 16:15:57 INFO - 'TMOUT': '86400', 16:15:57 INFO - 'USER': 'cltbld', 16:15:57 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467068234.13290-104159833', 16:15:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:57 INFO - '_': '/tools/buildbot/bin/python'} 16:15:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:15:57 INFO - Cleaning up... 16:15:57 INFO - Return code: 0 16:15:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:15:57 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')]} 16:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:57 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')]} 16:15:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:57 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 0x7f7b16e63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f7a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252f980>, '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 0x2578a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2578f10>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467068234.13290-104159833', '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 16:15:57 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 16:15:57 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 16:15:57 INFO - Using env: {'DISPLAY': ':0', 16:15:57 INFO - 'HOME': '/home/cltbld', 16:15:57 INFO - 'LANG': 'en_US.UTF-8', 16:15:57 INFO - 'LANGUAGE': 'en_US:en', 16:15:57 INFO - 'LOGNAME': 'cltbld', 16:15:57 INFO - 'MAIL': '/var/mail/cltbld', 16:15:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:57 INFO - 'MOZ_NO_REMOTE': '1', 16:15:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:57 INFO - 'NO_EM_RESTART': '1', 16:15:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:57 INFO - 'PWD': '/builds/slave/test', 16:15:57 INFO - 'SHELL': '/bin/bash', 16:15:57 INFO - 'SHLVL': '1', 16:15:57 INFO - 'TERM': 'linux', 16:15:57 INFO - 'TMOUT': '86400', 16:15:57 INFO - 'USER': 'cltbld', 16:15:57 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467068234.13290-104159833', 16:15:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:57 INFO - '_': '/tools/buildbot/bin/python'} 16:15:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:58 INFO - Downloading/unpacking flake8 16:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:15:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:15:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:15:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:16:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:16:00 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 16:16:00 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 16:16:00 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 16:16:00 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 16:16:00 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 16:16:00 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 16:16:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:16:00 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 16:16:00 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 16:16:00 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 16:16:00 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 16:16:00 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 16:16:00 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 16:16:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:16:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:16:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:16:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:16:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:16:00 INFO - no previously-included directories found matching 'docs/_build' 16:16:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:16:00 INFO - Running setup.py install for pep8 16:16:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:16:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:16:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:16:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:16:00 INFO - no previously-included directories found matching 'docs/_build' 16:16:00 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:16:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:16:00 INFO - Cleaning up... 16:16:00 INFO - Return code: 0 16:16:00 INFO - Running post-action listener: _resource_record_post_action 16:16:00 INFO - Running post-action listener: _start_resource_monitoring 16:16:00 INFO - Starting resource monitoring. 16:16:00 INFO - ##### 16:16:00 INFO - ##### Finished create-virtualenv step (success) 16:16:00 INFO - ##### 16:16:00 INFO - ##### 16:16:00 INFO - ##### Running install step. 16:16:00 INFO - ##### 16:16:00 INFO - Running pre-action listener: _resource_record_pre_action 16:16:00 INFO - Running main action method: install 16:16:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:16:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:16:01 INFO - Reading from file tmpfile_stdout 16:16:01 INFO - Detecting whether we're running mozinstall >=1.0... 16:16:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:16:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:16:01 INFO - Reading from file tmpfile_stdout 16:16:01 INFO - Output received: 16:16:01 INFO - Usage: mozinstall [options] installer 16:16:01 INFO - Options: 16:16:01 INFO - -h, --help show this help message and exit 16:16:01 INFO - -d DEST, --destination=DEST 16:16:01 INFO - Directory to install application into. [default: 16:16:01 INFO - "/builds/slave/test"] 16:16:01 INFO - --app=APP Application being installed. [default: firefox] 16:16:01 INFO - mkdir: /builds/slave/test/build/application 16:16:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:16:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:16:18 INFO - Reading from file tmpfile_stdout 16:16:18 INFO - Output received: 16:16:18 INFO - /builds/slave/test/build/application/firefox/firefox 16:16:18 INFO - Running post-action listener: _resource_record_post_action 16:16:18 INFO - ##### 16:16:18 INFO - ##### Finished install step (success) 16:16:18 INFO - ##### 16:16:18 INFO - ##### 16:16:18 INFO - ##### Running run-tests step. 16:16:18 INFO - ##### 16:16:18 INFO - Running pre-action listener: _resource_record_pre_action 16:16:18 INFO - Running main action method: run_tests 16:16:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:16:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:16:18 INFO - Python 2.7.3 16:16:18 INFO - Return code: 0 16:16:18 INFO - grabbing minidump binary from tooltool 16:16:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:18 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 0x252f980>, '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 0x2578a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2578f10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:16:18 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 16:16:18 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 16:16:18 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 16:16:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:16:18 INFO - Return code: 0 16:16:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:16:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:16:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:16:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:16:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:16:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:16:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:16:19 INFO - Return code: 0 16:16:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VNU6M3wTRaOcJMHYR8ouBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 16:16:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VNU6M3wTRaOcJMHYR8ouBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 16:16:19 INFO - Using env: {'DISPLAY': ':0', 16:16:19 INFO - 'HOME': '/home/cltbld', 16:16:19 INFO - 'LANG': 'en_US.UTF-8', 16:16:19 INFO - 'LANGUAGE': 'en_US:en', 16:16:19 INFO - 'LOGNAME': 'cltbld', 16:16:19 INFO - 'MAIL': '/var/mail/cltbld', 16:16:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:16:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:16:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:19 INFO - 'MOZ_NO_REMOTE': '1', 16:16:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:16:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:16:19 INFO - 'NO_EM_RESTART': '1', 16:16:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:16:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:19 INFO - 'PWD': '/builds/slave/test', 16:16:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:16:19 INFO - 'SHELL': '/bin/bash', 16:16:19 INFO - 'SHLVL': '1', 16:16:19 INFO - 'TERM': 'linux', 16:16:19 INFO - 'TMOUT': '86400', 16:16:19 INFO - 'USER': 'cltbld', 16:16:19 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467068234.13290-104159833', 16:16:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:19 INFO - '_': '/tools/buildbot/bin/python'} 16:16:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VNU6M3wTRaOcJMHYR8ouBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:16:19 INFO - mozversion application_buildid: 20160627133055 16:16:19 INFO - mozversion application_changeset: 87bbd3f58b4b153facdd1a2995105ae28cfbcd21 16:16:19 INFO - mozversion application_display_name: Nightly 16:16:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:16:19 INFO - mozversion application_name: Firefox 16:16:19 INFO - mozversion application_remotingname: firefox 16:16:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:16:19 INFO - mozversion application_vendor: Mozilla 16:16:19 INFO - mozversion application_version: 50.0a1 16:16:19 INFO - mozversion platform_buildid: 20160627133055 16:16:19 INFO - mozversion platform_changeset: 87bbd3f58b4b153facdd1a2995105ae28cfbcd21 16:16:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:16:19 INFO - mozversion platform_version: 50.0a1 16:16:19 INFO - using testdate: 1467069379 16:16:19 INFO - actual date: 1467069379 16:16:19 INFO - starting webserver on 'localhost:40060' 16:16:19 INFO - SUITE-START | Running 2 tests 16:16:19 INFO - TEST-START | dromaeo_css 16:16:19 INFO - operating with platform_type : linux_ 16:16:19 INFO - Initialising browser for dromaeo_css test... 16:16:19 INFO - TEST-INFO | started process 19581 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOijSda/profile http://localhost:40060/getInfo.html) 16:16:23 INFO - PROCESS | 19581 | __metrics Screen width/height:1600/1200 16:16:23 INFO - PROCESS | 19581 | colorDepth:24 16:16:23 INFO - PROCESS | 19581 | Browser inner width/height: 1024/697 16:16:23 INFO - PROCESS | 19581 | __metrics 16:16:24 INFO - PROCESS | 19581 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:16:25 INFO - TEST-INFO | 19581: exit 0 16:16:25 INFO - Browser initialized. 16:16:25 INFO - Running cycle 1/1 for dromaeo_css test... 16:16:25 INFO - TEST-INFO | started process 19663 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOijSda/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:16:37 INFO - PROCESS | 19663 | RSS: Main: 156696576 16:16:37 INFO - PROCESS | 19663 | 16:17:29 INFO - PROCESS | 19663 | 1467069449037 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] 16:19:37 INFO - PROCESS | 19663 | Cycle 1(1): loaded http://localhost:40060/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40060/tests/dromaeo/cssquery-ext.html) 16:19:38 INFO - PROCESS | 19663 | RSS: Main: 283795456 16:19:38 INFO - PROCESS | 19663 | 16:22:40 INFO - PROCESS | 19663 | Cycle 1(1): loaded http://localhost:40060/tests/dromaeo/cssquery-ext.html (next: http://localhost:40060/tests/dromaeo/cssquery-jquery.html) 16:22:41 INFO - PROCESS | 19663 | RSS: Main: 243445760 16:22:41 INFO - PROCESS | 19663 | 16:25:43 INFO - PROCESS | 19663 | Cycle 1(1): loaded http://localhost:40060/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40060/tests/dromaeo/cssquery-mootools.html) 16:25:43 INFO - PROCESS | 19663 | RSS: Main: 245252096 16:25:43 INFO - PROCESS | 19663 | 16:28:45 INFO - PROCESS | 19663 | Cycle 1(1): loaded http://localhost:40060/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40060/tests/dromaeo/cssquery-prototype.html) 16:28:46 INFO - PROCESS | 19663 | RSS: Main: 235761664 16:28:46 INFO - PROCESS | 19663 | 16:31:48 INFO - PROCESS | 19663 | Cycle 1(1): loaded http://localhost:40060/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40060/tests/dromaeo/cssquery-yui.html) 16:31:49 INFO - PROCESS | 19663 | RSS: Main: 206188544 16:31:49 INFO - PROCESS | 19663 | 16:34:52 INFO - PROCESS | 19663 | Cycle 1(1): loaded http://localhost:40060/tests/dromaeo/cssquery-yui.html (next: http://localhost:40060/tests/dromaeo/cssquery-dojo.html) 16:34:52 INFO - PROCESS | 19663 | RSS: Main: 331243520 16:34:52 INFO - PROCESS | 19663 | 16:34:52 INFO - PROCESS | 19663 | __start_tp_report 16:34:52 INFO - PROCESS | 19663 | _x_x_mozilla_page_load 16:34:52 INFO - PROCESS | 19663 | _x_x_mozilla_page_load_details 16:34:52 INFO - PROCESS | 19663 | |i|pagename|runs| 16:34:52 INFO - PROCESS | 19663 | |0;dojo.html;3047.7866549341547;3062.8315442650646;3077.5691403203555;3092.056922638594;3124.4219819333425;5133.358330208724;5187.844364669057;5233.084210263203;5315.601329900253;5338.466153384659;5137.58899288057;5142.382914050309;5287.947120528794;5298.920516192251;5371.435999220074;4670.883227919295;4785.425748910136;4804.846489814743;4819.54214349638;5012.047710934929;4894.045661096087;4898.093852637274;4901.980376091607;4928.778204980785;4946.480619534951;4738.573528382445;4780.80876764929;4787.640926930477;4845.70925744453;4881.536254055859;4712.787924543404;4740.123077230689;4743.146233677937;4751.596114330286;4823.27650852375;4729.030548737501;4741.075490279397;4744.4069491313585;4749.453812811536;4759.976200118977;5103.9489605103845;5150.253213284052;5204.375474942994;5248.632595718302;5272.446393128743;5641.717914104278;5680.488756011979;5692.829215123512;5693.658380497142;5695.800646977336;5674.489295963342;5707.74315155819;5713.74288157034;5721.7711291548285;5723.456271654186;5161.483851614846;5179.922301165486;5207.557357624644;5208.791648334062;5338.5996050296;5763.193152958589;5772.105323674838;5773.39379365169;5773.566982476331;5774.422557744192;5515.641483303572;5515.889682206333;5516.586256030814;5517.337919449692;5519.862003449865;5442.755076021588;5512.145617429305;5548.5838562108;5567.359753628384;5611.186377975171;5562.471565201299;5566.276384070045;5579.637323573955;5579.637323573955;5585.69278689676;5469.261649677323;5587.217789509472;5593.636413633101;5595.207240973743;5600.663960162403;4289.828406863753;4295.871123866226;4321.978390108029;4325.134973005412;4365.869023929287;3846.211526637033;3846.480725102131;3857.363535016747;3885.8445662173763;3889.5138107736534;5294.97352513235;5335.1730481775385;5346.064438723208;5347.572194224531;5352.2506849041165;5442.183672449085;5555.944440555623;5588.608797384144;5618.297712785902;5688.374278829326;5324.227986941872;5338.679679219259;5340.786368545292;5345.54562862161;5346.679199248058;4867.683600565952;4873.829415970424;4882.9755851221225;4884.5603895649565;4922.704637721677;5653.604247702704;5774.480296773227;5853.64878107315;5873.148393482921;5897.292324920951;5696.401877802937;5699;5700.942990570041;5706.3152421709665;5708.714564271853;5589.077802162597;5883.117532370179;5893.44012318829;5898.970505147447;5900.232969713909;5507.642003269774;5548.833534993957;5551.472610102034;5567.860803479945;5580.497755202051;5616.1014237721765;5656.858578535405;5658.236138121301;5661.716914154358;5663.773449061991;5282.128448805904;5369.4630536946;5529.972350138223;5533;5536.695481748542;5381.757820898148;5411.296531451044;5425.376081750649;5426.728663566885;5463.262459568066;5348.064088784525;5351.250824884597;5353.625246232727;5356.035913535601;5399.4600539945695;5351.946480535301;5414.648047876875;5450.264214331173;5470.64440811346;5509.641873278224;5299.894002119859;5342.171963345688;5350.545203657733;5361.035013697572;5407.080796264723 16:34:52 INFO - PROCESS | 19663 | |1;ext.html;582.4641329976421;614.4899733221425;626.026528747797;629.3391938464613;639.9488040956724;30287.697123028764;40694.59305406949;41461.79269103658;41560;41998;40819.79590102045;44734.552654473526;44780.5219478052;44866.1026779465;44925.32612010814;8092.635831387573;8847.867281990775;8988.146126118008;8993.865092023625;10691.465426728671;10485.475726213697;10604.522796474139;10897.618583349584;10923.344599324066;10924.781504369908;10936.507857146407;10999.065079468255;11002.559897604086;11005.394703291317;11010;10841.512131954041;10919.617813376493;10927.508262128224;10932.617358392417;10935;10719.571217151304;10733.62432314873;10769.83845242322;10796.298240614413;10800.945995269973;44186.33720494195;44465.777671111435;44476;44521.33218001733;44533.332000020026;3587.8385472653795;3611.2596917632086;3772.981135094307;3900.9244792962436;4166.354215096665;33316.83341583301;33678.83160584181;34110.658893411;34182.316353673035;34279.314413711836;4367.25756621372;4396.1427521633295;4415.271480205763;4425.070735145623;4450.777461126931;377710;377760;380888;381897;382205;65969.6701516499;66243;66493.667531663;66554.66722666356;66576;68768.31231687719;68830.65584672145;68852;68993;69037.85772853644;16134.78989075824;16145.838541614434;16175.676486470205;16177.272022759003;16496.6700665986;13953.581392558239;13958;13999.370028348749;13999.440022399194;14027.228502432465;19665;20293.086811093537;20437.182512699324;20444.48888777763;20469.59060818805;6673.329668682205;7366.116066071999;7566.508176968479;7575.507592006502;7728.6522106505345;974.668612671695;1076.7146706122883;1096.3860238266595;1105.5522513382093;1133.7052366384798;32025.839870800963;32260.35479290401;32458;32508.512372314435;32750.344993100003;1100.510272928539;1118.0943435817014;1178.393127539318;1195.9521619135137;1213.4296880466168;16577.834221657627;16733.247003884855;17020.48938531846;17094.48716538481;17349.826501735075;490678;492599;496940;498807;499434;39072.60927390747;39104.80447597801;39238.60761392407;39252.411213831816;39304.21391572153;1220.4873952939786;1309.8297221361163;1346.2393747532612;1392.7005693775684;1397.1477398786733;32220.516692250105;33378;33802;33820.661793381754;34249.65750342465;49768.25347619716;53631.46368536264;55151.724241378535;55315.17027244675;61421.692891535255;475816;476557;480844;482457;482489;24977.12580059762;25891.870540647174;26336.736632634194;26755.866220668773;28251.858740706164;48809.26786098282;48934;49073.75463122661;50022.74988625179;50042.74978625084;40553.797231013654;41454.37818432786;41564.1687166261;42031.3695294577;42847.14305713931;41077.357649040605;41079.794601026806;41530.792346039285;41534.169316614105;42052.78973605113;40488.3926741105;41252;41605.79197103995;41681.58318416777;41804;35281.47077793886;36588;37755.81122094372;37772;37837.62162378341;27907.441851162457;28144.29639259035;28390.574141388308;28593.42813143767;28620.42759144847 16:34:52 INFO - PROCESS | 19663 | |2;jquery.html;374.80510134729934;381.59550876071364;392.46232661254066;394.90127468132965;400.50137578714504;17519.474415767516;19400.805991940077;19825.107870145843;20162.19351225951;20208.494787630316;18528.44414667562;18914.621707565875;19080.522986925334;19185.808141918576;19279.614407711837;5382.542483888874;5390.299261096052;5596.916046259309;5617.831465056034;5657.519110875581;5501.504864562188;5579.69311687857;5597.44025597441;5603.971980140093;5614.775408983635;5274.4461831507715;5510.118381059031;5538.169274608801;5562.360328562207;5565.276514053167;5450.863728406782;5467.535259502947;5479.150731636602;5498.395176530578;5500.972495137538;4795.304680821261;4857.2714092886;4866.58634016109;4867.8783030424165;4873.731944743037;22351.77648223513;22876.656850147094;22895.198668046705;23005;23005.19481818145;2419.5765740995257;2469.3949982254285;2798.608194852722;2829.7170282971742;3155.2742869139997;13443.529476468277;14245.928770356186;14434.13395196281;15023.774643380359;15100.54698359051;1970.724098626179;2008.513699862106;2025.9493512662302;2131.840111991607;2136.2309568555306;55121;78911.21088789096;80209.59895200486;80630.19369806343;81008.59495702543;9831.606735730491;10030.74923126913;10049.648262310784;10207;10224.948875255724;13228.206307621573;13230.140040897311;13286;13311.267880266485;13314.600561983156;7745;7926.24700653437;8004.1995800420655;8011.919880801234;8062.798430039296;8003.909210578844;8082.393820463489;8092.8381432371025;8233.38249631268;8362.372822038371;4063.532693740258;4112.91774164521;4191.245575796386;4218;4256.978715106405;1678.3706110208673;1722.603801125748;1727.1911070987535;1730.4030109612163;1758.4373000639928;929.7257309093834;950.2113246005798;962.451402700454;963.1524258652341;979.9363041402286;17629.598536863312;19010.904945475184;19096.904515477334;19249.422517324503;19288;1003.4180175498193;1017.8422344536609;1023.4780262066399;1034.8602938603192;1080.9459527023616;10340.397238428055;10600.098991585648;10617.787644247072;10773;10825;436626;449966;472409;485776;485916;67213;79679.99999999884;91595.5420222908;94014;94657.05342946482;980.6812785844629;1003.1623594298696;1018.1345856022322;1033.7984093101923;1041.8020576090519;16361.590960226089;16871.493855184362;17139.143042848056;17429.564260893578;17716.645667086843;40479.59520404758;44705.32942005807;45220.77389613031;46349;47015.52984470248;58741.41258587359;59554;59747.103793442264;60321.09518357316;61434.38565614287;7478.326950574475;8100.635471403919;8142.18578142181;8224.095349511668;8378.99452065756;9112.544372781202;11618.128640352177;11998.340091295062;12182.39088045612;12256.693582660504;10081;10180.847287290548;10187.235957303381;10446.320989135682;10590.417527036087;10486.685399438029;10536.367817930948;10666.253362264568;10964.342139471657;11070.169737269576;10236.129928956123;10362.171026318027;10481.475926203811;10549.89450105489;10576.788464230825;7486.43851711113;7847.882281765664;7926.24700653437;7990.400719945911;8114.43198976066;9155.542222888962;10038.19694424459;10197.949010255197;10313.071823535618;10452.58189672435 16:34:52 INFO - PROCESS | 19663 | |3;mootools.html;1309.9803502947464;1452.9491467798625;1487.3232679130992;1592.5859276588092;1731.792184937807;7964.641591128406;8340.833183336337;8346.081930987593;8573.571321433934;8578.828423431527;8325.042620098691;8510.106438823927;8515.063343032278;8520.616572254248;8522.829543409143;1822.7605228444652;2196.8681879087308;2273.27255278311;2322.5238826040622;2345.7302410222787;2293.5642227976714;2302.228753367624;2304.2396009316885;2307.411610039446;2308.6421604651305;2262.1743063781682;2314.618088015475;2316.513532158249;2317.8145748340175;2318.3624503261653;2005.7693365262962;2218.5784700906856;2297.7702229777055;2301.6432452969816;2319.686842276288;2186.409669389272;2199.56008798241;2200.8459407841456;2211.624023915922;2271.6251818449937;8474.618642161118;8486.363522735757;8534.103919088468;8541.273991710712;8552.657893684245;5051.520105589963;5200.115980283361;5204.401493828221;5209.7134657593815;5221.660592061542;3176.5076413156;3224.967750322514;3266.7876588021704;3291.2594666200152;3295.571575695168;983.5819776594918;1002.1531805624236;1010.3483253301579;1027.23984251654;1033.2095946600857;11623.941880290544;11666.941665291704;11667.708307292301;11670.241434306829;11673.70815729605;4526.094781043805;4541.568550987651;4630.699004564693;4656;4659.464161621389;9867.210623150131;9874.506274686237;9877.802443951225;9882.357646752938;9891.060349266809;4617.076584683077;5224.746060945422;5227.059129356752;5231.346081739783;5235.267062611238;4658.720476771405;4825.252085926687;4834.347363105936;4839.249916262985;4840.685355451885;3860.3244432224246;3870.3807390817333;3978;3996;3999.4000899864673;1242.9627111186678;1268.6067319131098;1270.9872901271053;1279.8848103670714;1295.8185853980451;1004.3170643962176;1009.3893194617298;1019.6176433837311;1020.4846552491093;1026.4867566216892;5956.344802071769;6038.5772995889865;6104.755809767648;6150.169727086786;6189.535784816157;442.674634143904;453.3087042260579;454.23234733300615;458.749981260214;461.6583728041225;4165.333546632524;4185.497740271187;4186.518550366686;4199.223143718422;4218.156368726267;9960.103590676874;10217.386956782617;10281.948590257001;10305.896941030494;10327.948360258151;10173.84739228912;10238.948805256076;10239;10245.334053286513;10246.282760206863;7424.554526728413;7773;7774.844503110019;7877.842443151105;7986.201379861967;5881.676507792113;5984.581079324405;6038.215032045806;6249.625022498482;6270.184875966278;9561.856572151562;9565.808683826424;9632.229421646392;9650.903490965282;9660.420374777535;9515.619375224913;9589.520523973913;9887.406755594688;10009.649662261785;10040.69877903664;7072.115985501812;7348.77953661391;7434.182239953709;7521.05986751656;7541.660625271767;8339.374546909128;8341.082480926972;8362.665493380196;8403.201695838885;8404.621792019496;7433;7435.553866768011;7452.701891924262;7722.575258360619;7736.342410894912;7370.262973702587;7402.814929626802;7477.626118693935;7566.659500322388;7599.848003040019;6517;6534.444572211415;6613.867722645617;6616.933830661632;6619.834504137242;4965.45380008206;5117.513836185556;5211.0880595894805;5262.500062494057;5268.78924843002;5223.973880130575;5263.605229607718;5307.097793375058;5311.123664595299;5316.362036555638 16:34:52 INFO - PROCESS | 19663 | |4;prototype.html;306.0985398002881;307.6369883537425;315.3944426700734;321.4904376563147;324.3545344763921;5227.2159176123605;5348.475684429934;5363;5410.783568657253;5444.1833724941225;5333.306670132887;5339.5461385782255;5354.170103633943;5355.518003379695;5369.731513424333;4150.273702102135;4159.625633692982;4162.188373267214;4162.979185104078;4175.519815221258;4072.9613948443107;4154.376843473473;4176.18564379946;4183.493942180812;4191.497020357561;4069.1719255117705;4092.9386059209137;4117.023828562292;4119.855805046824;4138.358554424069;4036.2331157080207;4072.6131017553435;4083.1629515949157;4127.442795222667;4141.544430112685;3600.4959305697225;3607.2244467439364;3629.5825980012373;3630.1650620357464;3647.1246900743895;5180.948190518085;5197.454267301917;5210.973945130288;5247.1866860636665;5271.42014378418;4707.340972263886;4712.929306060412;4720.409948756405;4736.2895565665085;4742.762861856893;5558.610897237195;5564.554835613182;5566.55467562594;5568.276124103881;5592.692401917893;3852.499175107246;3890.863819766323;3900.8439662413753;3905.5508616509183;3962.128331767007;5473.562115030828;5617.41017193197;5802.535797136219;5819.505342045931;5852.795152169653;3982.143839074613;4002.619751123697;4019.376996565537;4021.155557332934;4024.215278020816;3878.8254528545717;3942.5466071402157;4030.717849750548;4054.189162167578;4054.7972601369815;4637.608717384771;4646.140464014168;4648.6518909516535;4651.046560444622;4651.37206477128;5562.721863906789;5578.41426650204;5597.041035637494;5609.018421776254;5623.775048997994;1367.9658008549666;1408.2184387664945;1425.2161311278755;1426.5648977061887;1438.101186758276;863.3740538109946;875.2429148786254;878.2490970220497;878.5826732302233;881.4094556647062;4724.811007559659;4731.266653668687;4784.330193772875;4794.496577859344;4803.615710743132;4990.975045124751;5005.399352077701;5057.317262169634;5067.543921047123;5088.363954505687;4468.687191896601;4784.928226076611;4787.210110331756;4809.567138957441;4812.903741925212;2669.878650966599;2674.6790385153517;2695.2183866678442;2704.269847141261;2709.6883858356146;5149.124648809711;5172.301739265226;5183.559397451183;5191.870203244949;5227.634065615446;4806.327114204014;5097.9098569586295;5104.9744751276;5137.563307118862;5217.295665085241;5123.718195499208;5170.560502357342;5193.584513238932;5193.8964719288;5198.610104242197;5020.623453240948;5047.444781074006;5055.407546622802;5074;5499.615026948075;5449.782008719607;5607.8878422432135;5615.034737841886;5660.801871934463;5668.574856885668;5822.806324703341;5863.853403664943;5913.793017244376;5939.138824870283;5949.434803693643;3838.347480928305;4034.556198818069;4040;4092.386142078712;4093.3655283431117;5754.913676294943;5769.884602308014;5775.191473193672;5790.652560846363;5810.331811841524;5632.155176723524;5633.464820842013;5641.605087643826;5660.264165658438;5663.943360566342;5495.422980587141;5568.6658800472105;5578.3584887738425;5582.525485333792;5617.606767526234;5462.8907421850545;5489.533389661923;5534.335879694301;5534.730760388222;5544.833654990357;5381.973090134681;5571.777128914798;5591.4688104629995;5598.852235291837;5673.631213971079;5399.163129714901;5449.373322068013;5459.727013649381;5480;5480.958617862593 16:34:52 INFO - PROCESS | 19663 | |5;yui.html;759.722701214057;786.8386980668963;805.3396215103616;810.6352141536306;817.8364327134575;17095.914520427395;17764.555886102855;17782.911085444553;17807.28770849166;17813.64372712545;16717.080560569164;16746.16269186539;16832.747508787346;16859;16914.83085169148;672.9932700673004;794.1859593916254;818.071488860145;826.9586520673943;829.3862541719114;824.2499325613693;827.0282418158639;829.1501211258478;829.6515463505342;829.9170082991712;867.7873920889359;868.3834477520968;868.9913100868973;869.1959937058227;869.395769939892;697.6476879176034;839.70190582343;865.3942240431692;870.7300736771621;871.2202578692098;631.210986267166;631.5105793010454;631.8736252749469;631.9982827218863;632.8417895526119;15584.766228506582;15613.765793513106;15633.765493517607;15634.843651563453;15653.373865045498;13956.72086558263;14101.506447274398;14140.85859141416;14307.713845723027;14324.713505729931;13301.73396532064;13323.200607963554;13365.933170334183;13679.179249245077;13861.653458663513;4462.2191116554795;4612.262038073892;4628.398308219944;4635.327877457749;4735.73953432561;74887.99999999946;77751.22248777554;78185.60907195485;78768.60615696943;79365;11014.229003969645;11017.11863050954;11325.830112548318;11330.94334528322;11492.597759078559;20661.58676826455;20912.163513459596;20938.790612093988;20944.685829712565;20956.790432095484;8431.620577074047;8452.661893524313;8473.95763021181;8542.316614670812;8659.567021648892;4837.018893984038;4851.199552073868;4884.8290309838985;4897.828575999894;5002.499750024968;3430.3310854383158;3445.707114895262;3519.8064106473876;3545.13144279648;3548.6806187443253;601.5728832528954;602.4457499100838;612.4518555892452;615.8429600451856;618.5422787137576;652.5008368598026;670.7048898484651;671.8723442545901;673.9797806065826;684.7979845945458;8303;8443.746687599381;8681.131886811394;8731.257843083282;8922.643094276156;528.7197785173864;616.7841255560518;643.6556442303345;654.6661202786613;662.9933700663028;4142.171565686875;4143.91712165755;4176.248275310473;4252.319628859368;4255.340422234497;109233.45383273033;109911;111858;112279;113493;99188;102075.4896225529;102522;104508.47745761374;105441;85755.5712221435;87207.1279287199;87582.56208718916;89512;90164.09835901688;7167.211606723361;7198.4601154914635;7334.669939852826;7394.8890766639615;7400.5189662671755;51889.481105189974;52103.47896520986;53199.73400132974;53586.73206633942;54433;76186;78235.60882195552;78902.6054869722;80249.19750802651;82290.58854705688;11205.271657342246;11358.375289358833;12036.338001409656;12882.935585322013;13264.53574124901;14390.640233994234;15228.847711523185;15762.290696918437;16105.436309729103;16158.596035099217;14763;14948.626284342978;15219.771703424236;15459.922700386876;15607.609809754847;13468.5286014989;14301.856981430052;14315.427382904567;14326.355314010687;14921.925390372979;13226.537071202461;14292.213928234047;14445.711085778436;14459.783103253249;14774.335154917839;11668.066554675775;12058.792828348616;12167.33079680626;12275.570355037531;12341.259524428562;11955.71444133023;12376.381180941096;12526.812097818358;12627.242365458102;12825.486980521047 16:34:52 INFO - PROCESS | 19663 | __end_tp_report 16:34:52 INFO - PROCESS | 19663 | __start_cc_report 16:34:52 INFO - PROCESS | 19663 | _x_x_mozilla_cycle_collect,1075 16:34:52 INFO - PROCESS | 19663 | __end_cc_report 16:34:52 INFO - PROCESS | 19663 | __startTimestamp1467070492438__endTimestamp 16:34:52 INFO - PROCESS | 19663 | 16:34:52 INFO - PROCESS | 19663 | ------- Summary: start ------- 16:34:52 INFO - PROCESS | 19663 | Number of tests: 6 16:34:52 INFO - PROCESS | 19663 | 16:34:52 INFO - PROCESS | 19663 | [#0] dojo.html Cycles:165 Average:5220.59 Median:5356.04 stddev:581.13 (10.8%) stddev-sans-first:557.35 16:34:52 INFO - PROCESS | 19663 | Values: 3047.8 3062.8 3077.6 3092.1 3124.4 5133.4 5187.8 5233.1 5315.6 5338.5 5137.6 5142.4 5287.9 5298.9 5371.4 4670.9 4785.4 4804.8 4819.5 5012.0 4894.0 4898.1 4902.0 4928.8 4946.5 4738.6 4780.8 4787.6 4845.7 4881.5 4712.8 4740.1 4743.1 4751.6 4823.3 4729.0 4741.1 4744.4 4749.5 4760.0 5103.9 5150.3 5204.4 5248.6 5272.4 5641.7 5680.5 5692.8 5693.7 5695.8 5674.5 5707.7 5713.7 5721.8 5723.5 5161.5 5179.9 5207.6 5208.8 5338.6 5763.2 5772.1 5773.4 5773.6 5774.4 5515.6 5515.9 5516.6 5517.3 5519.9 5442.8 5512.1 5548.6 5567.4 5611.2 5562.5 5566.3 5579.6 5579.6 5585.7 5469.3 5587.2 5593.6 5595.2 5600.7 4289.8 4295.9 4322.0 4325.1 4365.9 3846.2 3846.5 3857.4 3885.8 3889.5 5295.0 5335.2 5346.1 5347.6 5352.3 5442.2 5555.9 5588.6 5618.3 5688.4 5324.2 5338.7 5340.8 5345.5 5346.7 4867.7 4873.8 4883.0 4884.6 4922.7 5653.6 5774.5 5853.6 5873.1 5897.3 5696.4 5699.0 5700.9 5706.3 5708.7 5589.1 5883.1 5893.4 5899.0 5900.2 5507.6 5548.8 5551.5 5567.9 5580.5 5616.1 5656.9 5658.2 5661.7 5663.8 5282.1 5369.5 5530.0 5533.0 5536.7 5381.8 5411.3 5425.4 5426.7 5463.3 5348.1 5351.3 5353.6 5356.0 5399.5 5351.9 5414.6 5450.3 5470.6 5509.6 5299.9 5342.2 5350.5 5361.0 5407.1 16:34:52 INFO - PROCESS | 19663 | 16:34:52 INFO - PROCESS | 19663 | [#1] ext.html Cycles:180 Average:61608.04 Median:209362.81 stddev:120338.13 (57.5%) stddev-sans-first:120588.48 16:34:52 INFO - PROCESS | 19663 | Values: 582.5 614.5 626.0 629.3 639.9 30287.7 40694.6 41461.8 41560.0 41998.0 40819.8 44734.6 44780.5 44866.1 44925.3 8092.6 8847.9 8988.1 8993.9 10691.5 10485.5 10604.5 10897.6 10923.3 10924.8 10936.5 10999.1 11002.6 11005.4 11010.0 10841.5 10919.6 10927.5 10932.6 10935.0 10719.6 10733.6 10769.8 10796.3 10800.9 44186.3 44465.8 44476.0 44521.3 44533.3 3587.8 3611.3 3773.0 3900.9 4166.4 33316.8 33678.8 34110.7 34182.3 34279.3 4367.3 4396.1 4415.3 4425.1 4450.8 377710.0 377760.0 380888.0 381897.0 382205.0 65969.7 66243.0 66493.7 66554.7 66576.0 68768.3 68830.7 68852.0 68993.0 69037.9 16134.8 16145.8 16175.7 16177.3 16496.7 13953.6 13958.0 13999.4 13999.4 14027.2 19665.0 20293.1 20437.2 20444.5 20469.6 6673.3 7366.1 7566.5 7575.5 7728.7 974.7 1076.7 1096.4 1105.6 1133.7 32025.8 32260.4 32458.0 32508.5 32750.3 1100.5 1118.1 1178.4 1196.0 1213.4 16577.8 16733.2 17020.5 17094.5 17349.8 490678.0 492599.0 496940.0 498807.0 499434.0 39072.6 39104.8 39238.6 39252.4 39304.2 1220.5 1309.8 1346.2 1392.7 1397.1 32220.5 33378.0 33802.0 33820.7 34249.7 49768.3 53631.5 55151.7 55315.2 61421.7 475816.0 476557.0 480844.0 482457.0 482489.0 24977.1 25891.9 26336.7 26755.9 28251.9 48809.3 48934.0 49073.8 50022.7 50042.7 40553.8 41454.4 41564.2 42031.4 42847.1 41077.4 41079.8 41530.8 41534.2 42052.8 40488.4 41252.0 41605.8 41681.6 41804.0 35281.5 36588.0 37755.8 37772.0 37837.6 27907.4 28144.3 28390.6 28593.4 28620.4 16:34:52 INFO - PROCESS | 19663 | 16:34:52 INFO - PROCESS | 19663 | [#2] jquery.html Cycles:180 Average:27863.51 Median:1765.04 stddev:76953.70 (4359.9%) stddev-sans-first:77141.89 16:34:52 INFO - PROCESS | 19663 | Values: 374.8 381.6 392.5 394.9 400.5 17519.5 19400.8 19825.1 20162.2 20208.5 18528.4 18914.6 19080.5 19185.8 19279.6 5382.5 5390.3 5596.9 5617.8 5657.5 5501.5 5579.7 5597.4 5604.0 5614.8 5274.4 5510.1 5538.2 5562.4 5565.3 5450.9 5467.5 5479.2 5498.4 5501.0 4795.3 4857.3 4866.6 4867.9 4873.7 22351.8 22876.7 22895.2 23005.0 23005.2 2419.6 2469.4 2798.6 2829.7 3155.3 13443.5 14245.9 14434.1 15023.8 15100.5 1970.7 2008.5 2025.9 2131.8 2136.2 55121.0 78911.2 80209.6 80630.2 81008.6 9831.6 10030.7 10049.6 10207.0 10224.9 13228.2 13230.1 13286.0 13311.3 13314.6 7745.0 7926.2 8004.2 8011.9 8062.8 8003.9 8082.4 8092.8 8233.4 8362.4 4063.5 4112.9 4191.2 4218.0 4257.0 1678.4 1722.6 1727.2 1730.4 1758.4 929.7 950.2 962.5 963.2 979.9 17629.6 19010.9 19096.9 19249.4 19288.0 1003.4 1017.8 1023.5 1034.9 1080.9 10340.4 10600.1 10617.8 10773.0 10825.0 436626.0 449966.0 472409.0 485776.0 485916.0 67213.0 79680.0 91595.5 94014.0 94657.1 980.7 1003.2 1018.1 1033.8 1041.8 16361.6 16871.5 17139.1 17429.6 17716.6 40479.6 44705.3 45220.8 46349.0 47015.5 58741.4 59554.0 59747.1 60321.1 61434.4 7478.3 8100.6 8142.2 8224.1 8379.0 9112.5 11618.1 11998.3 12182.4 12256.7 10081.0 10180.8 10187.2 10446.3 10590.4 10486.7 10536.4 10666.3 10964.3 11070.2 10236.1 10362.2 10481.5 10549.9 10576.8 7486.4 7847.9 7926.2 7990.4 8114.4 9155.5 10038.2 10197.9 10313.1 10452.6 16:34:52 INFO - PROCESS | 19663 | 16:34:52 INFO - PROCESS | 19663 | [#3] mootools.html Cycles:180 Average:5614.21 Median:4903.07 stddev:3142.54 (64.1%) stddev-sans-first:3134.71 16:34:52 INFO - PROCESS | 19663 | Values: 1310.0 1452.9 1487.3 1592.6 1731.8 7964.6 8340.8 8346.1 8573.6 8578.8 8325.0 8510.1 8515.1 8520.6 8522.8 1822.8 2196.9 2273.3 2322.5 2345.7 2293.6 2302.2 2304.2 2307.4 2308.6 2262.2 2314.6 2316.5 2317.8 2318.4 2005.8 2218.6 2297.8 2301.6 2319.7 2186.4 2199.6 2200.8 2211.6 2271.6 8474.6 8486.4 8534.1 8541.3 8552.7 5051.5 5200.1 5204.4 5209.7 5221.7 3176.5 3225.0 3266.8 3291.3 3295.6 983.6 1002.2 1010.3 1027.2 1033.2 11623.9 11666.9 11667.7 11670.2 11673.7 4526.1 4541.6 4630.7 4656.0 4659.5 9867.2 9874.5 9877.8 9882.4 9891.1 4617.1 5224.7 5227.1 5231.3 5235.3 4658.7 4825.3 4834.3 4839.2 4840.7 3860.3 3870.4 3978.0 3996.0 3999.4 1243.0 1268.6 1271.0 1279.9 1295.8 1004.3 1009.4 1019.6 1020.5 1026.5 5956.3 6038.6 6104.8 6150.2 6189.5 442.7 453.3 454.2 458.7 461.7 4165.3 4185.5 4186.5 4199.2 4218.2 9960.1 10217.4 10281.9 10305.9 10327.9 10173.8 10238.9 10239.0 10245.3 10246.3 7424.6 7773.0 7774.8 7877.8 7986.2 5881.7 5984.6 6038.2 6249.6 6270.2 9561.9 9565.8 9632.2 9650.9 9660.4 9515.6 9589.5 9887.4 10009.6 10040.7 7072.1 7348.8 7434.2 7521.1 7541.7 8339.4 8341.1 8362.7 8403.2 8404.6 7433.0 7435.6 7452.7 7722.6 7736.3 7370.3 7402.8 7477.6 7566.7 7599.8 6517.0 6534.4 6613.9 6616.9 6619.8 4965.5 5117.5 5211.1 5262.5 5268.8 5224.0 5263.6 5307.1 5311.1 5316.4 16:34:52 INFO - PROCESS | 19663 | 16:34:52 INFO - PROCESS | 19663 | [#4] prototype.html Cycles:180 Average:4546.60 Median:5101.44 stddev:1339.20 (26.3%) stddev-sans-first:1304.59 16:34:52 INFO - PROCESS | 19663 | Values: 306.1 307.6 315.4 321.5 324.4 5227.2 5348.5 5363.0 5410.8 5444.2 5333.3 5339.5 5354.2 5355.5 5369.7 4150.3 4159.6 4162.2 4163.0 4175.5 4073.0 4154.4 4176.2 4183.5 4191.5 4069.2 4092.9 4117.0 4119.9 4138.4 4036.2 4072.6 4083.2 4127.4 4141.5 3600.5 3607.2 3629.6 3630.2 3647.1 5180.9 5197.5 5211.0 5247.2 5271.4 4707.3 4712.9 4720.4 4736.3 4742.8 5558.6 5564.6 5566.6 5568.3 5592.7 3852.5 3890.9 3900.8 3905.6 3962.1 5473.6 5617.4 5802.5 5819.5 5852.8 3982.1 4002.6 4019.4 4021.2 4024.2 3878.8 3942.5 4030.7 4054.2 4054.8 4637.6 4646.1 4648.7 4651.0 4651.4 5562.7 5578.4 5597.0 5609.0 5623.8 1368.0 1408.2 1425.2 1426.6 1438.1 863.4 875.2 878.2 878.6 881.4 4724.8 4731.3 4784.3 4794.5 4803.6 4991.0 5005.4 5057.3 5067.5 5088.4 4468.7 4784.9 4787.2 4809.6 4812.9 2669.9 2674.7 2695.2 2704.3 2709.7 5149.1 5172.3 5183.6 5191.9 5227.6 4806.3 5097.9 5105.0 5137.6 5217.3 5123.7 5170.6 5193.6 5193.9 5198.6 5020.6 5047.4 5055.4 5074.0 5499.6 5449.8 5607.9 5615.0 5660.8 5668.6 5822.8 5863.9 5913.8 5939.1 5949.4 3838.3 4034.6 4040.0 4092.4 4093.4 5754.9 5769.9 5775.2 5790.7 5810.3 5632.2 5633.5 5641.6 5660.3 5663.9 5495.4 5568.7 5578.4 5582.5 5617.6 5462.9 5489.5 5534.3 5534.7 5544.8 5382.0 5571.8 5591.5 5598.9 5673.6 5399.2 5449.4 5459.7 5480.0 5481.0 16:34:52 INFO - PROCESS | 19663 | 16:34:52 INFO - PROCESS | 19663 | [#5] yui.html Cycles:180 Average:21284.95 Median:4620.33 stddev:30334.89 (656.6%) stddev-sans-first:30380.84 16:34:52 INFO - PROCESS | 19663 | Values: 759.7 786.8 805.3 810.6 817.8 17095.9 17764.6 17782.9 17807.3 17813.6 16717.1 16746.2 16832.7 16859.0 16914.8 673.0 794.2 818.1 827.0 829.4 824.2 827.0 829.2 829.7 829.9 867.8 868.4 869.0 869.2 869.4 697.6 839.7 865.4 870.7 871.2 631.2 631.5 631.9 632.0 632.8 15584.8 15613.8 15633.8 15634.8 15653.4 13956.7 14101.5 14140.9 14307.7 14324.7 13301.7 13323.2 13365.9 13679.2 13861.7 4462.2 4612.3 4628.4 4635.3 4735.7 74888.0 77751.2 78185.6 78768.6 79365.0 11014.2 11017.1 11325.8 11330.9 11492.6 20661.6 20912.2 20938.8 20944.7 20956.8 8431.6 8452.7 8474.0 8542.3 8659.6 4837.0 4851.2 4884.8 4897.8 5002.5 3430.3 3445.7 3519.8 3545.1 3548.7 601.6 602.4 612.5 615.8 618.5 652.5 670.7 671.9 674.0 684.8 8303.0 8443.7 8681.1 8731.3 8922.6 528.7 616.8 643.7 654.7 663.0 4142.2 4143.9 4176.2 4252.3 4255.3 109233.5 109911.0 111858.0 112279.0 113493.0 99188.0 102075.5 102522.0 104508.5 105441.0 85755.6 87207.1 87582.6 89512.0 90164.1 7167.2 7198.5 7334.7 7394.9 7400.5 51889.5 52103.5 53199.7 53586.7 54433.0 76186.0 78235.6 78902.6 80249.2 82290.6 11205.3 11358.4 12036.3 12882.9 13264.5 14390.6 15228.8 15762.3 16105.4 16158.6 14763.0 14948.6 15219.8 15459.9 15607.6 13468.5 14301.9 14315.4 14326.4 14921.9 13226.5 14292.2 14445.7 14459.8 14774.3 11668.1 12058.8 12167.3 12275.6 12341.3 11955.7 12376.4 12526.8 12627.2 12825.5 16:34:52 INFO - PROCESS | 19663 | -------- Summary: end -------- 16:34:52 INFO - PROCESS | 19663 | 16:34:53 INFO - TEST-INFO | 19663: exit 0 16:34:53 INFO - TEST-OK | dromaeo_css | took 1113567ms 16:34:53 INFO - TEST-START | kraken 16:34:53 INFO - operating with platform_type : linux_ 16:34:53 INFO - Initialising browser for kraken test... 16:34:53 INFO - TEST-INFO | started process 19844 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRGGzvV/profile http://localhost:40060/getInfo.html) 16:34:57 INFO - PROCESS | 19844 | __metrics Screen width/height:1600/1200 16:34:57 INFO - PROCESS | 19844 | colorDepth:24 16:34:57 INFO - PROCESS | 19844 | Browser inner width/height: 1024/697 16:34:57 INFO - PROCESS | 19844 | __metrics 16:34:58 INFO - PROCESS | 19844 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:34:58 INFO - TEST-INFO | 19844: exit 0 16:34:58 INFO - Browser initialized. 16:34:58 INFO - Running cycle 1/1 for kraken test... 16:34:58 INFO - TEST-INFO | started process 19924 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRGGzvV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:35:10 INFO - PROCESS | 19924 | RSS: Main: 156889088 16:35:10 INFO - PROCESS | 19924 | 16:35:13 INFO - PROCESS | 19924 | Cycle 1(1): loaded http://localhost:40060/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40060/tests/kraken/driver.html?testName=audio-beat-detection) 16:35:14 INFO - PROCESS | 19924 | RSS: Main: 215068672 16:35:14 INFO - PROCESS | 19924 | 16:35:16 INFO - PROCESS | 19924 | Cycle 1(1): loaded http://localhost:40060/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40060/tests/kraken/driver.html?testName=audio-dft) 16:35:17 INFO - PROCESS | 19924 | RSS: Main: 203509760 16:35:17 INFO - PROCESS | 19924 | 16:35:20 INFO - PROCESS | 19924 | Cycle 1(1): loaded http://localhost:40060/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40060/tests/kraken/driver.html?testName=audio-fft) 16:35:21 INFO - PROCESS | 19924 | RSS: Main: 269135872 16:35:21 INFO - PROCESS | 19924 | 16:35:23 INFO - PROCESS | 19924 | Cycle 1(1): loaded http://localhost:40060/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40060/tests/kraken/driver.html?testName=audio-oscillator) 16:35:23 INFO - PROCESS | 19924 | RSS: Main: 181051392 16:35:23 INFO - PROCESS | 19924 | 16:35:25 INFO - PROCESS | 19924 | Cycle 1(1): loaded http://localhost:40060/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40060/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:35:26 INFO - PROCESS | 19924 | RSS: Main: 184631296 16:35:26 INFO - PROCESS | 19924 | 16:35:29 INFO - PROCESS | 19924 | Cycle 1(1): loaded http://localhost:40060/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40060/tests/kraken/driver.html?testName=imaging-darkroom) 16:35:30 INFO - PROCESS | 19924 | RSS: Main: 218624000 16:35:30 INFO - PROCESS | 19924 | 16:35:33 INFO - PROCESS | 19924 | Cycle 1(1): loaded http://localhost:40060/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40060/tests/kraken/driver.html?testName=imaging-desaturate) 16:35:34 INFO - PROCESS | 19924 | RSS: Main: 220917760 16:35:34 INFO - PROCESS | 19924 | 16:35:36 INFO - PROCESS | 19924 | Cycle 1(1): loaded http://localhost:40060/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40060/tests/kraken/driver.html?testName=json-parse-financial) 16:35:37 INFO - PROCESS | 19924 | RSS: Main: 220626944 16:35:37 INFO - PROCESS | 19924 | 16:35:38 INFO - PROCESS | 19924 | Cycle 1(1): loaded http://localhost:40060/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40060/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:35:39 INFO - PROCESS | 19924 | RSS: Main: 207224832 16:35:39 INFO - PROCESS | 19924 | 16:35:41 INFO - PROCESS | 19924 | Cycle 1(1): loaded http://localhost:40060/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40060/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:35:41 INFO - PROCESS | 19924 | RSS: Main: 210849792 16:35:41 INFO - PROCESS | 19924 | 16:35:43 INFO - PROCESS | 19924 | Cycle 1(1): loaded http://localhost:40060/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40060/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:35:44 INFO - PROCESS | 19924 | RSS: Main: 218734592 16:35:44 INFO - PROCESS | 19924 | 16:35:47 INFO - PROCESS | 19924 | Cycle 1(1): loaded http://localhost:40060/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40060/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:35:47 INFO - PROCESS | 19924 | RSS: Main: 236478464 16:35:47 INFO - PROCESS | 19924 | 16:35:50 INFO - PROCESS | 19924 | Cycle 1(1): loaded http://localhost:40060/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40060/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:35:51 INFO - PROCESS | 19924 | RSS: Main: 230846464 16:35:51 INFO - PROCESS | 19924 | 16:35:52 INFO - PROCESS | 19924 | Cycle 1(1): loaded http://localhost:40060/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40060/tests/kraken/driver.html?testName=ai-astar) 16:35:53 INFO - PROCESS | 19924 | RSS: Main: 272375808 16:35:53 INFO - PROCESS | 19924 | 16:35:53 INFO - PROCESS | 19924 | __start_tp_report 16:35:53 INFO - PROCESS | 19924 | _x_x_mozilla_page_load 16:35:53 INFO - PROCESS | 19924 | _x_x_mozilla_page_load_details 16:35:53 INFO - PROCESS | 19924 | |i|pagename|runs| 16:35:53 INFO - PROCESS | 19924 | |0;ai-astar;101;111;111;111;110;111;110;113;111;110 16:35:53 INFO - PROCESS | 19924 | |1;audio-beat-detection;162;137;134;183;126;134;163;125;171;128 16:35:53 INFO - PROCESS | 19924 | |2;audio-dft;160;161;159;160;160;161;162;161;162;161 16:35:53 INFO - PROCESS | 19924 | |3;audio-fft;74;77;75;123;74;76;78;75;103;74 16:35:53 INFO - PROCESS | 19924 | |4;audio-oscillator;84;84;125;85;84;84;119;86;85;133 16:35:53 INFO - PROCESS | 19924 | |5;imaging-gaussian-blur;116;117;117;117;117;117;117;117;117;117 16:35:53 INFO - PROCESS | 19924 | |6;imaging-darkroom;146;146;146;145;146;145;145;147;145;145 16:35:53 INFO - PROCESS | 19924 | |7;imaging-desaturate;95;95;95;94;94;95;94;94;95;95 16:35:53 INFO - PROCESS | 19924 | |8;json-parse-financial;56;52;52;53;54;53;54;54;54;54 16:35:53 INFO - PROCESS | 19924 | |9;json-stringify-tinderbox;62;62;62;62;62;62;61;62;62;62 16:35:53 INFO - PROCESS | 19924 | |10;stanford-crypto-aes;79;79;78;84;79;80;81;80;95;80 16:35:53 INFO - PROCESS | 19924 | |11;stanford-crypto-ccm;121;122;119;121;119;128;121;128;123;128 16:35:53 INFO - PROCESS | 19924 | |12;stanford-crypto-pbkdf2;160;161;158;158;158;162;166;161;168;164 16:35:53 INFO - PROCESS | 19924 | |13;stanford-crypto-sha256-iterative;64;68;63;67;63;64;66;66;62;67 16:35:53 INFO - PROCESS | 19924 | __end_tp_report 16:35:53 INFO - PROCESS | 19924 | __start_cc_report 16:35:53 INFO - PROCESS | 19924 | _x_x_mozilla_cycle_collect,1671 16:35:53 INFO - PROCESS | 19924 | __end_cc_report 16:35:53 INFO - PROCESS | 19924 | __startTimestamp1467070553017__endTimestamp 16:35:53 INFO - PROCESS | 19924 | 16:35:53 INFO - PROCESS | 19924 | ------- Summary: start ------- 16:35:53 INFO - PROCESS | 19924 | Number of tests: 14 16:35:53 INFO - PROCESS | 19924 | 16:35:53 INFO - PROCESS | 19924 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:3.25 (2.9%) stddev-sans-first:0.93 16:35:53 INFO - PROCESS | 19924 | Values: 101.0 111.0 111.0 111.0 110.0 111.0 110.0 113.0 111.0 110.0 16:35:53 INFO - PROCESS | 19924 | 16:35:53 INFO - PROCESS | 19924 | [#1] audio-beat-detection Cycles:10 Average:146.30 Median:149.50 stddev:21.27 (14.2%) stddev-sans-first:21.79 16:35:53 INFO - PROCESS | 19924 | Values: 162.0 137.0 134.0 183.0 126.0 134.0 163.0 125.0 171.0 128.0 16:35:53 INFO - PROCESS | 19924 | 16:35:53 INFO - PROCESS | 19924 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.95 (0.6%) stddev-sans-first:0.97 16:35:53 INFO - PROCESS | 19924 | Values: 160.0 161.0 159.0 160.0 160.0 161.0 162.0 161.0 162.0 161.0 16:35:53 INFO - PROCESS | 19924 | 16:35:53 INFO - PROCESS | 19924 | [#3] audio-fft Cycles:10 Average:82.90 Median:75.00 stddev:16.60 (22.1%) stddev-sans-first:17.29 16:35:53 INFO - PROCESS | 19924 | Values: 74.0 77.0 75.0 123.0 74.0 76.0 78.0 75.0 103.0 74.0 16:35:53 INFO - PROCESS | 19924 | 16:35:53 INFO - PROCESS | 19924 | [#4] audio-oscillator Cycles:10 Average:96.90 Median:84.00 stddev:20.14 (24.0%) stddev-sans-first:20.81 16:35:53 INFO - PROCESS | 19924 | Values: 84.0 84.0 125.0 85.0 84.0 84.0 119.0 86.0 85.0 133.0 16:35:53 INFO - PROCESS | 19924 | 16:35:53 INFO - PROCESS | 19924 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 16:35:53 INFO - PROCESS | 19924 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 16:35:53 INFO - PROCESS | 19924 | 16:35:53 INFO - PROCESS | 19924 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 16:35:53 INFO - PROCESS | 19924 | Values: 146.0 146.0 146.0 145.0 146.0 145.0 145.0 147.0 145.0 145.0 16:35:53 INFO - PROCESS | 19924 | 16:35:53 INFO - PROCESS | 19924 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 16:35:53 INFO - PROCESS | 19924 | Values: 95.0 95.0 95.0 94.0 94.0 95.0 94.0 94.0 95.0 95.0 16:35:53 INFO - PROCESS | 19924 | 16:35:53 INFO - PROCESS | 19924 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:54.00 stddev:1.17 (2.2%) stddev-sans-first:0.87 16:35:53 INFO - PROCESS | 19924 | Values: 56.0 52.0 52.0 53.0 54.0 53.0 54.0 54.0 54.0 54.0 16:35:53 INFO - PROCESS | 19924 | 16:35:53 INFO - PROCESS | 19924 | [#9] json-stringify-tinderbox Cycles:10 Average:61.90 Median:62.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 16:35:53 INFO - PROCESS | 19924 | Values: 62.0 62.0 62.0 62.0 62.0 62.0 61.0 62.0 62.0 62.0 16:35:53 INFO - PROCESS | 19924 | 16:35:53 INFO - PROCESS | 19924 | [#10] stanford-crypto-aes Cycles:10 Average:81.50 Median:80.00 stddev:5.02 (6.3%) stddev-sans-first:5.24 16:35:53 INFO - PROCESS | 19924 | Values: 79.0 79.0 78.0 84.0 79.0 80.0 81.0 80.0 95.0 80.0 16:35:53 INFO - PROCESS | 19924 | 16:35:53 INFO - PROCESS | 19924 | [#11] stanford-crypto-ccm Cycles:10 Average:123.00 Median:122.50 stddev:3.65 (3.0%) stddev-sans-first:3.80 16:35:53 INFO - PROCESS | 19924 | Values: 121.0 122.0 119.0 121.0 119.0 128.0 121.0 128.0 123.0 128.0 16:35:53 INFO - PROCESS | 19924 | 16:35:53 INFO - PROCESS | 19924 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.60 Median:161.50 stddev:3.47 (2.1%) stddev-sans-first:3.63 16:35:53 INFO - PROCESS | 19924 | Values: 160.0 161.0 158.0 158.0 158.0 162.0 166.0 161.0 168.0 164.0 16:35:53 INFO - PROCESS | 19924 | 16:35:53 INFO - PROCESS | 19924 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:66.00 stddev:2.05 (3.1%) stddev-sans-first:2.15 16:35:53 INFO - PROCESS | 19924 | Values: 64.0 68.0 63.0 67.0 63.0 64.0 66.0 66.0 62.0 67.0 16:35:53 INFO - PROCESS | 19924 | -------- Summary: end -------- 16:35:53 INFO - PROCESS | 19924 | 16:35:53 INFO - TEST-INFO | 19924: exit 0 16:35:54 INFO - TEST-OK | kraken | took 60827ms 16:35:54 INFO - SUITE-END | took 1174s 16:35:54 INFO - Completed test suite (00:19:34) 16:35:54 INFO - javascript benchmark 16:35:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3047.7866549341547, 3062.8315442650646, 3077.5691403203555, 3092.056922638594, 3124.4219819333425, 5133.358330208724, 5187.844364669057, 5233.084210263203, 5315.601329900253, 5338.466153384659, 5137.58899288057, 5142.382914050309, 5287.947120528794, 5298.920516192251, 5371.435999220074, 4670.883227919295, 4785.425748910136, 4804.846489814743, 4819.54214349638, 5012.047710934929, 4894.045661096087, 4898.093852637274, 4901.980376091607, 4928.778204980785, 4946.480619534951, 4738.573528382445, 4780.80876764929, 4787.640926930477, 4845.70925744453, 4881.536254055859, 4712.787924543404, 4740.123077230689, 4743.146233677937, 4751.596114330286, 4823.27650852375, 4729.030548737501, 4741.075490279397, 4744.4069491313585, 4749.453812811536, 4759.976200118977, 5103.9489605103845, 5150.253213284052, 5204.375474942994, 5248.632595718302, 5272.446393128743, 5641.717914104278, 5680.488756011979, 5692.829215123512, 5693.658380497142, 5695.800646977336, 5674.489295963342, 5707.74315155819, 5713.74288157034, 5721.7711291548285, 5723.456271654186, 5161.483851614846, 5179.922301165486, 5207.557357624644, 5208.791648334062, 5338.5996050296, 5763.193152958589, 5772.105323674838, 5773.39379365169, 5773.566982476331, 5774.422557744192, 5515.641483303572, 5515.889682206333, 5516.586256030814, 5517.337919449692, 5519.862003449865, 5442.755076021588, 5512.145617429305, 5548.5838562108, 5567.359753628384, 5611.186377975171, 5562.471565201299, 5566.276384070045, 5579.637323573955, 5579.637323573955, 5585.69278689676, 5469.261649677323, 5587.217789509472, 5593.636413633101, 5595.207240973743, 5600.663960162403, 4289.828406863753, 4295.871123866226, 4321.978390108029, 4325.134973005412, 4365.869023929287, 3846.211526637033, 3846.480725102131, 3857.363535016747, 3885.8445662173763, 3889.5138107736534, 5294.97352513235, 5335.1730481775385, 5346.064438723208, 5347.572194224531, 5352.2506849041165, 5442.183672449085, 5555.944440555623, 5588.608797384144, 5618.297712785902, 5688.374278829326, 5324.227986941872, 5338.679679219259, 5340.786368545292, 5345.54562862161, 5346.679199248058, 4867.683600565952, 4873.829415970424, 4882.9755851221225, 4884.5603895649565, 4922.704637721677, 5653.604247702704, 5774.480296773227, 5853.64878107315, 5873.148393482921, 5897.292324920951, 5696.401877802937, 5699.0, 5700.942990570041, 5706.3152421709665, 5708.714564271853, 5589.077802162597, 5883.117532370179, 5893.44012318829, 5898.970505147447, 5900.232969713909, 5507.642003269774, 5548.833534993957, 5551.472610102034, 5567.860803479945, 5580.497755202051, 5616.1014237721765, 5656.858578535405, 5658.236138121301, 5661.716914154358, 5663.773449061991, 5282.128448805904, 5369.4630536946, 5529.972350138223, 5533.0, 5536.695481748542, 5381.757820898148, 5411.296531451044, 5425.376081750649, 5426.728663566885, 5463.262459568066, 5348.064088784525, 5351.250824884597, 5353.625246232727, 5356.035913535601, 5399.4600539945695, 5351.946480535301, 5414.648047876875, 5450.264214331173, 5470.64440811346, 5509.641873278224, 5299.894002119859, 5342.171963345688, 5350.545203657733, 5361.035013697572, 5407.080796264723], "value": 5182.370911999438, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.4641329976421, 614.4899733221425, 626.026528747797, 629.3391938464613, 639.9488040956724, 30287.697123028764, 40694.59305406949, 41461.79269103658, 41560.0, 41998.0, 40819.79590102045, 44734.552654473526, 44780.5219478052, 44866.1026779465, 44925.32612010814, 8092.635831387573, 8847.867281990775, 8988.146126118008, 8993.865092023625, 10691.465426728671, 10485.475726213697, 10604.522796474139, 10897.618583349584, 10923.344599324066, 10924.781504369908, 10936.507857146407, 10999.065079468255, 11002.559897604086, 11005.394703291317, 11010.0, 10841.512131954041, 10919.617813376493, 10927.508262128224, 10932.617358392417, 10935.0, 10719.571217151304, 10733.62432314873, 10769.83845242322, 10796.298240614413, 10800.945995269973, 44186.33720494195, 44465.777671111435, 44476.0, 44521.33218001733, 44533.332000020026, 3587.8385472653795, 3611.2596917632086, 3772.981135094307, 3900.9244792962436, 4166.354215096665, 33316.83341583301, 33678.83160584181, 34110.658893411, 34182.316353673035, 34279.314413711836, 4367.25756621372, 4396.1427521633295, 4415.271480205763, 4425.070735145623, 4450.777461126931, 377710.0, 377760.0, 380888.0, 381897.0, 382205.0, 65969.6701516499, 66243.0, 66493.667531663, 66554.66722666356, 66576.0, 68768.31231687719, 68830.65584672145, 68852.0, 68993.0, 69037.85772853644, 16134.78989075824, 16145.838541614434, 16175.676486470205, 16177.272022759003, 16496.6700665986, 13953.581392558239, 13958.0, 13999.370028348749, 13999.440022399194, 14027.228502432465, 19665.0, 20293.086811093537, 20437.182512699324, 20444.48888777763, 20469.59060818805, 6673.329668682205, 7366.116066071999, 7566.508176968479, 7575.507592006502, 7728.6522106505345, 974.668612671695, 1076.7146706122883, 1096.3860238266595, 1105.5522513382093, 1133.7052366384798, 32025.839870800963, 32260.35479290401, 32458.0, 32508.512372314435, 32750.344993100003, 1100.510272928539, 1118.0943435817014, 1178.393127539318, 1195.9521619135137, 1213.4296880466168, 16577.834221657627, 16733.247003884855, 17020.48938531846, 17094.48716538481, 17349.826501735075, 490678.0, 492599.0, 496940.0, 498807.0, 499434.0, 39072.60927390747, 39104.80447597801, 39238.60761392407, 39252.411213831816, 39304.21391572153, 1220.4873952939786, 1309.8297221361163, 1346.2393747532612, 1392.7005693775684, 1397.1477398786733, 32220.516692250105, 33378.0, 33802.0, 33820.661793381754, 34249.65750342465, 49768.25347619716, 53631.46368536264, 55151.724241378535, 55315.17027244675, 61421.692891535255, 475816.0, 476557.0, 480844.0, 482457.0, 482489.0, 24977.12580059762, 25891.870540647174, 26336.736632634194, 26755.866220668773, 28251.858740706164, 48809.26786098282, 48934.0, 49073.75463122661, 50022.74988625179, 50042.74978625084, 40553.797231013654, 41454.37818432786, 41564.1687166261, 42031.3695294577, 42847.14305713931, 41077.357649040605, 41079.794601026806, 41530.792346039285, 41534.169316614105, 42052.78973605113, 40488.3926741105, 41252.0, 41605.79197103995, 41681.58318416777, 41804.0, 35281.47077793886, 36588.0, 37755.81122094372, 37772.0, 37837.62162378341, 27907.441851162457, 28144.29639259035, 28390.574141388308, 28593.42813143767, 28620.42759144847], "value": 20860.553688130116, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.80510134729934, 381.59550876071364, 392.46232661254066, 394.90127468132965, 400.50137578714504, 17519.474415767516, 19400.805991940077, 19825.107870145843, 20162.19351225951, 20208.494787630316, 18528.44414667562, 18914.621707565875, 19080.522986925334, 19185.808141918576, 19279.614407711837, 5382.542483888874, 5390.299261096052, 5596.916046259309, 5617.831465056034, 5657.519110875581, 5501.504864562188, 5579.69311687857, 5597.44025597441, 5603.971980140093, 5614.775408983635, 5274.4461831507715, 5510.118381059031, 5538.169274608801, 5562.360328562207, 5565.276514053167, 5450.863728406782, 5467.535259502947, 5479.150731636602, 5498.395176530578, 5500.972495137538, 4795.304680821261, 4857.2714092886, 4866.58634016109, 4867.8783030424165, 4873.731944743037, 22351.77648223513, 22876.656850147094, 22895.198668046705, 23005.0, 23005.19481818145, 2419.5765740995257, 2469.3949982254285, 2798.608194852722, 2829.7170282971742, 3155.2742869139997, 13443.529476468277, 14245.928770356186, 14434.13395196281, 15023.774643380359, 15100.54698359051, 1970.724098626179, 2008.513699862106, 2025.9493512662302, 2131.840111991607, 2136.2309568555306, 55121.0, 78911.21088789096, 80209.59895200486, 80630.19369806343, 81008.59495702543, 9831.606735730491, 10030.74923126913, 10049.648262310784, 10207.0, 10224.948875255724, 13228.206307621573, 13230.140040897311, 13286.0, 13311.267880266485, 13314.600561983156, 7745.0, 7926.24700653437, 8004.1995800420655, 8011.919880801234, 8062.798430039296, 8003.909210578844, 8082.393820463489, 8092.8381432371025, 8233.38249631268, 8362.372822038371, 4063.532693740258, 4112.91774164521, 4191.245575796386, 4218.0, 4256.978715106405, 1678.3706110208673, 1722.603801125748, 1727.1911070987535, 1730.4030109612163, 1758.4373000639928, 929.7257309093834, 950.2113246005798, 962.451402700454, 963.1524258652341, 979.9363041402286, 17629.598536863312, 19010.904945475184, 19096.904515477334, 19249.422517324503, 19288.0, 1003.4180175498193, 1017.8422344536609, 1023.4780262066399, 1034.8602938603192, 1080.9459527023616, 10340.397238428055, 10600.098991585648, 10617.787644247072, 10773.0, 10825.0, 436626.0, 449966.0, 472409.0, 485776.0, 485916.0, 67213.0, 79679.99999999884, 91595.5420222908, 94014.0, 94657.05342946482, 980.6812785844629, 1003.1623594298696, 1018.1345856022322, 1033.7984093101923, 1041.8020576090519, 16361.590960226089, 16871.493855184362, 17139.143042848056, 17429.564260893578, 17716.645667086843, 40479.59520404758, 44705.32942005807, 45220.77389613031, 46349.0, 47015.52984470248, 58741.41258587359, 59554.0, 59747.103793442264, 60321.09518357316, 61434.38565614287, 7478.326950574475, 8100.635471403919, 8142.18578142181, 8224.095349511668, 8378.99452065756, 9112.544372781202, 11618.128640352177, 11998.340091295062, 12182.39088045612, 12256.693582660504, 10081.0, 10180.847287290548, 10187.235957303381, 10446.320989135682, 10590.417527036087, 10486.685399438029, 10536.367817930948, 10666.253362264568, 10964.342139471657, 11070.169737269576, 10236.129928956123, 10362.171026318027, 10481.475926203811, 10549.89450105489, 10576.788464230825, 7486.43851711113, 7847.882281765664, 7926.24700653437, 7990.400719945911, 8114.43198976066, 9155.542222888962, 10038.19694424459, 10197.949010255197, 10313.071823535618, 10452.58189672435], "value": 8936.024448709992, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1309.9803502947464, 1452.9491467798625, 1487.3232679130992, 1592.5859276588092, 1731.792184937807, 7964.641591128406, 8340.833183336337, 8346.081930987593, 8573.571321433934, 8578.828423431527, 8325.042620098691, 8510.106438823927, 8515.063343032278, 8520.616572254248, 8522.829543409143, 1822.7605228444652, 2196.8681879087308, 2273.27255278311, 2322.5238826040622, 2345.7302410222787, 2293.5642227976714, 2302.228753367624, 2304.2396009316885, 2307.411610039446, 2308.6421604651305, 2262.1743063781682, 2314.618088015475, 2316.513532158249, 2317.8145748340175, 2318.3624503261653, 2005.7693365262962, 2218.5784700906856, 2297.7702229777055, 2301.6432452969816, 2319.686842276288, 2186.409669389272, 2199.56008798241, 2200.8459407841456, 2211.624023915922, 2271.6251818449937, 8474.618642161118, 8486.363522735757, 8534.103919088468, 8541.273991710712, 8552.657893684245, 5051.520105589963, 5200.115980283361, 5204.401493828221, 5209.7134657593815, 5221.660592061542, 3176.5076413156, 3224.967750322514, 3266.7876588021704, 3291.2594666200152, 3295.571575695168, 983.5819776594918, 1002.1531805624236, 1010.3483253301579, 1027.23984251654, 1033.2095946600857, 11623.941880290544, 11666.941665291704, 11667.708307292301, 11670.241434306829, 11673.70815729605, 4526.094781043805, 4541.568550987651, 4630.699004564693, 4656.0, 4659.464161621389, 9867.210623150131, 9874.506274686237, 9877.802443951225, 9882.357646752938, 9891.060349266809, 4617.076584683077, 5224.746060945422, 5227.059129356752, 5231.346081739783, 5235.267062611238, 4658.720476771405, 4825.252085926687, 4834.347363105936, 4839.249916262985, 4840.685355451885, 3860.3244432224246, 3870.3807390817333, 3978.0, 3996.0, 3999.4000899864673, 1242.9627111186678, 1268.6067319131098, 1270.9872901271053, 1279.8848103670714, 1295.8185853980451, 1004.3170643962176, 1009.3893194617298, 1019.6176433837311, 1020.4846552491093, 1026.4867566216892, 5956.344802071769, 6038.5772995889865, 6104.755809767648, 6150.169727086786, 6189.535784816157, 442.674634143904, 453.3087042260579, 454.23234733300615, 458.749981260214, 461.6583728041225, 4165.333546632524, 4185.497740271187, 4186.518550366686, 4199.223143718422, 4218.156368726267, 9960.103590676874, 10217.386956782617, 10281.948590257001, 10305.896941030494, 10327.948360258151, 10173.84739228912, 10238.948805256076, 10239.0, 10245.334053286513, 10246.282760206863, 7424.554526728413, 7773.0, 7774.844503110019, 7877.842443151105, 7986.201379861967, 5881.676507792113, 5984.581079324405, 6038.215032045806, 6249.625022498482, 6270.184875966278, 9561.856572151562, 9565.808683826424, 9632.229421646392, 9650.903490965282, 9660.420374777535, 9515.619375224913, 9589.520523973913, 9887.406755594688, 10009.649662261785, 10040.69877903664, 7072.115985501812, 7348.77953661391, 7434.182239953709, 7521.05986751656, 7541.660625271767, 8339.374546909128, 8341.082480926972, 8362.665493380196, 8403.201695838885, 8404.621792019496, 7433.0, 7435.553866768011, 7452.701891924262, 7722.575258360619, 7736.342410894912, 7370.262973702587, 7402.814929626802, 7477.626118693935, 7566.659500322388, 7599.848003040019, 6517.0, 6534.444572211415, 6613.867722645617, 6616.933830661632, 6619.834504137242, 4965.45380008206, 5117.513836185556, 5211.0880595894805, 5262.500062494057, 5268.78924843002, 5223.973880130575, 5263.605229607718, 5307.097793375058, 5311.123664595299, 5316.362036555638], "value": 4439.459111171112, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.0985398002881, 307.6369883537425, 315.3944426700734, 321.4904376563147, 324.3545344763921, 5227.2159176123605, 5348.475684429934, 5363.0, 5410.783568657253, 5444.1833724941225, 5333.306670132887, 5339.5461385782255, 5354.170103633943, 5355.518003379695, 5369.731513424333, 4150.273702102135, 4159.625633692982, 4162.188373267214, 4162.979185104078, 4175.519815221258, 4072.9613948443107, 4154.376843473473, 4176.18564379946, 4183.493942180812, 4191.497020357561, 4069.1719255117705, 4092.9386059209137, 4117.023828562292, 4119.855805046824, 4138.358554424069, 4036.2331157080207, 4072.6131017553435, 4083.1629515949157, 4127.442795222667, 4141.544430112685, 3600.4959305697225, 3607.2244467439364, 3629.5825980012373, 3630.1650620357464, 3647.1246900743895, 5180.948190518085, 5197.454267301917, 5210.973945130288, 5247.1866860636665, 5271.42014378418, 4707.340972263886, 4712.929306060412, 4720.409948756405, 4736.2895565665085, 4742.762861856893, 5558.610897237195, 5564.554835613182, 5566.55467562594, 5568.276124103881, 5592.692401917893, 3852.499175107246, 3890.863819766323, 3900.8439662413753, 3905.5508616509183, 3962.128331767007, 5473.562115030828, 5617.41017193197, 5802.535797136219, 5819.505342045931, 5852.795152169653, 3982.143839074613, 4002.619751123697, 4019.376996565537, 4021.155557332934, 4024.215278020816, 3878.8254528545717, 3942.5466071402157, 4030.717849750548, 4054.189162167578, 4054.7972601369815, 4637.608717384771, 4646.140464014168, 4648.6518909516535, 4651.046560444622, 4651.37206477128, 5562.721863906789, 5578.41426650204, 5597.041035637494, 5609.018421776254, 5623.775048997994, 1367.9658008549666, 1408.2184387664945, 1425.2161311278755, 1426.5648977061887, 1438.101186758276, 863.3740538109946, 875.2429148786254, 878.2490970220497, 878.5826732302233, 881.4094556647062, 4724.811007559659, 4731.266653668687, 4784.330193772875, 4794.496577859344, 4803.615710743132, 4990.975045124751, 5005.399352077701, 5057.317262169634, 5067.543921047123, 5088.363954505687, 4468.687191896601, 4784.928226076611, 4787.210110331756, 4809.567138957441, 4812.903741925212, 2669.878650966599, 2674.6790385153517, 2695.2183866678442, 2704.269847141261, 2709.6883858356146, 5149.124648809711, 5172.301739265226, 5183.559397451183, 5191.870203244949, 5227.634065615446, 4806.327114204014, 5097.9098569586295, 5104.9744751276, 5137.563307118862, 5217.295665085241, 5123.718195499208, 5170.560502357342, 5193.584513238932, 5193.8964719288, 5198.610104242197, 5020.623453240948, 5047.444781074006, 5055.407546622802, 5074.0, 5499.615026948075, 5449.782008719607, 5607.8878422432135, 5615.034737841886, 5660.801871934463, 5668.574856885668, 5822.806324703341, 5863.853403664943, 5913.793017244376, 5939.138824870283, 5949.434803693643, 3838.347480928305, 4034.556198818069, 4040.0, 4092.386142078712, 4093.3655283431117, 5754.913676294943, 5769.884602308014, 5775.191473193672, 5790.652560846363, 5810.331811841524, 5632.155176723524, 5633.464820842013, 5641.605087643826, 5660.264165658438, 5663.943360566342, 5495.422980587141, 5568.6658800472105, 5578.3584887738425, 5582.525485333792, 5617.606767526234, 5462.8907421850545, 5489.533389661923, 5534.335879694301, 5534.730760388222, 5544.833654990357, 5381.973090134681, 5571.777128914798, 5591.4688104629995, 5598.852235291837, 5673.631213971079, 5399.163129714901, 5449.373322068013, 5459.727013649381, 5480.0, 5480.958617862593], "value": 4114.219063033122, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [759.722701214057, 786.8386980668963, 805.3396215103616, 810.6352141536306, 817.8364327134575, 17095.914520427395, 17764.555886102855, 17782.911085444553, 17807.28770849166, 17813.64372712545, 16717.080560569164, 16746.16269186539, 16832.747508787346, 16859.0, 16914.83085169148, 672.9932700673004, 794.1859593916254, 818.071488860145, 826.9586520673943, 829.3862541719114, 824.2499325613693, 827.0282418158639, 829.1501211258478, 829.6515463505342, 829.9170082991712, 867.7873920889359, 868.3834477520968, 868.9913100868973, 869.1959937058227, 869.395769939892, 697.6476879176034, 839.70190582343, 865.3942240431692, 870.7300736771621, 871.2202578692098, 631.210986267166, 631.5105793010454, 631.8736252749469, 631.9982827218863, 632.8417895526119, 15584.766228506582, 15613.765793513106, 15633.765493517607, 15634.843651563453, 15653.373865045498, 13956.72086558263, 14101.506447274398, 14140.85859141416, 14307.713845723027, 14324.713505729931, 13301.73396532064, 13323.200607963554, 13365.933170334183, 13679.179249245077, 13861.653458663513, 4462.2191116554795, 4612.262038073892, 4628.398308219944, 4635.327877457749, 4735.73953432561, 74887.99999999946, 77751.22248777554, 78185.60907195485, 78768.60615696943, 79365.0, 11014.229003969645, 11017.11863050954, 11325.830112548318, 11330.94334528322, 11492.597759078559, 20661.58676826455, 20912.163513459596, 20938.790612093988, 20944.685829712565, 20956.790432095484, 8431.620577074047, 8452.661893524313, 8473.95763021181, 8542.316614670812, 8659.567021648892, 4837.018893984038, 4851.199552073868, 4884.8290309838985, 4897.828575999894, 5002.499750024968, 3430.3310854383158, 3445.707114895262, 3519.8064106473876, 3545.13144279648, 3548.6806187443253, 601.5728832528954, 602.4457499100838, 612.4518555892452, 615.8429600451856, 618.5422787137576, 652.5008368598026, 670.7048898484651, 671.8723442545901, 673.9797806065826, 684.7979845945458, 8303.0, 8443.746687599381, 8681.131886811394, 8731.257843083282, 8922.643094276156, 528.7197785173864, 616.7841255560518, 643.6556442303345, 654.6661202786613, 662.9933700663028, 4142.171565686875, 4143.91712165755, 4176.248275310473, 4252.319628859368, 4255.340422234497, 109233.45383273033, 109911.0, 111858.0, 112279.0, 113493.0, 99188.0, 102075.4896225529, 102522.0, 104508.47745761374, 105441.0, 85755.5712221435, 87207.1279287199, 87582.56208718916, 89512.0, 90164.09835901688, 7167.211606723361, 7198.4601154914635, 7334.669939852826, 7394.8890766639615, 7400.5189662671755, 51889.481105189974, 52103.47896520986, 53199.73400132974, 53586.73206633942, 54433.0, 76186.0, 78235.60882195552, 78902.6054869722, 80249.19750802651, 82290.58854705688, 11205.271657342246, 11358.375289358833, 12036.338001409656, 12882.935585322013, 13264.53574124901, 14390.640233994234, 15228.847711523185, 15762.290696918437, 16105.436309729103, 16158.596035099217, 14763.0, 14948.626284342978, 15219.771703424236, 15459.922700386876, 15607.609809754847, 13468.5286014989, 14301.856981430052, 14315.427382904567, 14326.355314010687, 14921.925390372979, 13226.537071202461, 14292.213928234047, 14445.711085778436, 14459.783103253249, 14774.335154917839, 11668.066554675775, 12058.792828348616, 12167.33079680626, 12275.570355037531, 12341.259524428562, 11955.71444133023, 12376.381180941096, 12526.812097818358, 12627.242365458102, 12825.486980521047], "value": 7650.121078553838, "unit": "score"}], "name": "dromaeo_css", "value": 7162.352101610997, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 111.0, 111.0, 110.0, 111.0, 110.0, 113.0, 111.0, 110.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 137.0, 134.0, 183.0, 126.0, 134.0, 163.0, 125.0, 171.0, 128.0], "value": 146.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 159.0, 160.0, 160.0, 161.0, 162.0, 161.0, 162.0, 161.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 75.0, 123.0, 74.0, 76.0, 78.0, 75.0, 103.0, 74.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 125.0, 85.0, 84.0, 84.0, 119.0, 86.0, 85.0, 133.0], "value": 96.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 145.0, 147.0, 145.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 52.0, 52.0, 53.0, 54.0, 53.0, 54.0, 54.0, 54.0, 54.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 61.0, 62.0, 62.0, 62.0], "value": 61.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 78.0, 84.0, 79.0, 80.0, 81.0, 80.0, 95.0, 80.0], "value": 81.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 122.0, 119.0, 121.0, 119.0, 128.0, 121.0, 128.0, 123.0, 128.0], "value": 123.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 158.0, 158.0, 158.0, 162.0, 166.0, 161.0, 168.0, 164.0], "value": 161.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 68.0, 63.0, 67.0, 63.0, 64.0, 66.0, 66.0, 62.0, 67.0], "value": 65.0, "unit": "score"}], "name": "kraken", "value": 1500.4, "alertThreshold": 2.0}]} 16:35:54 INFO - Return code: 0 16:35:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:35:54 INFO - # TBPL SUCCESS # 16:35:54 INFO - Running post-action listener: _resource_record_post_action 16:35:54 INFO - ##### 16:35:54 INFO - ##### Finished run-tests step (success) 16:35:54 INFO - ##### 16:35:54 INFO - Running post-run listener: _resource_record_post_run 16:35:54 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 12288; Write bytes: 553697280; Read time: 216; Write time: 498244 16:35:54 INFO - TinderboxPrint: CPU usage
13.1% 16:35:54 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 216 16:35:54 INFO - TinderboxPrint: I/O write bytes / time
553,697,280 / 498,244 16:35:54 INFO - TinderboxPrint: CPU idle
8,269.4 (86.8%) 16:35:54 INFO - TinderboxPrint: CPU user
1,206.3 (12.7%) 16:35:54 INFO - TinderboxPrint: Swap in / out
0 / 0 16:35:54 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 256708608; Read time: 0; Write time: 239656 16:35:54 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 12288; Write bytes: 296988672; Read time: 216; Write time: 258588 16:35:54 INFO - Running post-run listener: _upload_blobber_files 16:35:54 INFO - Blob upload gear active. 16:35:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:35:54 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 16:35:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:35:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:35:55 INFO - (blobuploader) - INFO - Open directory for files ... 16:35:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:35:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:35:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:35:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:35:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:35:56 INFO - (blobuploader) - INFO - Done attempting. 16:35:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:35:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:35:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:35:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:35:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:35:59 INFO - (blobuploader) - INFO - Done attempting. 16:35:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:35:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:35:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:36:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:36:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:36:00 INFO - (blobuploader) - INFO - Done attempting. 16:36:00 INFO - (blobuploader) - INFO - Iteration through files over. 16:36:00 INFO - Return code: 0 16:36:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:36:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:36:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/22558acfdbfca0e8546c970a0da87469d5ad93b89eb8b138e99bbc7525299f0dbdda4cacb458509a326dc1345d0bae4fa9270c32a1b0c8b38f5fc1ee6e3fb924", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/56395c88607e73e9c51b98d6815813c4fff65842cd0a2385e07a798ef0ad7aac0760b63f6438e40cc97b54fd5598bc37fd0b5f4d6fa06337b433a03669c5683a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4a0da0aef16f84811bc12e0647d990c626c2c50f0ef26cdccf3e36d7586fe4be286ea09d04ce01d0bf021be4db1acb4c18b5216b9890b698b57a6eb08f21db2c"} 16:36:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:36:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:36:00 INFO - Contents: 16:36:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/22558acfdbfca0e8546c970a0da87469d5ad93b89eb8b138e99bbc7525299f0dbdda4cacb458509a326dc1345d0bae4fa9270c32a1b0c8b38f5fc1ee6e3fb924", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/56395c88607e73e9c51b98d6815813c4fff65842cd0a2385e07a798ef0ad7aac0760b63f6438e40cc97b54fd5598bc37fd0b5f4d6fa06337b433a03669c5683a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4a0da0aef16f84811bc12e0647d990c626c2c50f0ef26cdccf3e36d7586fe4be286ea09d04ce01d0bf021be4db1acb4c18b5216b9890b698b57a6eb08f21db2c"} 16:36:00 INFO - Running post-run listener: copy_logs_to_upload_dir 16:36:00 INFO - Copying logs to upload dir... 16:36:00 INFO - mkdir: /builds/slave/test/build/upload/logs 16:36:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.165404 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-06-27 16:36:00.314770) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 16:36:00.318863) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6dbc10da6d83fee962c624be000001a8-1467068234.13290-104159833 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/22558acfdbfca0e8546c970a0da87469d5ad93b89eb8b138e99bbc7525299f0dbdda4cacb458509a326dc1345d0bae4fa9270c32a1b0c8b38f5fc1ee6e3fb924", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/56395c88607e73e9c51b98d6815813c4fff65842cd0a2385e07a798ef0ad7aac0760b63f6438e40cc97b54fd5598bc37fd0b5f4d6fa06337b433a03669c5683a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4a0da0aef16f84811bc12e0647d990c626c2c50f0ef26cdccf3e36d7586fe4be286ea09d04ce01d0bf021be4db1acb4c18b5216b9890b698b57a6eb08f21db2c"} build_url:https://queue.taskcluster.net/v1/task/VNU6M3wTRaOcJMHYR8ouBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011185 build_url: 'https://queue.taskcluster.net/v1/task/VNU6M3wTRaOcJMHYR8ouBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/22558acfdbfca0e8546c970a0da87469d5ad93b89eb8b138e99bbc7525299f0dbdda4cacb458509a326dc1345d0bae4fa9270c32a1b0c8b38f5fc1ee6e3fb924", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/56395c88607e73e9c51b98d6815813c4fff65842cd0a2385e07a798ef0ad7aac0760b63f6438e40cc97b54fd5598bc37fd0b5f4d6fa06337b433a03669c5683a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4a0da0aef16f84811bc12e0647d990c626c2c50f0ef26cdccf3e36d7586fe4be286ea09d04ce01d0bf021be4db1acb4c18b5216b9890b698b57a6eb08f21db2c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 16:36:00.349417) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 16:36:00.349932) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6dbc10da6d83fee962c624be000001a8-1467068234.13290-104159833 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004388 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 16:36:00.432309) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 16:36:00.432686) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 16:36:00.433059) ========= ========= Total master_lag: 0.22 =========