builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-042 starttime: 1465505064.45 results: success (0) buildid: 20160609031135 builduid: b7e12a9c3411425faa1664d3e023b6f5 revision: 1ae7a82e2b1d2b18ccfa9a578040b46c774bc501 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 13:44:24.449823) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 13:44:24.450231) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 13:44:24.450533) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 13:44:24.467634) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 13:44:24.468016) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1465505064.271795-1226615883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 13:44:25-- 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% 30.2M=0s 2016-06-09 13:44:25 (30.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115514 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 13:44:24.597074) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 13:44:24.597381) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1465505064.271795-1226615883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019527 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 13:44:24.646346) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-09 13:44:24.646705) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1ae7a82e2b1d2b18ccfa9a578040b46c774bc501 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1ae7a82e2b1d2b18ccfa9a578040b46c774bc501 --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=74d6aec007b0fa31a864ebd7000001f8-1465505064.271795-1226615883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 13:44:25,310 truncating revision to first 12 chars 2016-06-09 13:44:25,310 Setting DEBUG logging. 2016-06-09 13:44:25,310 attempt 1/10 2016-06-09 13:44:25,310 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1ae7a82e2b1d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-09 13:44:26,733 unpacking tar archive at: mozilla-aurora-1ae7a82e2b1d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.769298 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-09 13:44:26.429408) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 13:44:26.429739) ========= script_repo_revision: 1ae7a82e2b1d2b18ccfa9a578040b46c774bc501 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 13:44:26.430132) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 13:44:26.430406) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 13:44:26.438770) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-06-09 13:44:26.439090) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1465505064.271795-1226615883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:44:27 INFO - MultiFileLogger online at 20160609 13:44:27 in /builds/slave/test 13:44:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 13:44:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:44:27 INFO - {'append_to_log': False, 13:44:27 INFO - 'base_work_dir': '/builds/slave/test', 13:44:27 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 13:44:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:44:27 INFO - 'branch': 'Mozilla-Aurora', 13:44:27 INFO - 'buildbot_json_path': 'buildprops.json', 13:44:27 INFO - 'config_files': ('talos/linux_config.py',), 13:44:27 INFO - 'default_actions': ('clobber', 13:44:27 INFO - 'read-buildbot-config', 13:44:27 INFO - 'download-and-extract', 13:44:27 INFO - 'populate-webroot', 13:44:27 INFO - 'create-virtualenv', 13:44:27 INFO - 'install', 13:44:27 INFO - 'run-tests'), 13:44:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:44:27 INFO - 'download_minidump_stackwalk': True, 13:44:27 INFO - 'download_symbols': 'ondemand', 13:44:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:44:27 INFO - 'tooltool.py': '/tools/tooltool.py', 13:44:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:44:27 INFO - '/tools/misc-python/virtualenv.py')}, 13:44:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:44:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:44:27 INFO - 'installer_path': 'installer.exe', 13:44:27 INFO - 'log_level': 'info', 13:44:27 INFO - 'log_name': 'talos', 13:44:27 INFO - 'log_to_console': True, 13:44:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:44:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:44:27 INFO - 'opt_config_files': (), 13:44:27 INFO - 'pip_index': False, 13:44:27 INFO - 'sps_profile': False, 13:44:27 INFO - 'sps_profile_interval': 0, 13:44:27 INFO - 'suite': 'dromaeojs-e10s', 13:44:27 INFO - 'system_bits': '32', 13:44:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:44:27 INFO - 'title': 'talos-linux64-ix-042', 13:44:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:44:27 INFO - 'use_talos_json': True, 13:44:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:44:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:44:27 INFO - 'work_dir': 'build'} 13:44:27 INFO - ##### 13:44:27 INFO - ##### Running clobber step. 13:44:27 INFO - ##### 13:44:27 INFO - Running pre-action listener: _resource_record_pre_action 13:44:27 INFO - Running main action method: clobber 13:44:27 INFO - rmtree: /builds/slave/test/build 13:44:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:44:27 INFO - Running post-action listener: _resource_record_post_action 13:44:27 INFO - ##### 13:44:27 INFO - ##### Finished clobber step (success) 13:44:27 INFO - ##### 13:44:27 INFO - ##### 13:44:27 INFO - ##### Running read-buildbot-config step. 13:44:27 INFO - ##### 13:44:27 INFO - Running pre-action listener: _resource_record_pre_action 13:44:27 INFO - Running main action method: read_buildbot_config 13:44:27 INFO - Using buildbot properties: 13:44:27 INFO - { 13:44:27 INFO - "project": "", 13:44:27 INFO - "product": "firefox", 13:44:27 INFO - "script_repo_revision": "production", 13:44:27 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 13:44:27 INFO - "repository": "", 13:44:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 13:44:27 INFO - "buildid": "20160609031135", 13:44:27 INFO - "pgo_build": "True", 13:44:27 INFO - "basedir": "/builds/slave/test", 13:44:27 INFO - "buildnumber": 398, 13:44:27 INFO - "slavename": "talos-linux64-ix-042", 13:44:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:44:27 INFO - "platform": "ubuntu64_hw", 13:44:27 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 13:44:27 INFO - "branch": "mozilla-aurora", 13:44:27 INFO - "repo_path": "releases/mozilla-aurora", 13:44:27 INFO - "revision": "1ae7a82e2b1d2b18ccfa9a578040b46c774bc501", 13:44:27 INFO - "stage_platform": "linux64-pgo", 13:44:27 INFO - "builduid": "b7e12a9c3411425faa1664d3e023b6f5", 13:44:27 INFO - "slavebuilddir": "test" 13:44:27 INFO - } 13:44:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 13:44:27 INFO - Running post-action listener: _resource_record_post_action 13:44:27 INFO - ##### 13:44:27 INFO - ##### Finished read-buildbot-config step (success) 13:44:27 INFO - ##### 13:44:27 INFO - ##### 13:44:27 INFO - ##### Running download-and-extract step. 13:44:27 INFO - ##### 13:44:27 INFO - Running pre-action listener: _resource_record_pre_action 13:44:27 INFO - Running main action method: download_and_extract 13:44:27 INFO - mkdir: /builds/slave/test/build/tests 13:44:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:27 INFO - https://queue.taskcluster.net/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:44:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 13:44:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 13:44:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 13:44:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:44:28 INFO - Downloaded 1361 bytes. 13:44:28 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 13:44:28 INFO - Using the following test package requirements: 13:44:28 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 13:44:28 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 13:44:28 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 13:44:28 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 13:44:28 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 13:44:28 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 13:44:28 INFO - u'jsshell-linux-x86_64.zip'], 13:44:28 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 13:44:28 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 13:44:28 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 13:44:28 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 13:44:28 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 13:44:28 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 13:44:28 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 13:44:28 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 13:44:28 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 13:44:28 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 13:44:28 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 13:44:28 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:44:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:28 INFO - https://queue.taskcluster.net/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:44:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 13:44:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 13:44:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 13:44:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:44:29 INFO - Downloaded 24472728 bytes. 13:44:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:44:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:44:30 INFO - Return code: 0 13:44:30 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:44:30 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')]} 13:44:30 INFO - https://queue.taskcluster.net/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:44:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 13:44:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 13:44:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 13:44:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:44:31 INFO - Downloaded 24472728 bytes. 13:44:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:44:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:44:33 INFO - Return code: 0 13:44: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')]} 13:44:33 INFO - https://queue.taskcluster.net/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:44:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 13:44:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 13:44:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 13:44:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:44:35 INFO - Downloaded 10833369 bytes. 13:44:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:44:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 13:44:35 INFO - Return code: 0 13:44:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:35 INFO - https://queue.taskcluster.net/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:44:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 13:44:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 13:44:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 13:44:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:44:37 INFO - Downloaded 63540841 bytes. 13:44:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 13:44:37 INFO - mkdir: /builds/slave/test/properties 13:44:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:44:37 INFO - Writing to file /builds/slave/test/properties/build_url 13:44:37 INFO - Contents: 13:44:37 INFO - build_url:https://queue.taskcluster.net/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 13:44:38 INFO - Running post-action listener: _resource_record_post_action 13:44:38 INFO - Running post-action listener: set_extra_try_arguments 13:44:38 INFO - ##### 13:44:38 INFO - ##### Finished download-and-extract step (success) 13:44:38 INFO - ##### 13:44:38 INFO - ##### 13:44:38 INFO - ##### Running populate-webroot step. 13:44:38 INFO - ##### 13:44:38 INFO - Running pre-action listener: _resource_record_pre_action 13:44:38 INFO - Running main action method: populate_webroot 13:44:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:44:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:44:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:44:38 INFO - '--tppagecycles', 13:44:38 INFO - '7'], 13:44:38 INFO - 'tests': ['tsvgm']}}, 13:44:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:44:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:44:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:44:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:44:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:44:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:44:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:44:38 INFO - 'talos_options': ['--disable-e10s'], 13:44:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:44:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:44:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:44:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:44:38 INFO - 'talos_options': ['--disable-e10s'], 13:44:38 INFO - 'tests': ['damp', 'tps']}, 13:44:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:44:38 INFO - 'tests': ['damp', 'tps']}, 13:44:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:44:38 INFO - 'tests': ['dromaeo_dom']}, 13:44:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:44:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:44:38 INFO - 'tests': ['a11yr', 13:44:38 INFO - 'ts_paint', 13:44:38 INFO - 'tpaint', 13:44:38 INFO - 'sessionrestore', 13:44:38 INFO - 'sessionrestore_no_auto_restore', 13:44:38 INFO - 'tabpaint']}, 13:44:38 INFO - 'other-e10s': {'tests': ['a11yr', 13:44:38 INFO - 'ts_paint', 13:44:38 INFO - 'tpaint', 13:44:38 INFO - 'sessionrestore', 13:44:38 INFO - 'sessionrestore_no_auto_restore', 13:44:38 INFO - 'tabpaint']}, 13:44:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:44:38 INFO - 'ts_paint', 13:44:38 INFO - 'tpaint', 13:44:38 INFO - 'sessionrestore', 13:44:38 INFO - 'sessionrestore_no_auto_restore', 13:44:38 INFO - 'tabpaint']}, 13:44:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:44:38 INFO - 'ts_paint', 13:44:38 INFO - 'tpaint', 13:44:38 INFO - 'sessionrestore', 13:44:38 INFO - 'sessionrestore_no_auto_restore', 13:44:38 INFO - 'tabpaint']}, 13:44:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:44:38 INFO - 'tests': ['a11yr', 13:44:38 INFO - 'ts_paint', 13:44:38 INFO - 'tpaint', 13:44:38 INFO - 'sessionrestore', 13:44:38 INFO - 'sessionrestore_no_auto_restore', 13:44:38 INFO - 'tabpaint']}, 13:44:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:44:38 INFO - 'tests': ['a11yr', 13:44:38 INFO - 'ts_paint', 13:44:38 INFO - 'tpaint', 13:44:38 INFO - 'sessionrestore', 13:44:38 INFO - 'sessionrestore_no_auto_restore', 13:44:38 INFO - 'tabpaint']}, 13:44:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:44:38 INFO - 'tests': ['tsvgx', 13:44:38 INFO - 'tsvgr_opacity', 13:44:38 INFO - 'tart', 13:44:38 INFO - 'tscrollx', 13:44:38 INFO - 'cart']}, 13:44:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:44:38 INFO - 'tsvgr_opacity', 13:44:38 INFO - 'tart', 13:44:38 INFO - 'tscrollx', 13:44:38 INFO - 'cart']}, 13:44:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:44:38 INFO - 'talos_options': ['--disable-e10s'], 13:44:38 INFO - 'tests': ['tp5o']}, 13:44:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:44:38 INFO - 'tests': ['tp5o']}, 13:44:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:44:38 INFO - 'talos_options': ['--disable-e10s', 13:44:38 INFO - '--xperf_path', 13:44:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:44:38 INFO - 'tests': ['tp5n']}, 13:44:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:44:38 INFO - 'talos_options': ['--xperf_path', 13:44:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:44:38 INFO - 'tests': ['tp5n']}}, 13:44:38 INFO - 'talos.zip': {'path': '', 13:44:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:44:38 INFO - Running post-action listener: _resource_record_post_action 13:44:38 INFO - ##### 13:44:38 INFO - ##### Finished populate-webroot step (success) 13:44:38 INFO - ##### 13:44:38 INFO - ##### 13:44:38 INFO - ##### Running create-virtualenv step. 13:44:38 INFO - ##### 13:44:38 INFO - Running pre-action listener: _resource_record_pre_action 13:44:38 INFO - Running main action method: create_virtualenv 13:44:38 INFO - Creating virtualenv /builds/slave/test/build/venv 13:44:38 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 13:44:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:44:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:44:38 INFO - Using real prefix '/usr' 13:44:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:44:38 INFO - Installing distribute.............................................................................................................................................................................................done. 13:44:40 INFO - Installing pip.................done. 13:44:40 INFO - Return code: 0 13:44:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:44:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3f2f555f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24351c0>, '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 0x24360c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2436550>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465505064.271795-1226615883', '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 13:44:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:44:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:44:40 INFO - Using env: {'DISPLAY': ':0', 13:44:40 INFO - 'HOME': '/home/cltbld', 13:44:40 INFO - 'LANG': 'en_US.UTF-8', 13:44:40 INFO - 'LANGUAGE': 'en_US:en', 13:44:40 INFO - 'LOGNAME': 'cltbld', 13:44:40 INFO - 'MAIL': '/var/mail/cltbld', 13:44:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:40 INFO - 'MOZ_NO_REMOTE': '1', 13:44:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:40 INFO - 'NO_EM_RESTART': '1', 13:44:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:40 INFO - 'PWD': '/builds/slave/test', 13:44:40 INFO - 'SHELL': '/bin/bash', 13:44:40 INFO - 'SHLVL': '1', 13:44:40 INFO - 'TERM': 'linux', 13:44:40 INFO - 'TMOUT': '86400', 13:44:40 INFO - 'USER': 'cltbld', 13:44:40 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465505064.271795-1226615883', 13:44:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:40 INFO - '_': '/tools/buildbot/bin/python'} 13:44:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:40 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 13:44:40 INFO - Cleaning up... 13:44:40 INFO - Return code: 0 13:44:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:44:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3f2f555f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24351c0>, '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 0x24360c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2436550>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465505064.271795-1226615883', '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 13:44:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:44:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:44:40 INFO - Using env: {'DISPLAY': ':0', 13:44:40 INFO - 'HOME': '/home/cltbld', 13:44:40 INFO - 'LANG': 'en_US.UTF-8', 13:44:40 INFO - 'LANGUAGE': 'en_US:en', 13:44:40 INFO - 'LOGNAME': 'cltbld', 13:44:40 INFO - 'MAIL': '/var/mail/cltbld', 13:44:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:40 INFO - 'MOZ_NO_REMOTE': '1', 13:44:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:40 INFO - 'NO_EM_RESTART': '1', 13:44:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:40 INFO - 'PWD': '/builds/slave/test', 13:44:40 INFO - 'SHELL': '/bin/bash', 13:44:40 INFO - 'SHLVL': '1', 13:44:40 INFO - 'TERM': 'linux', 13:44:40 INFO - 'TMOUT': '86400', 13:44:40 INFO - 'USER': 'cltbld', 13:44:40 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465505064.271795-1226615883', 13:44:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:40 INFO - '_': '/tools/buildbot/bin/python'} 13:44:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:41 INFO - Downloading/unpacking psutil>=3.1.1 13:44:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:44:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:44:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:44:43 INFO - Installing collected packages: psutil 13:44:43 INFO - Running setup.py install for psutil 13:44:43 INFO - building 'psutil._psutil_linux' extension 13:44:43 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 13:44:43 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 13:44:43 INFO - building 'psutil._psutil_posix' extension 13:44:43 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 13:44:43 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 13:44:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:44:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:44:43 INFO - Successfully installed psutil 13:44:43 INFO - Cleaning up... 13:44:43 INFO - Return code: 0 13:44:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:44:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3f2f555f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24351c0>, '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 0x24360c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2436550>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465505064.271795-1226615883', '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 13:44:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:44:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:44:43 INFO - Using env: {'DISPLAY': ':0', 13:44:43 INFO - 'HOME': '/home/cltbld', 13:44:43 INFO - 'LANG': 'en_US.UTF-8', 13:44:43 INFO - 'LANGUAGE': 'en_US:en', 13:44:43 INFO - 'LOGNAME': 'cltbld', 13:44:43 INFO - 'MAIL': '/var/mail/cltbld', 13:44:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:43 INFO - 'MOZ_NO_REMOTE': '1', 13:44:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:43 INFO - 'NO_EM_RESTART': '1', 13:44:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:43 INFO - 'PWD': '/builds/slave/test', 13:44:43 INFO - 'SHELL': '/bin/bash', 13:44:43 INFO - 'SHLVL': '1', 13:44:43 INFO - 'TERM': 'linux', 13:44:43 INFO - 'TMOUT': '86400', 13:44:43 INFO - 'USER': 'cltbld', 13:44:43 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465505064.271795-1226615883', 13:44:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:43 INFO - '_': '/tools/buildbot/bin/python'} 13:44:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:44:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:44:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:44:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:44:45 INFO - Installing collected packages: mozsystemmonitor 13:44:45 INFO - Running setup.py install for mozsystemmonitor 13:44:45 INFO - Successfully installed mozsystemmonitor 13:44:45 INFO - Cleaning up... 13:44:45 INFO - Return code: 0 13:44:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:44:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3f2f555f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24351c0>, '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 0x24360c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2436550>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465505064.271795-1226615883', '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 13:44:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:44:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:44:45 INFO - Using env: {'DISPLAY': ':0', 13:44:45 INFO - 'HOME': '/home/cltbld', 13:44:45 INFO - 'LANG': 'en_US.UTF-8', 13:44:45 INFO - 'LANGUAGE': 'en_US:en', 13:44:45 INFO - 'LOGNAME': 'cltbld', 13:44:45 INFO - 'MAIL': '/var/mail/cltbld', 13:44:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:45 INFO - 'MOZ_NO_REMOTE': '1', 13:44:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:45 INFO - 'NO_EM_RESTART': '1', 13:44:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:45 INFO - 'PWD': '/builds/slave/test', 13:44:45 INFO - 'SHELL': '/bin/bash', 13:44:45 INFO - 'SHLVL': '1', 13:44:45 INFO - 'TERM': 'linux', 13:44:45 INFO - 'TMOUT': '86400', 13:44:45 INFO - 'USER': 'cltbld', 13:44:45 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465505064.271795-1226615883', 13:44:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:45 INFO - '_': '/tools/buildbot/bin/python'} 13:44:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:46 INFO - Downloading/unpacking jsonschema==2.5.1 13:44: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 13:44: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 13:44: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 13:44: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 13:44: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 13:44: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 13:44:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:44:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:44:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:48 INFO - Downloading functools32-3.2.3-2.tar.gz 13:44:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:44:48 INFO - warning: no files found matching '*.txt' 13:44:48 INFO - no previously-included directories found matching 'build' 13:44:48 INFO - no previously-included directories found matching 'dist' 13:44:48 INFO - no previously-included directories found matching '.git*' 13:44:48 INFO - Installing collected packages: jsonschema, functools32 13:44:48 INFO - Running setup.py install for functools32 13:44:48 INFO - warning: no files found matching '*.txt' 13:44:48 INFO - no previously-included directories found matching 'build' 13:44:48 INFO - no previously-included directories found matching 'dist' 13:44:48 INFO - no previously-included directories found matching '.git*' 13:44:48 INFO - Successfully installed jsonschema functools32 13:44:48 INFO - Cleaning up... 13:44:48 INFO - Return code: 0 13:44:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:44:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:48 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 0x7f3f2f555f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24351c0>, '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 0x24360c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2436550>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465505064.271795-1226615883', '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 13:44:48 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 13:44:48 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 13:44:48 INFO - Using env: {'DISPLAY': ':0', 13:44:48 INFO - 'HOME': '/home/cltbld', 13:44:48 INFO - 'LANG': 'en_US.UTF-8', 13:44:48 INFO - 'LANGUAGE': 'en_US:en', 13:44:48 INFO - 'LOGNAME': 'cltbld', 13:44:48 INFO - 'MAIL': '/var/mail/cltbld', 13:44:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:48 INFO - 'MOZ_NO_REMOTE': '1', 13:44:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:48 INFO - 'NO_EM_RESTART': '1', 13:44:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:48 INFO - 'PWD': '/builds/slave/test', 13:44:48 INFO - 'SHELL': '/bin/bash', 13:44:48 INFO - 'SHLVL': '1', 13:44:48 INFO - 'TERM': 'linux', 13:44:48 INFO - 'TMOUT': '86400', 13:44:48 INFO - 'USER': 'cltbld', 13:44:48 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465505064.271795-1226615883', 13:44:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:48 INFO - '_': '/tools/buildbot/bin/python'} 13:44:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:48 INFO - Downloading/unpacking blobuploader==1.2.4 13:44:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:50 INFO - Downloading blobuploader-1.2.4.tar.gz 13:44:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:44:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:44:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:44:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:44:51 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 13:44:51 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 13:44:51 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 13:44:51 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 13:44:51 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 13:44:51 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 13:44:51 INFO - Downloading docopt-0.6.1.tar.gz 13:44:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:44:51 INFO - Installing collected packages: blobuploader, requests, docopt 13:44:51 INFO - Running setup.py install for blobuploader 13:44:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:44:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:44:51 INFO - Running setup.py install for requests 13:44:51 INFO - Running setup.py install for docopt 13:44:51 INFO - Successfully installed blobuploader requests docopt 13:44:51 INFO - Cleaning up... 13:44:52 INFO - Return code: 0 13:44:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:44:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:52 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 0x7f3f2f555f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24351c0>, '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 0x24360c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2436550>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465505064.271795-1226615883', '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 13:44:52 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 13:44:52 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 13:44:52 INFO - Using env: {'DISPLAY': ':0', 13:44:52 INFO - 'HOME': '/home/cltbld', 13:44:52 INFO - 'LANG': 'en_US.UTF-8', 13:44:52 INFO - 'LANGUAGE': 'en_US:en', 13:44:52 INFO - 'LOGNAME': 'cltbld', 13:44:52 INFO - 'MAIL': '/var/mail/cltbld', 13:44:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:52 INFO - 'MOZ_NO_REMOTE': '1', 13:44:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:52 INFO - 'NO_EM_RESTART': '1', 13:44:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:52 INFO - 'PWD': '/builds/slave/test', 13:44:52 INFO - 'SHELL': '/bin/bash', 13:44:52 INFO - 'SHLVL': '1', 13:44:52 INFO - 'TERM': 'linux', 13:44:52 INFO - 'TMOUT': '86400', 13:44:52 INFO - 'USER': 'cltbld', 13:44:52 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465505064.271795-1226615883', 13:44:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:52 INFO - '_': '/tools/buildbot/bin/python'} 13:44:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:44:52 INFO - Running setup.py (path:/tmp/pip-9qXqgK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:44:52 INFO - Running setup.py (path:/tmp/pip-iUHGZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:44:52 INFO - Running setup.py (path:/tmp/pip-9Rh7cJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:44:52 INFO - Running setup.py (path:/tmp/pip-cDGIFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:44:52 INFO - Running setup.py (path:/tmp/pip-grWlLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:44:52 INFO - Running setup.py (path:/tmp/pip-O8XWAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:44:52 INFO - Running setup.py (path:/tmp/pip-LyORHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:44:52 INFO - Running setup.py (path:/tmp/pip-9_gC7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:44:52 INFO - Running setup.py (path:/tmp/pip-kG6Z36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:44:52 INFO - Running setup.py (path:/tmp/pip-DsEYlN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:44:52 INFO - Running setup.py (path:/tmp/pip-lJrkBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:44:53 INFO - Running setup.py (path:/tmp/pip-83lEl1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:44:53 INFO - Running setup.py (path:/tmp/pip-NKIUAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:44:53 INFO - Running setup.py (path:/tmp/pip-Ri7iNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:44:53 INFO - Running setup.py (path:/tmp/pip-A8G2I4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:44:53 INFO - Running setup.py (path:/tmp/pip-Zk9dJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:44:53 INFO - Running setup.py (path:/tmp/pip-S2mszI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:44:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:44:53 INFO - Running setup.py install for manifestparser 13:44:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:44:53 INFO - Running setup.py install for mozcrash 13:44:53 INFO - Running setup.py install for mozdebug 13:44:53 INFO - Running setup.py install for mozdevice 13:44:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:44:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:44:53 INFO - Running setup.py install for mozfile 13:44:54 INFO - Running setup.py install for mozhttpd 13:44:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:44:54 INFO - Running setup.py install for mozinfo 13:44:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:44:54 INFO - Running setup.py install for mozInstall 13:44:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:44:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:44:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:44:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:44:54 INFO - Running setup.py install for mozleak 13:44:54 INFO - Running setup.py install for mozlog 13:44:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:44:54 INFO - Running setup.py install for moznetwork 13:44:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:44:54 INFO - Running setup.py install for mozprocess 13:44:54 INFO - Running setup.py install for mozprofile 13:44:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:44:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:44:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:44:54 INFO - Running setup.py install for mozrunner 13:44:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:44:54 INFO - Running setup.py install for mozscreenshot 13:44:55 INFO - Running setup.py install for moztest 13:44:55 INFO - Running setup.py install for mozversion 13:44:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:44:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:44:55 INFO - Cleaning up... 13:44:55 INFO - Return code: 0 13:44:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:44:55 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')]} 13:44:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:55 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')]} 13:44:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:55 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 0x7f3f2f555f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24351c0>, '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 0x24360c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2436550>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465505064.271795-1226615883', '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 13:44:55 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 13:44:55 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 13:44:55 INFO - Using env: {'DISPLAY': ':0', 13:44:55 INFO - 'HOME': '/home/cltbld', 13:44:55 INFO - 'LANG': 'en_US.UTF-8', 13:44:55 INFO - 'LANGUAGE': 'en_US:en', 13:44:55 INFO - 'LOGNAME': 'cltbld', 13:44:55 INFO - 'MAIL': '/var/mail/cltbld', 13:44:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:55 INFO - 'MOZ_NO_REMOTE': '1', 13:44:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:55 INFO - 'NO_EM_RESTART': '1', 13:44:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:55 INFO - 'PWD': '/builds/slave/test', 13:44:55 INFO - 'SHELL': '/bin/bash', 13:44:55 INFO - 'SHLVL': '1', 13:44:55 INFO - 'TERM': 'linux', 13:44:55 INFO - 'TMOUT': '86400', 13:44:55 INFO - 'USER': 'cltbld', 13:44:55 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465505064.271795-1226615883', 13:44:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:55 INFO - '_': '/tools/buildbot/bin/python'} 13:44:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:44:55 INFO - Running setup.py (path:/tmp/pip-Uuin7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:44:55 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)) 13:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:44:55 INFO - Running setup.py (path:/tmp/pip-wUVdlP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:44:55 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)) 13:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:44:55 INFO - Running setup.py (path:/tmp/pip-JKFPSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:44:55 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)) 13:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:44:55 INFO - Running setup.py (path:/tmp/pip-aw5hsF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:44:55 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)) 13:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:44:55 INFO - Running setup.py (path:/tmp/pip-FM_lGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:44:55 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)) 13:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:44:55 INFO - Running setup.py (path:/tmp/pip-6fkULD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:44:55 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)) 13:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:44:55 INFO - Running setup.py (path:/tmp/pip-tQNgeg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:44:55 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)) 13:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:44:55 INFO - Running setup.py (path:/tmp/pip-1vtVYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:44:56 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)) 13:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:44:56 INFO - Running setup.py (path:/tmp/pip-AxtrLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:44:56 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)) 13:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:44:56 INFO - Running setup.py (path:/tmp/pip-dz_VQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:44:56 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)) 13:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:44:56 INFO - Running setup.py (path:/tmp/pip-FLLKiw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:44:56 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)) 13:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:44:56 INFO - Running setup.py (path:/tmp/pip-2_l2sQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:44:56 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)) 13:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:44:56 INFO - Running setup.py (path:/tmp/pip-_pb0Mq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:44:56 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)) 13:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:44:56 INFO - Running setup.py (path:/tmp/pip-Ok8FQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:44:56 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)) 13:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:44:56 INFO - Running setup.py (path:/tmp/pip-3tX4m1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:44:56 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)) 13:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:44:56 INFO - Running setup.py (path:/tmp/pip-8YwFs1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:44:56 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)) 13:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:44:56 INFO - Running setup.py (path:/tmp/pip-kT6yux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:44:56 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)) 13:44:56 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)) 13:44:56 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)) 13:44:56 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)) 13:44:56 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)) 13:44:56 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)) 13:44:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:44:56 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 13:44:56 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 13:44:56 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 13:44:56 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 13:44:56 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 13:44:56 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 13:44:58 INFO - Downloading blessings-1.6.tar.gz 13:44:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:44:58 INFO - Installing collected packages: blessings 13:44:58 INFO - Running setup.py install for blessings 13:44:58 INFO - Successfully installed blessings 13:44:58 INFO - Cleaning up... 13:44:58 INFO - Return code: 0 13:44:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:44:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:44:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:44:59 INFO - Reading from file tmpfile_stdout 13:44:59 INFO - Current package versions: 13:44:59 INFO - argparse == 1.2.1 13:44:59 INFO - blessings == 1.6 13:44:59 INFO - blobuploader == 1.2.4 13:44:59 INFO - docopt == 0.6.1 13:44:59 INFO - functools32 == 3.2.3-2 13:44:59 INFO - jsonschema == 2.5.1 13:44:59 INFO - manifestparser == 1.1 13:44:59 INFO - mozInstall == 1.12 13:44:59 INFO - mozcrash == 0.17 13:44:59 INFO - mozdebug == 0.1 13:44:59 INFO - mozdevice == 0.48 13:44:59 INFO - mozfile == 1.2 13:44:59 INFO - mozhttpd == 0.7 13:44:59 INFO - mozinfo == 0.9 13:44:59 INFO - mozleak == 0.1 13:44:59 INFO - mozlog == 3.2 13:44:59 INFO - moznetwork == 0.27 13:44:59 INFO - mozprocess == 0.22 13:44:59 INFO - mozprofile == 0.28 13:44:59 INFO - mozrunner == 6.11 13:44:59 INFO - mozscreenshot == 0.1 13:44:59 INFO - mozsystemmonitor == 0.3 13:44:59 INFO - moztest == 0.7 13:44:59 INFO - mozversion == 1.4 13:44:59 INFO - psutil == 3.1.1 13:44:59 INFO - requests == 1.2.3 13:44:59 INFO - wsgiref == 0.1.2 13:44:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:44:59 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')]} 13:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:59 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')]} 13:44:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:59 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 0x7f3f2f555f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24351c0>, '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 0x24360c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2436550>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465505064.271795-1226615883', '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 13:44:59 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 13:44:59 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 13:44:59 INFO - Using env: {'DISPLAY': ':0', 13:44:59 INFO - 'HOME': '/home/cltbld', 13:44:59 INFO - 'LANG': 'en_US.UTF-8', 13:44:59 INFO - 'LANGUAGE': 'en_US:en', 13:44:59 INFO - 'LOGNAME': 'cltbld', 13:44:59 INFO - 'MAIL': '/var/mail/cltbld', 13:44:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:59 INFO - 'MOZ_NO_REMOTE': '1', 13:44:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:59 INFO - 'NO_EM_RESTART': '1', 13:44:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:59 INFO - 'PWD': '/builds/slave/test', 13:44:59 INFO - 'SHELL': '/bin/bash', 13:44:59 INFO - 'SHLVL': '1', 13:44:59 INFO - 'TERM': 'linux', 13:44:59 INFO - 'TMOUT': '86400', 13:44:59 INFO - 'USER': 'cltbld', 13:44:59 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465505064.271795-1226615883', 13:44:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:59 INFO - '_': '/tools/buildbot/bin/python'} 13:44:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:59 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)) 13:44:59 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)) 13:44:59 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)) 13:44:59 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)) 13:44:59 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)) 13:44:59 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)) 13:44:59 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)) 13:44:59 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)) 13:44:59 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)) 13:44:59 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)) 13:44:59 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)) 13:44:59 INFO - Cleaning up... 13:44:59 INFO - Return code: 0 13:44:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:44:59 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')]} 13:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:59 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')]} 13:44:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:59 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 0x7f3f2f555f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24351c0>, '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 0x24360c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2436550>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465505064.271795-1226615883', '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 13:44:59 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 13:44:59 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 13:44:59 INFO - Using env: {'DISPLAY': ':0', 13:44:59 INFO - 'HOME': '/home/cltbld', 13:44:59 INFO - 'LANG': 'en_US.UTF-8', 13:44:59 INFO - 'LANGUAGE': 'en_US:en', 13:44:59 INFO - 'LOGNAME': 'cltbld', 13:44:59 INFO - 'MAIL': '/var/mail/cltbld', 13:44:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:59 INFO - 'MOZ_NO_REMOTE': '1', 13:44:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:59 INFO - 'NO_EM_RESTART': '1', 13:44:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:59 INFO - 'PWD': '/builds/slave/test', 13:44:59 INFO - 'SHELL': '/bin/bash', 13:44:59 INFO - 'SHLVL': '1', 13:44:59 INFO - 'TERM': 'linux', 13:44:59 INFO - 'TMOUT': '86400', 13:44:59 INFO - 'USER': 'cltbld', 13:44:59 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465505064.271795-1226615883', 13:44:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:59 INFO - '_': '/tools/buildbot/bin/python'} 13:44:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:44:59 INFO - Cleaning up... 13:44:59 INFO - Return code: 0 13:44:59 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:44:59 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')]} 13:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:59 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')]} 13:44:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:59 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 0x7f3f2f555f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24351c0>, '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 0x24360c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2436550>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465505064.271795-1226615883', '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 13:44:59 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 13:44:59 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 13:44:59 INFO - Using env: {'DISPLAY': ':0', 13:44:59 INFO - 'HOME': '/home/cltbld', 13:44:59 INFO - 'LANG': 'en_US.UTF-8', 13:44:59 INFO - 'LANGUAGE': 'en_US:en', 13:44:59 INFO - 'LOGNAME': 'cltbld', 13:44:59 INFO - 'MAIL': '/var/mail/cltbld', 13:44:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:59 INFO - 'MOZ_NO_REMOTE': '1', 13:44:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:59 INFO - 'NO_EM_RESTART': '1', 13:44:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:59 INFO - 'PWD': '/builds/slave/test', 13:44:59 INFO - 'SHELL': '/bin/bash', 13:44:59 INFO - 'SHLVL': '1', 13:44:59 INFO - 'TERM': 'linux', 13:44:59 INFO - 'TMOUT': '86400', 13:44:59 INFO - 'USER': 'cltbld', 13:44:59 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465505064.271795-1226615883', 13:44:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:59 INFO - '_': '/tools/buildbot/bin/python'} 13:44:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:59 INFO - Downloading/unpacking flake8 13:44: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 13:44: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 13:44: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 13:44: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 13:44: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 13:44: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 13:45:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:45:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:45:01 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 13:45:01 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 13:45:01 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 13:45:01 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 13:45:01 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 13:45:01 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 13:45:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:45:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:45:01 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 13:45:01 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 13:45:01 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 13:45:01 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 13:45:01 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 13:45:01 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 13:45:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:45:02 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 13:45:02 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 13:45:02 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 13:45:02 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 13:45:02 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 13:45:02 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 13:45:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:45:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:45:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:45:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:45:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:45:02 INFO - no previously-included directories found matching 'docs/_build' 13:45:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:45:02 INFO - Running setup.py install for pep8 13:45:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:45:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:45:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:45:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:45:02 INFO - no previously-included directories found matching 'docs/_build' 13:45:02 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:45:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:45:02 INFO - Cleaning up... 13:45:02 INFO - Return code: 0 13:45:02 INFO - Running post-action listener: _resource_record_post_action 13:45:02 INFO - Running post-action listener: _start_resource_monitoring 13:45:02 INFO - Starting resource monitoring. 13:45:02 INFO - ##### 13:45:02 INFO - ##### Finished create-virtualenv step (success) 13:45:02 INFO - ##### 13:45:02 INFO - ##### 13:45:02 INFO - ##### Running install step. 13:45:02 INFO - ##### 13:45:02 INFO - Running pre-action listener: _resource_record_pre_action 13:45:02 INFO - Running main action method: install 13:45:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:45:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:45:02 INFO - Reading from file tmpfile_stdout 13:45:02 INFO - Detecting whether we're running mozinstall >=1.0... 13:45:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:45:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:45:02 INFO - Reading from file tmpfile_stdout 13:45:02 INFO - Output received: 13:45:02 INFO - Usage: mozinstall [options] installer 13:45:02 INFO - Options: 13:45:02 INFO - -h, --help show this help message and exit 13:45:02 INFO - -d DEST, --destination=DEST 13:45:02 INFO - Directory to install application into. [default: 13:45:02 INFO - "/builds/slave/test"] 13:45:02 INFO - --app=APP Application being installed. [default: firefox] 13:45:02 INFO - mkdir: /builds/slave/test/build/application 13:45:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:45:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:45:18 INFO - Reading from file tmpfile_stdout 13:45:18 INFO - Output received: 13:45:18 INFO - /builds/slave/test/build/application/firefox/firefox 13:45:18 INFO - Running post-action listener: _resource_record_post_action 13:45:18 INFO - ##### 13:45:18 INFO - ##### Finished install step (success) 13:45:18 INFO - ##### 13:45:18 INFO - ##### 13:45:18 INFO - ##### Running run-tests step. 13:45:18 INFO - ##### 13:45:18 INFO - Running pre-action listener: _resource_record_pre_action 13:45:18 INFO - Running main action method: run_tests 13:45:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:45:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:45:18 INFO - Python 2.7.3 13:45:18 INFO - Return code: 0 13:45:18 INFO - grabbing minidump binary from tooltool 13:45: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')]} 13:45: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 0x24351c0>, '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 0x24360c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2436550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:45: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 13:45: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 13:45: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 13:45:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:45:18 INFO - Return code: 0 13:45:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:45:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:45:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:45:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:45:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:45:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:45:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:45:19 INFO - Return code: 0 13:45:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 13:45:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 13:45:19 INFO - Using env: {'DISPLAY': ':0', 13:45:19 INFO - 'HOME': '/home/cltbld', 13:45:19 INFO - 'LANG': 'en_US.UTF-8', 13:45:19 INFO - 'LANGUAGE': 'en_US:en', 13:45:19 INFO - 'LOGNAME': 'cltbld', 13:45:19 INFO - 'MAIL': '/var/mail/cltbld', 13:45:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:45:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:45:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:19 INFO - 'MOZ_NO_REMOTE': '1', 13:45:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:45:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:45:19 INFO - 'NO_EM_RESTART': '1', 13:45:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:45:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:19 INFO - 'PWD': '/builds/slave/test', 13:45:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:45:19 INFO - 'SHELL': '/bin/bash', 13:45:19 INFO - 'SHLVL': '1', 13:45:19 INFO - 'TERM': 'linux', 13:45:19 INFO - 'TMOUT': '86400', 13:45:19 INFO - 'USER': 'cltbld', 13:45:19 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465505064.271795-1226615883', 13:45:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:19 INFO - '_': '/tools/buildbot/bin/python'} 13:45:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 13:45:19 INFO - mozversion application_buildid: 20160609031135 13:45:19 INFO - mozversion application_changeset: 1ae7a82e2b1d2b18ccfa9a578040b46c774bc501 13:45:19 INFO - mozversion application_display_name: FirefoxDeveloperEdition 13:45:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:45:19 INFO - mozversion application_name: Firefox 13:45:19 INFO - mozversion application_remotingname: firefox-dev 13:45:19 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:45:19 INFO - mozversion application_vendor: Mozilla 13:45:19 INFO - mozversion application_version: 49.0a2 13:45:19 INFO - mozversion platform_buildid: 20160609031135 13:45:19 INFO - mozversion platform_changeset: 1ae7a82e2b1d2b18ccfa9a578040b46c774bc501 13:45:19 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:45:19 INFO - mozversion platform_version: 49.0a2 13:45:19 INFO - using testdate: 1465505119 13:45:19 INFO - actual date: 1465505119 13:45:19 INFO - starting webserver on 'localhost:33389' 13:45:19 INFO - SUITE-START | Running 2 tests 13:45:19 INFO - TEST-START | dromaeo_css 13:45:19 INFO - operating with platform_type : linux_ 13:45:19 INFO - Initialising browser for dromaeo_css test... 13:45:19 INFO - TEST-INFO | started process 19236 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCZgl1C/profile http://localhost:33389/getInfo.html) 13:45:24 INFO - PROCESS | 19236 | __metrics Screen width/height:1600/1200 13:45:24 INFO - PROCESS | 19236 | colorDepth:24 13:45:24 INFO - PROCESS | 19236 | Browser inner width/height: 1024/697 13:45:24 INFO - PROCESS | 19236 | __metrics 13:45:25 ERROR - PROCESS | 19236 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 13:45:26 INFO - TEST-INFO | 19236: exit 0 13:45:26 INFO - Browser initialized. 13:45:26 INFO - Running cycle 1/1 for dromaeo_css test... 13:45:26 INFO - TEST-INFO | started process 19364 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCZgl1C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:45:37 INFO - PROCESS | 19364 | RSS: Main: 156475392 13:45:37 INFO - PROCESS | 19364 | 13:46:27 INFO - PROCESS | 19364 | 1465505187487 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] 13:48:35 INFO - PROCESS | 19364 | Cycle 1(1): loaded http://localhost:33389/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33389/tests/dromaeo/cssquery-ext.html) 13:48:36 INFO - PROCESS | 19364 | RSS: Main: 159883264 13:48:36 INFO - PROCESS | 19364 | 13:51:38 INFO - PROCESS | 19364 | Cycle 1(1): loaded http://localhost:33389/tests/dromaeo/cssquery-ext.html (next: http://localhost:33389/tests/dromaeo/cssquery-jquery.html) 13:51:39 INFO - PROCESS | 19364 | RSS: Main: 157155328 13:51:39 INFO - PROCESS | 19364 | 13:54:40 INFO - PROCESS | 19364 | Cycle 1(1): loaded http://localhost:33389/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33389/tests/dromaeo/cssquery-mootools.html) 13:54:41 INFO - PROCESS | 19364 | RSS: Main: 157147136 13:54:41 INFO - PROCESS | 19364 | 13:57:43 INFO - PROCESS | 19364 | Cycle 1(1): loaded http://localhost:33389/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33389/tests/dromaeo/cssquery-prototype.html) 13:57:43 INFO - PROCESS | 19364 | RSS: Main: 156078080 13:57:43 INFO - PROCESS | 19364 | 14:00:46 INFO - PROCESS | 19364 | Cycle 1(1): loaded http://localhost:33389/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33389/tests/dromaeo/cssquery-yui.html) 14:00:46 INFO - PROCESS | 19364 | RSS: Main: 158310400 14:00:46 INFO - PROCESS | 19364 | 14:03:49 INFO - PROCESS | 19364 | Cycle 1(1): loaded http://localhost:33389/tests/dromaeo/cssquery-yui.html (next: http://localhost:33389/tests/dromaeo/cssquery-dojo.html) 14:03:49 INFO - PROCESS | 19364 | RSS: Main: 158629888 14:03:49 INFO - PROCESS | 19364 | 14:03:49 INFO - PROCESS | 19364 | __start_tp_report 14:03:49 INFO - PROCESS | 19364 | _x_x_mozilla_page_load 14:03:49 INFO - PROCESS | 19364 | _x_x_mozilla_page_load_details 14:03:49 INFO - PROCESS | 19364 | |i|pagename|runs| 14:03:49 INFO - PROCESS | 19364 | |0;dojo.html;3379.8817041403554;3400.5069264956596;3416.0947348952523;3438.4326586113293;3446.5519482467275;5758.30900291965;5770.422957704228;5779.884402311951;5799.710014499274;5804.535637149029;5773.5381169506445;5799.246098007253;5809.883802323951;5829;5847.210626565412;5214.270002199695;5235.764390602432;5282.445343238962;5306.575473962073;5346.465353464661;5252.5010124038345;5288.444713305105;5303.178007408838;5338.3060202173665;5339.759710813003;5330.946690533103;5368.62419630626;5374.355077390699;5411.080116380205;5426.104692725715;5312.4687531246955;5396.43337449566;5401.4328495508;5405.135178371442;5407.053765591045;5301.416844147141;5306.389765176977;5314.734263286859;5356.607282106641;5394.676319420808;5603.775848966036;5693.373728889819;5694.316681998145;5701.914471282934;5801.01382764931;6261.686915654199;6285.560010799246;6290.842728931813;6317.05244213367;6317.620942743404;6091.360407157274;6233.563650544464;6277.905831412532;6279.560430769848;6291.842703932438;5831.650100993954;5874.1776151338845;5878.382769809194;5921.822345329647;5922.881542369171;6443.259025212067;6474.805755827333;6481.837954051187;6482.416582507502;6485;6023.939760602338;6086.726097325631;6203.96898015516;6249.75000999964;6250.156228909039;6186.133941248228;6318.810435686937;6321.3994670507145;6325.430711235919;6334.081558174131;6240.7503699851495;6258.468030217391;6283.874322513524;6290.811275661737;6290.937090629035;6071.453569178795;6124.014786914997;6161.168242287234;6265.749370025148;6274.341194174637;4719.716816990992;4734.692245004064;4748.6438517111355;4759.024399998061;4770.308305295782;4233;4235.364695295731;4235.53409124996;4239.682023848224;4246.681498887596;5934.970325148433;5996.640201587918;6021.819345419644;6025.066114752132;6051.727672254671;6111.561351782736;6222.160008398808;6223.782167624111;6258.43674069336;6330.841728956813;6048.706589392613;6059.7273122709585;6065.2418447694035;6070.848228794315;6074.817755467343;5223.738813059332;5316.0962636351915;5349.144136938071;5356.196570514454;5394.433584473652;6447.838804029843;6462.773802916875;6482.967585162044;6503.959366501337;6537;6134.846628834315;6339.556231063873;6343.651099189405;6353.618782873043;6359.109724638462;6438.937575300023;6451.225852897683;6520.119783829123;6596.3073877244115;6601.33986601336;6243.125962365363;6255.56211065221;6258.874822503433;6260.186175797117;6270.686465676789;6122.846928826815;6212.689365531795;6326.6520341381665;6342.016987366966;6359.777407790705;6116.8776624468155;6118.938810611837;6192.628442293477;6195.318514963441;6201.875962480815;6103.908441373294;6145.508359331332;6171.105189747372;6171.9074213887725;6190.350013248724;5904.3210030845285;5932.021216499229;6021.789237376671;6100.450959413674;6104.633721976518;6153.323134455117;6225;6232.376762323732;6247.96876015617;6263.592866463665;6107.938920610737;6108.472881779555;6114.908276375947;6134.509239260759;6138.14066030765 14:03:49 INFO - PROCESS | 19364 | |1;ext.html;591.9911201331978;627.2974268818923;641.1216633212499;647.5402464250382;666.7033170239246;46742.298865517005;47933;48035.51964480354;48265;51037.489625103735;49820.50179498204;50020.749896250556;50240.24639630409;50265.24602130962;50536.747316263456;9011.324150688692;9223.308251881135;9229.077092290785;9232.953835230814;9249.167574918256;9145.131212534832;9202.723918282429;9241.861372079424;9249.260059195281;9265.814683706321;9251;9269.490178040205;9314.068593140666;9320.02139775324;9324.207442367408;9214.861777073349;9276.489793061379;9283.39657922233;9284.164425201765;9290.163885250326;9003.954980225122;9066.818663626691;9103.08969103091;9104.772380690469;9124.954375228148;45146.774266128785;45563.54436455626;45883.31175032377;45940;46111;3769.9434508482395;3833.4249862520564;3840.8079596020366;3865.265599536079;4047.5750046245016;34408.139796505035;34859.82570087159;34938.650613493795;35083;35346.469802952975;4755.0489902019735;4763.666543341968;4807.567318941277;4808.230683090689;4819.6385271104455;372947;373409;373667;375036;375090.99999999726;54486.45513544814;55286.44713552813;55738;65522.34477655258;65616;69925.65037174782;70414.2958570418;70861.64569177224;70868;71421.28578714251;16219.107949062678;16379;16406.83593164077;16409.58976025585;16440.260188291555;13321.200727956353;13326.200427974352;13360.599182024554;13362.131461454974;13491.460341586422;19060.428187154408;19369.225230990603;19467.610647786965;19478.496309458016;19524.079997608464;6060.545459090586;6125.540584456184;6129.632222066691;6136.723847426876;6275.46293990495;1030.5568605499707;1077.5420446310286;1103.6413165721174;1116.3692513729716;1136.7271854754965;33419.49870751941;33528.32943341119;33566.49650255248;33913.49129763056;33928.982130536126;1146.8451759012594;1170.0814860334597;1219.451246938881;1225.2281062930474;1302.0885380233685;17736.733948990775;17740;17847.46457606274;17878.28486860537;17967.382935535865;538205;553055;559791;565507;567697;62003;62777.372226278065;63127;63173.36826631675;63234.683826581495;1423.4946593958996;1433.6129245103764;1436.2531483628454;1441.0273065680833;1482.844301348343;31965.840170798998;32536.34927301488;32693.673063269063;33241.33517329688;33331.333373332884;54320;64024.67987660032;66703.33296666971;66787.33212668005;66966;466838;469271;472057;472800;472969;28281.85859070774;28734.712652873204;28917.277068073465;29049.7095029047;31305.8434707825;53252.201216981004;53898.730506347216;54398.45601543934;55485;55868;44062.55937440713;44443.33334999913;44621.10757784891;44653;44704.55295447004;44614;44795.77602112099;44827.551724483645;46006.53993460156;46106;44577;44969.100617986805;45164;45328.54671453243;45747;38421.6157838418;38823.223535529694;39027;39331.6066839328;39835.60164398319;29454.558181627723;29791.957281495044;30434.543481847348;30456.84771576128;30508.237294067825 14:03:49 INFO - PROCESS | 19364 | |2;jquery.html;409.7684808083433;411.27615396901456;412.38760440745506;414.2067939895101;427.3632287891043;18604.34884779033;19660.410187694357;20103;20105.798942010595;20662.07020684069;12951.41718622662;16626.00243985362;18830.623387532276;19638;19690.606187876234;5216.634835561522;5365.839024829242;5369.62412631116;5384.542313903323;5392.595555333366;4976.701397916118;5105.438401775802;5271.077561426754;5312.946870531284;5385.084535628953;4991.201407774757;5040.42035165957;5046.6467347285525;5049.3183420238165;5085.313482679846;4997.325361076245;5033.094043072246;5154.974225128888;5724.856878578027;5728.570357223183;5030.144875371196;5053.267276244961;5061.974690126563;5069.264956581275;5167.638265321429;14475.565733028026;20359.676621019586;22816.429589260402;24327.391815204584;24343.269701908972;2457.7542245775458;2532.683414573178;2537.5051864886354;2573.2537564106387;2740.9995351696684;11062;11331.886681133166;11787.882121178764;14576.562703118923;15747.685046299124;2021.4946263434142;2109.725735654355;2146.388279340396;2151.08578853988;2164.826813854888;82614.17385826186;86911;87878.5606071972;87888.56055719744;87955;11472.082233421306;11564.306141631529;11728.354940478184;11912.940435297767;11940.582079627171;13213.14114582549;16620.501384958472;16798.748018779726;16951.321947121978;17071.914640426967;7641.617919104134;7973.44185906981;8417.242448179693;8436.578171091422;8500.70247541333;8326.875096873551;8328.625211865481;8356.791080223044;8432.704855330034;8549.829003419896;4351.477822661301;4403;4404.1411924674385;4534.750588717587;4538.319252112144;2030.7461567304088;2065.731454910882;2066.638338290793;2106.9051892664866;2110.6622940329476;972.1979367022235;1011.0647650923014;1029.7374169586708;1085.571199376242;1104.3429159649995;17062.914685426495;19474.513137171685;19626.50933726668;19703.310384136486;19995.800041999686;1005.2962925951863;1055.145332280855;1077.0844781935448;1084.38732116354;1088.3905013192636;10880.67357979262;11127.443627818577;11131.220814543067;11165.441727913572;11167.441627918734;474137;475449;478785;479481;482354;60803.39196608066;92977.53511232536;97228.51385743025;97599;100039;1058.6188971970084;1060.9893901061046;1088.1838621034224;1118.6196693124377;1130.4404319861721;17399.391021314193;17465.38871139504;17544.73682894732;17779.822201777817;17832.84086534371;35050.474242886885;39311;41273;42421.363679544214;45069.09861802811;58209.70895145667;58262.12606810986;58706.119408208055;58743.4125658738;59125;8715.607797648994;9048.095190480899;9078.137576930181;9125.498097604695;9292.58183381736;7806.921930780847;9428.245740340893;12691.111622186358;13269.66825829362;13625.86374136246;11988.940055299669;12037.337946413032;12101.273923564615;12165.939170304446;12257.26456412618;10207;11651.53393864236;11707.2975621463;11805.468753906267;11886.583969561023;11860.703482413008;11896.702582435508;11971.341576213392;12059.457324420599;12306;8995.415298005608;9010.738496610611;9122.452652840851;9223.76940576491;9320.254379649747;11117.722056948642;11165.330080195214;11329.320240785579;11376.94311528437;11415.486303116213 14:03:49 INFO - PROCESS | 19364 | |3;mootools.html;1514.5683480208136;1521.1633601519163;1692.9746053809195;1697.702901992151;1822.0434272007194;8196.713115040975;8654.307655387569;8826.558672066396;9381.530923453825;9402.81194376113;8736.825263494726;8835.734927952171;9044.728658140266;9051.275897928166;9052.72841814745;2480.131953816168;2520.420303330235;2521.9747802521924;2530.063876365747;2532.1011041080337;2449.9877500612474;2498.5002999400103;2516.5973444248925;2519.1560827122935;2521.218422289087;2442.1696623148127;2442.5237078769646;2449.2774631483667;2453.9631905521433;2463.4580392313665;2384.451576137481;2397.5564520563667;2431.8054555635595;2481.404462928902;2484.3292311075907;2432.4648577312964;2439.9634005489934;2446.6330050492393;2462.2982450001664;2465.0263146057205;8937.285017198608;9007.369484136114;9018.63925442988;9021.097890210993;9032.683856065072;5552.333719953632;5706.400827913092;5707.600467967244;5711.086226203787;5717.313922329306;3397.371486275047;3465.480177973299;3567.661072198137;3644.580873199563;3650.4159334506353;1114.3202646385698;1126.1553834624033;1148.844905937696;1162.3839365136491;1169.3626973299572;12844.935775321064;12877.67805804853;12925.870741292561;12955.417006234742;12968.35158242084;4924.1875090610365;4980.477049909779;5043.36957880265;5044.974775126174;5073.847784566469;10743.462826858782;10826.729331766612;10876.184286178568;10876.564937402574;10877.510512026978;5473.0969390050195;5489.780408783684;5504.724763761796;5521.696306703089;5727.255456790674;4464.441944756905;4956.603471722254;5103.8468845934685;5109.9744501277255;5121.948780512222;4271.508776490743;4320.913581728348;4338.609525142752;4342.500612429548;4491.348754430589;1371.732512160119;1388.5001399496173;1391.415605445695;1412.5903487988369;1421.7014426970452;1045.1429827541494;1058.6083149234678;1074.8602681651491;1077.1329080090602;1094.2504384496644;6361.236651601837;6445.323241059715;6470.352964703586;6505.902411463831;6585.209774826955;489.87263311538544;496.5406998526349;501.1780679685319;502.5979216626684;508.80919655129327;4323.870283891489;4379.4525684289465;4408.823647054146;4425.269830478;4474.127545128734;11208.607698730506;11638.76722465546;11640.650780476599;11715.121365897592;11717.472713727902;10902.563897444013;11346.432678366049;11352.659420217407;11491.080713542897;11644.708882278012;8430.747077587683;8558.315334773204;8565.314774818;8636.265917396966;8700.521471319138;6540.247871494648;6568.310327415553;6715.56348837324;6720.899186512109;6825.668994546016;10067;10333.534990925576;10584.84122738175;10673.679789606324;10719.410432425979;10647.467626618793;10796.514156862802;10797.56809727602;10822.56709731602;10921.508532116233;7477.775666730006;7914.169012253861;7964.482308649919;8006.479578827358;8241.50550966944;8668;8688.261497772508;8701.651933922572;8709.782255443664;8778.692745753868;8008.959955200186;8158.551279679437;8251.793705157419;8265.917340826514;8310.584470776315;7965.880511792212;8053.275205231323;8101.351891848756;8188.222118898695;8231.300339471212;7071.43428525727;7141.143062832493;7287.125544934642;7463.738769143054;7478.663460144416;5487.341519017584;5493.368262649847;5501.881775516375;5587.273654424899;5649.519790817826;5631.802886898939;5652.434756524314;5689.431056894277;5728.828135155952;5755.539556835527 14:03:49 INFO - PROCESS | 19364 | |4;prototype.html;338.18497421214875;346.9954481775262;351.51490942499345;354.36037951497536;355.5111721383098;5712.771489140429;5761.337446193689;5919.585629005971;5995.790147344844;6007.939920600793;5767.798127065554;5785.27684039495;5792.449717276862;5795.652260864351;5804.390538993408;4451.28779395296;4492.2812350024005;4497.2129877271345;4502.816134174923;4536.56902594253;4439.1565602535575;4498.842540511083;4516;4516.638668906479;4538.727676339414;4460.553944605546;4463.174312752151;4474.284114541674;4491.550844915515;4508.594226519613;4508.684392092555;4509.391232183662;4537.773111344452;4550.704204226715;4579.656525760582;3914.706397020206;4016.2369149861433;4025.75845449274;4083.224187404384;4083.9591604083876;5581.804636837691;5616.747246373923;5641.097424412074;5646.887062258773;5676.574256930747;5219;5222.328854766476;5237.528622424;5242.423333433319;5251.55582214894;5951.256092988377;6097.17688112108;6124.908126378108;6129.804688085825;6167.969160154215;4455.6830448166775;4459.888502787424;4464.15181115587;4484.596386325214;4498.730076195438;6221.782237621662;6411.679416029227;6438.195225596801;6456.451201647866;6477.255115661665;4560.977195114003;4565.589096981287;4566.49768525462;4571.634269258451;4584.518625544337;4602.7698615069785;4615.538446155358;4630.383833134269;4649;4653.6509761768;5156.7421628919155;5228.660137091077;5229;5264.1840514719515;5269.499397557226;5837.081459270365;5884.47039766423;6106.786262480792;6145.784897528565;6155.84610384735;1563.1012168003217;1573.2920185916155;1583.8099428068474;1585.888987770845;1586.841315868427;996.6312464388222;1008.0121480948711;1012.3015119567475;1013.8732658417698;1031.7884833609091;5259.579233661298;5263.526142712919;5289.153735402318;5295.046891559557;5339.893202135935;5501.642393244426;5533.6403133796175;5566.304211973504;5604.299462567179;5654.97172514143;5327.680339179662;5331.4401987790725;5533.22534845122;5980.282366116007;5994.28068631767;3350.0619826448633;3351.983240083784;3353.714934230569;3370.6966373026544;3391.6269210386836;6247.0629405589525;6528.37980391862;6539.593987292755;6567.704453299613;6590.439812615981;6259.4679452246155;6420.7752728655205;6424.646644434601;6457.61254324742;6478.792997466285;6368.5860419072615;6409.519286053658;6453.838654033687;6507.934920650733;6529.836754081186;6236.937630623635;6247.531435142291;6259.655718935503;6261.78083767066;6322.143492469681;6190.823743488722;6194.5044396449075;6201;6207.844803879939;6214.564980451325;6229.501639868709;6414.711337989895;6453.709583068679;6509.479241660751;6545.494536256783;4318.978405107954;4331.891702707458;4340.47914250292;4360.9127817444105;4379.58393952574;6039.516838652985;6189.907151392643;6293.496520278275;6305.684715764101;6365.440467085594;6146.877062458815;6147.200863887666;6157.84605384869;6178.66017369049;6181.258249010148;5982.312034116132;6139.815805525842;6144.8771024580155;6154.261488621394;6219.564630475823;5990.610610310316;6044.576879618385;6073.848153796191;6129.816105516842;6141.201643786279;6063.848403789941;6082.847928801815;6177.1969643945995;6196.172129221981;6248.875022499434;5849.94150058511;6089.4776305923515;6091.573589848668;6093.086037094294;6104.694765261808 14:03:49 INFO - PROCESS | 19364 | |5;yui.html;760.7983884270669;794.7337641889967;848.1772680499913;855.4525103933483;901.8602116671914;16529.586760330996;16971.3211471541;17099.658006839873;17105.82894171058;17161.14194290285;15636.687266254668;15836.366545338202;15863.206839658029;15869.920650396733;15886.285117169726;722.0973782771536;833.7957200485889;857.2584714222215;857.2884505860121;859.6733241368271;867.2281669314284;868.1622234543696;872.149654087263;873.8383399071192;874.2830878679486;921.0651189043126;926.2404828041009;930.06993006993;930.9255259579252;933.943963362197;900.2617853360215;918.4213945214506;921.345844450441;921.5438358012759;922.3681777982104;671.5802623360399;673.6699017481399;676.2257215488288;677.2753154125088;679.7179170644176;15987.280572374271;16104.919475402665;16109.516714498584;16116.83883161165;16180.433684820975;15123.924380378137;15226.543203703906;15301;15399.769003464957;15495.92252038744;12917.031222658245;12941.676458088528;12954.287514186715;12988;13037.282949437777;3887.3197190491833;3916.6083391660604;3918.4122381642696;3942.2706799242233;4080.81636326366;81533;81536.59231703804;81998;82356;83084;11939.88060119405;12180.695482613006;12314.938425307817;12383.19509231915;12598.937005314914;22849.657255141185;23158.652620210374;23650.172243971378;23668.763312367002;23899;8951.104889511127;9043.502607356528;9052.140046695553;9244.214241789388;9288.7677808054;5004.124278251292;5015.3480047593575;5053.646244762905;5104.183330667075;5173.611979101583;3897.7466464679705;4020.8793736187963;4025.174839158024;4029.37544680575;4032.274190645653;665.9200895892524;677.7356830835978;682.1813823411926;686.0361192524512;704.0389867830477;748.4162353364385;795;796.0685997383076;802.4864086984335;810.6190090657382;10695.197860160519;11228.326300421837;11231.157663175294;11259.774804504028;11275.32348059119;767.976960691169;773.6286582440348;773.6827900560743;781.1368437876179;781.5310813511961;5194;5241.9737901310245;5252.264682944391;5299.2316114164005;5327.254184414185;116395.41802290935;124956.37521812333;126201;126621;126888.36555817162;101842.49078754558;104664.47667761765;105540.47229763801;105909;106956;85697.57151214204;87685.56157219173;87703;88267.55866220628;95160.52419737857;10033.04415537768;10218.284720069523;10295.330803497749;10297.588096476356;10321.380717156995;54502.7274863639;54544;55566.16650750323;56212.71893640506;56554.7172264136;73183;84521.57739211265;85213.57393213242;85837.57081214554;86400.56799715961;13418.127821691558;13786.862131378557;13866.930665346608;14021.509247176708;14769.556913292618;16368.918155409146;16478.505644830195;16824.915875421033;16851.325946962475;16939.576510587332;14985.475508357154;15021.173835438718;15432.691346173238;15461.149636770086;15591.142487163315;14885.776713349092;15141.242937852843;15284.082955022734;15369.077855328716;15491.147986860831;15017.549473515812;15068.773968390702;15209.77185342243;15287.61780955485;15302.476937315345;12165.660910955752;12211.26732396059;12500.687482813002;12752.42614082387;12752.74494510123;12185.69535761613;12663.620091397273;12918.418671159632;12939.223646581235;13059.34703264852 14:03:49 INFO - PROCESS | 19364 | __end_tp_report 14:03:49 INFO - PROCESS | 19364 | __start_cc_report 14:03:49 INFO - PROCESS | 19364 | _x_x_mozilla_cycle_collect,366 14:03:49 INFO - PROCESS | 19364 | __end_cc_report 14:03:49 INFO - PROCESS | 19364 | __startTimestamp1465506229389__endTimestamp 14:03:49 INFO - PROCESS | 19364 | 14:03:49 INFO - PROCESS | 19364 | ------- Summary: start ------- 14:03:49 INFO - PROCESS | 19364 | Number of tests: 6 14:03:49 INFO - PROCESS | 19364 | 14:03:49 INFO - PROCESS | 19364 | [#0] dojo.html Cycles:165 Average:5828.18 Median:6100.45 stddev:671.96 (11.0%) stddev-sans-first:645.99 14:03:49 INFO - PROCESS | 19364 | Values: 3379.9 3400.5 3416.1 3438.4 3446.6 5758.3 5770.4 5779.9 5799.7 5804.5 5773.5 5799.2 5809.9 5829.0 5847.2 5214.3 5235.8 5282.4 5306.6 5346.5 5252.5 5288.4 5303.2 5338.3 5339.8 5330.9 5368.6 5374.4 5411.1 5426.1 5312.5 5396.4 5401.4 5405.1 5407.1 5301.4 5306.4 5314.7 5356.6 5394.7 5603.8 5693.4 5694.3 5701.9 5801.0 6261.7 6285.6 6290.8 6317.1 6317.6 6091.4 6233.6 6277.9 6279.6 6291.8 5831.7 5874.2 5878.4 5921.8 5922.9 6443.3 6474.8 6481.8 6482.4 6485.0 6023.9 6086.7 6204.0 6249.8 6250.2 6186.1 6318.8 6321.4 6325.4 6334.1 6240.8 6258.5 6283.9 6290.8 6290.9 6071.5 6124.0 6161.2 6265.7 6274.3 4719.7 4734.7 4748.6 4759.0 4770.3 4233.0 4235.4 4235.5 4239.7 4246.7 5935.0 5996.6 6021.8 6025.1 6051.7 6111.6 6222.2 6223.8 6258.4 6330.8 6048.7 6059.7 6065.2 6070.8 6074.8 5223.7 5316.1 5349.1 5356.2 5394.4 6447.8 6462.8 6483.0 6504.0 6537.0 6134.8 6339.6 6343.7 6353.6 6359.1 6438.9 6451.2 6520.1 6596.3 6601.3 6243.1 6255.6 6258.9 6260.2 6270.7 6122.8 6212.7 6326.7 6342.0 6359.8 6116.9 6118.9 6192.6 6195.3 6201.9 6103.9 6145.5 6171.1 6171.9 6190.4 5904.3 5932.0 6021.8 6100.5 6104.6 6153.3 6225.0 6232.4 6248.0 6263.6 6107.9 6108.5 6114.9 6134.5 6138.1 14:03:49 INFO - PROCESS | 19364 | 14:03:49 INFO - PROCESS | 19364 | [#1] ext.html Cycles:180 Average:64560.14 Median:45911.66 stddev:125365.02 (273.1%) stddev-sans-first:125624.70 14:03:49 INFO - PROCESS | 19364 | Values: 592.0 627.3 641.1 647.5 666.7 46742.3 47933.0 48035.5 48265.0 51037.5 49820.5 50020.7 50240.2 50265.2 50536.7 9011.3 9223.3 9229.1 9233.0 9249.2 9145.1 9202.7 9241.9 9249.3 9265.8 9251.0 9269.5 9314.1 9320.0 9324.2 9214.9 9276.5 9283.4 9284.2 9290.2 9004.0 9066.8 9103.1 9104.8 9125.0 45146.8 45563.5 45883.3 45940.0 46111.0 3769.9 3833.4 3840.8 3865.3 4047.6 34408.1 34859.8 34938.7 35083.0 35346.5 4755.0 4763.7 4807.6 4808.2 4819.6 372947.0 373409.0 373667.0 375036.0 375091.0 54486.5 55286.4 55738.0 65522.3 65616.0 69925.7 70414.3 70861.6 70868.0 71421.3 16219.1 16379.0 16406.8 16409.6 16440.3 13321.2 13326.2 13360.6 13362.1 13491.5 19060.4 19369.2 19467.6 19478.5 19524.1 6060.5 6125.5 6129.6 6136.7 6275.5 1030.6 1077.5 1103.6 1116.4 1136.7 33419.5 33528.3 33566.5 33913.5 33929.0 1146.8 1170.1 1219.5 1225.2 1302.1 17736.7 17740.0 17847.5 17878.3 17967.4 538205.0 553055.0 559791.0 565507.0 567697.0 62003.0 62777.4 63127.0 63173.4 63234.7 1423.5 1433.6 1436.3 1441.0 1482.8 31965.8 32536.3 32693.7 33241.3 33331.3 54320.0 64024.7 66703.3 66787.3 66966.0 466838.0 469271.0 472057.0 472800.0 472969.0 28281.9 28734.7 28917.3 29049.7 31305.8 53252.2 53898.7 54398.5 55485.0 55868.0 44062.6 44443.3 44621.1 44653.0 44704.6 44614.0 44795.8 44827.6 46006.5 46106.0 44577.0 44969.1 45164.0 45328.5 45747.0 38421.6 38823.2 39027.0 39331.6 39835.6 29454.6 29792.0 30434.5 30456.8 30508.2 14:03:49 INFO - PROCESS | 19364 | 14:03:49 INFO - PROCESS | 19364 | [#2] jquery.html Cycles:180 Average:28742.99 Median:23571.91 stddev:78990.23 (335.1%) stddev-sans-first:79183.17 14:03:49 INFO - PROCESS | 19364 | Values: 409.8 411.3 412.4 414.2 427.4 18604.3 19660.4 20103.0 20105.8 20662.1 12951.4 16626.0 18830.6 19638.0 19690.6 5216.6 5365.8 5369.6 5384.5 5392.6 4976.7 5105.4 5271.1 5312.9 5385.1 4991.2 5040.4 5046.6 5049.3 5085.3 4997.3 5033.1 5155.0 5724.9 5728.6 5030.1 5053.3 5062.0 5069.3 5167.6 14475.6 20359.7 22816.4 24327.4 24343.3 2457.8 2532.7 2537.5 2573.3 2741.0 11062.0 11331.9 11787.9 14576.6 15747.7 2021.5 2109.7 2146.4 2151.1 2164.8 82614.2 86911.0 87878.6 87888.6 87955.0 11472.1 11564.3 11728.4 11912.9 11940.6 13213.1 16620.5 16798.7 16951.3 17071.9 7641.6 7973.4 8417.2 8436.6 8500.7 8326.9 8328.6 8356.8 8432.7 8549.8 4351.5 4403.0 4404.1 4534.8 4538.3 2030.7 2065.7 2066.6 2106.9 2110.7 972.2 1011.1 1029.7 1085.6 1104.3 17062.9 19474.5 19626.5 19703.3 19995.8 1005.3 1055.1 1077.1 1084.4 1088.4 10880.7 11127.4 11131.2 11165.4 11167.4 474137.0 475449.0 478785.0 479481.0 482354.0 60803.4 92977.5 97228.5 97599.0 100039.0 1058.6 1061.0 1088.2 1118.6 1130.4 17399.4 17465.4 17544.7 17779.8 17832.8 35050.5 39311.0 41273.0 42421.4 45069.1 58209.7 58262.1 58706.1 58743.4 59125.0 8715.6 9048.1 9078.1 9125.5 9292.6 7806.9 9428.2 12691.1 13269.7 13625.9 11988.9 12037.3 12101.3 12165.9 12257.3 10207.0 11651.5 11707.3 11805.5 11886.6 11860.7 11896.7 11971.3 12059.5 12306.0 8995.4 9010.7 9122.5 9223.8 9320.3 11117.7 11165.3 11329.3 11376.9 11415.5 14:03:49 INFO - PROCESS | 19364 | 14:03:49 INFO - PROCESS | 19364 | [#3] mootools.html Cycles:180 Average:6099.67 Median:2490.61 stddev:3442.33 (138.2%) stddev-sans-first:3434.74 14:03:49 INFO - PROCESS | 19364 | Values: 1514.6 1521.2 1693.0 1697.7 1822.0 8196.7 8654.3 8826.6 9381.5 9402.8 8736.8 8835.7 9044.7 9051.3 9052.7 2480.1 2520.4 2522.0 2530.1 2532.1 2450.0 2498.5 2516.6 2519.2 2521.2 2442.2 2442.5 2449.3 2454.0 2463.5 2384.5 2397.6 2431.8 2481.4 2484.3 2432.5 2440.0 2446.6 2462.3 2465.0 8937.3 9007.4 9018.6 9021.1 9032.7 5552.3 5706.4 5707.6 5711.1 5717.3 3397.4 3465.5 3567.7 3644.6 3650.4 1114.3 1126.2 1148.8 1162.4 1169.4 12844.9 12877.7 12925.9 12955.4 12968.4 4924.2 4980.5 5043.4 5045.0 5073.8 10743.5 10826.7 10876.2 10876.6 10877.5 5473.1 5489.8 5504.7 5521.7 5727.3 4464.4 4956.6 5103.8 5110.0 5121.9 4271.5 4320.9 4338.6 4342.5 4491.3 1371.7 1388.5 1391.4 1412.6 1421.7 1045.1 1058.6 1074.9 1077.1 1094.3 6361.2 6445.3 6470.4 6505.9 6585.2 489.9 496.5 501.2 502.6 508.8 4323.9 4379.5 4408.8 4425.3 4474.1 11208.6 11638.8 11640.7 11715.1 11717.5 10902.6 11346.4 11352.7 11491.1 11644.7 8430.7 8558.3 8565.3 8636.3 8700.5 6540.2 6568.3 6715.6 6720.9 6825.7 10067.0 10333.5 10584.8 10673.7 10719.4 10647.5 10796.5 10797.6 10822.6 10921.5 7477.8 7914.2 7964.5 8006.5 8241.5 8668.0 8688.3 8701.7 8709.8 8778.7 8009.0 8158.6 8251.8 8265.9 8310.6 7965.9 8053.3 8101.4 8188.2 8231.3 7071.4 7141.1 7287.1 7463.7 7478.7 5487.3 5493.4 5501.9 5587.3 5649.5 5631.8 5652.4 5689.4 5728.8 5755.5 14:03:49 INFO - PROCESS | 19364 | 14:03:49 INFO - PROCESS | 19364 | [#4] prototype.html Cycles:180 Average:5116.78 Median:5665.77 stddev:1501.47 (26.5%) stddev-sans-first:1462.22 14:03:49 INFO - PROCESS | 19364 | Values: 338.2 347.0 351.5 354.4 355.5 5712.8 5761.3 5919.6 5995.8 6007.9 5767.8 5785.3 5792.4 5795.7 5804.4 4451.3 4492.3 4497.2 4502.8 4536.6 4439.2 4498.8 4516.0 4516.6 4538.7 4460.6 4463.2 4474.3 4491.6 4508.6 4508.7 4509.4 4537.8 4550.7 4579.7 3914.7 4016.2 4025.8 4083.2 4084.0 5581.8 5616.7 5641.1 5646.9 5676.6 5219.0 5222.3 5237.5 5242.4 5251.6 5951.3 6097.2 6124.9 6129.8 6168.0 4455.7 4459.9 4464.2 4484.6 4498.7 6221.8 6411.7 6438.2 6456.5 6477.3 4561.0 4565.6 4566.5 4571.6 4584.5 4602.8 4615.5 4630.4 4649.0 4653.7 5156.7 5228.7 5229.0 5264.2 5269.5 5837.1 5884.5 6106.8 6145.8 6155.8 1563.1 1573.3 1583.8 1585.9 1586.8 996.6 1008.0 1012.3 1013.9 1031.8 5259.6 5263.5 5289.2 5295.0 5339.9 5501.6 5533.6 5566.3 5604.3 5655.0 5327.7 5331.4 5533.2 5980.3 5994.3 3350.1 3352.0 3353.7 3370.7 3391.6 6247.1 6528.4 6539.6 6567.7 6590.4 6259.5 6420.8 6424.6 6457.6 6478.8 6368.6 6409.5 6453.8 6507.9 6529.8 6236.9 6247.5 6259.7 6261.8 6322.1 6190.8 6194.5 6201.0 6207.8 6214.6 6229.5 6414.7 6453.7 6509.5 6545.5 4319.0 4331.9 4340.5 4360.9 4379.6 6039.5 6189.9 6293.5 6305.7 6365.4 6146.9 6147.2 6157.8 6178.7 6181.3 5982.3 6139.8 6144.9 6154.3 6219.6 5990.6 6044.6 6073.8 6129.8 6141.2 6063.8 6082.8 6177.2 6196.2 6248.9 5849.9 6089.5 6091.6 6093.1 6104.7 14:03:49 INFO - PROCESS | 19364 | 14:03:49 INFO - PROCESS | 19364 | [#5] yui.html Cycles:180 Average:22479.97 Median:3892.53 stddev:32027.25 (822.8%) stddev-sans-first:32075.57 14:03:49 INFO - PROCESS | 19364 | Values: 760.8 794.7 848.2 855.5 901.9 16529.6 16971.3 17099.7 17105.8 17161.1 15636.7 15836.4 15863.2 15869.9 15886.3 722.1 833.8 857.3 857.3 859.7 867.2 868.2 872.1 873.8 874.3 921.1 926.2 930.1 930.9 933.9 900.3 918.4 921.3 921.5 922.4 671.6 673.7 676.2 677.3 679.7 15987.3 16104.9 16109.5 16116.8 16180.4 15123.9 15226.5 15301.0 15399.8 15495.9 12917.0 12941.7 12954.3 12988.0 13037.3 3887.3 3916.6 3918.4 3942.3 4080.8 81533.0 81536.6 81998.0 82356.0 83084.0 11939.9 12180.7 12314.9 12383.2 12598.9 22849.7 23158.7 23650.2 23668.8 23899.0 8951.1 9043.5 9052.1 9244.2 9288.8 5004.1 5015.3 5053.6 5104.2 5173.6 3897.7 4020.9 4025.2 4029.4 4032.3 665.9 677.7 682.2 686.0 704.0 748.4 795.0 796.1 802.5 810.6 10695.2 11228.3 11231.2 11259.8 11275.3 768.0 773.6 773.7 781.1 781.5 5194.0 5242.0 5252.3 5299.2 5327.3 116395.4 124956.4 126201.0 126621.0 126888.4 101842.5 104664.5 105540.5 105909.0 106956.0 85697.6 87685.6 87703.0 88267.6 95160.5 10033.0 10218.3 10295.3 10297.6 10321.4 54502.7 54544.0 55566.2 56212.7 56554.7 73183.0 84521.6 85213.6 85837.6 86400.6 13418.1 13786.9 13866.9 14021.5 14769.6 16368.9 16478.5 16824.9 16851.3 16939.6 14985.5 15021.2 15432.7 15461.1 15591.1 14885.8 15141.2 15284.1 15369.1 15491.1 15017.5 15068.8 15209.8 15287.6 15302.5 12165.7 12211.3 12500.7 12752.4 12752.7 12185.7 12663.6 12918.4 12939.2 13059.3 14:03:49 INFO - PROCESS | 19364 | -------- Summary: end -------- 14:03:49 INFO - PROCESS | 19364 | 14:03:50 INFO - TEST-INFO | 19364: exit 0 14:03:50 INFO - TEST-OK | dromaeo_css | took 1110212ms 14:03:50 INFO - TEST-START | kraken 14:03:50 INFO - operating with platform_type : linux_ 14:03:50 INFO - Initialising browser for kraken test... 14:03:50 INFO - TEST-INFO | started process 19610 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvlNtx9/profile http://localhost:33389/getInfo.html) 14:03:54 INFO - PROCESS | 19610 | __metrics Screen width/height:1600/1200 14:03:54 INFO - PROCESS | 19610 | colorDepth:24 14:03:54 INFO - PROCESS | 19610 | Browser inner width/height: 1024/697 14:03:54 INFO - PROCESS | 19610 | __metrics 14:03:55 ERROR - PROCESS | 19610 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 14:03:56 INFO - TEST-INFO | 19610: exit 0 14:03:56 INFO - Browser initialized. 14:03:56 INFO - Running cycle 1/1 for kraken test... 14:03:56 INFO - TEST-INFO | started process 19740 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvlNtx9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:04:08 INFO - PROCESS | 19740 | RSS: Main: 156135424 14:04:08 INFO - PROCESS | 19740 | 14:04:10 INFO - PROCESS | 19740 | Cycle 1(1): loaded http://localhost:33389/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33389/tests/kraken/driver.html?testName=audio-beat-detection) 14:04:11 INFO - PROCESS | 19740 | RSS: Main: 160829440 14:04:11 INFO - PROCESS | 19740 | 14:04:14 INFO - PROCESS | 19740 | Cycle 1(1): loaded http://localhost:33389/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33389/tests/kraken/driver.html?testName=audio-dft) 14:04:14 INFO - PROCESS | 19740 | RSS: Main: 160284672 14:04:14 INFO - PROCESS | 19740 | 14:04:17 INFO - PROCESS | 19740 | Cycle 1(1): loaded http://localhost:33389/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33389/tests/kraken/driver.html?testName=audio-fft) 14:04:18 INFO - PROCESS | 19740 | RSS: Main: 161320960 14:04:18 INFO - PROCESS | 19740 | 14:04:20 INFO - PROCESS | 19740 | Cycle 1(1): loaded http://localhost:33389/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33389/tests/kraken/driver.html?testName=audio-oscillator) 14:04:21 INFO - PROCESS | 19740 | RSS: Main: 160600064 14:04:21 INFO - PROCESS | 19740 | 14:04:23 INFO - PROCESS | 19740 | Cycle 1(1): loaded http://localhost:33389/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33389/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:04:23 INFO - PROCESS | 19740 | RSS: Main: 160563200 14:04:23 INFO - PROCESS | 19740 | 14:04:27 INFO - PROCESS | 19740 | Cycle 1(1): loaded http://localhost:33389/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33389/tests/kraken/driver.html?testName=imaging-darkroom) 14:04:27 INFO - PROCESS | 19740 | RSS: Main: 160063488 14:04:27 INFO - PROCESS | 19740 | 14:04:31 INFO - PROCESS | 19740 | Cycle 1(1): loaded http://localhost:33389/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33389/tests/kraken/driver.html?testName=imaging-desaturate) 14:04:31 INFO - PROCESS | 19740 | RSS: Main: 160923648 14:04:31 INFO - PROCESS | 19740 | 14:04:34 INFO - PROCESS | 19740 | Cycle 1(1): loaded http://localhost:33389/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33389/tests/kraken/driver.html?testName=json-parse-financial) 14:04:35 INFO - PROCESS | 19740 | RSS: Main: 160727040 14:04:35 INFO - PROCESS | 19740 | 14:04:36 INFO - PROCESS | 19740 | Cycle 1(1): loaded http://localhost:33389/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33389/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:04:37 INFO - PROCESS | 19740 | RSS: Main: 161271808 14:04:37 INFO - PROCESS | 19740 | 14:04:39 INFO - PROCESS | 19740 | Cycle 1(1): loaded http://localhost:33389/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33389/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:04:39 INFO - PROCESS | 19740 | RSS: Main: 161366016 14:04:39 INFO - PROCESS | 19740 | 14:04:41 INFO - PROCESS | 19740 | Cycle 1(1): loaded http://localhost:33389/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33389/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:04:42 INFO - PROCESS | 19740 | RSS: Main: 162009088 14:04:42 INFO - PROCESS | 19740 | 14:04:44 INFO - PROCESS | 19740 | Cycle 1(1): loaded http://localhost:33389/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33389/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:04:45 INFO - PROCESS | 19740 | RSS: Main: 161910784 14:04:45 INFO - PROCESS | 19740 | 14:04:48 INFO - PROCESS | 19740 | Cycle 1(1): loaded http://localhost:33389/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33389/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:04:48 INFO - PROCESS | 19740 | RSS: Main: 161361920 14:04:48 INFO - PROCESS | 19740 | 14:04:50 INFO - PROCESS | 19740 | Cycle 1(1): loaded http://localhost:33389/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33389/tests/kraken/driver.html?testName=ai-astar) 14:04:50 INFO - PROCESS | 19740 | RSS: Main: 162160640 14:04:50 INFO - PROCESS | 19740 | 14:04:50 INFO - PROCESS | 19740 | __start_tp_report 14:04:50 INFO - PROCESS | 19740 | _x_x_mozilla_page_load 14:04:50 INFO - PROCESS | 19740 | _x_x_mozilla_page_load_details 14:04:50 INFO - PROCESS | 19740 | |i|pagename|runs| 14:04:50 INFO - PROCESS | 19740 | |0;ai-astar;111;107;112;110;112;111;109;110;109;111 14:04:50 INFO - PROCESS | 19740 | |1;audio-beat-detection;154;125;156;180;128;158;149;126;202;123 14:04:50 INFO - PROCESS | 19740 | |2;audio-dft;161;163;163;166;163;163;164;162;168;163 14:04:50 INFO - PROCESS | 19740 | |3;audio-fft;78;76;76;173;76;75;75;76;160;75 14:04:50 INFO - PROCESS | 19740 | |4;audio-oscillator;85;86;145;85;85;85;143;85;84;152 14:04:50 INFO - PROCESS | 19740 | |5;imaging-gaussian-blur;117;117;117;118;117;117;117;118;119;119 14:04:50 INFO - PROCESS | 19740 | |6;imaging-darkroom;146;147;147;148;147;148;147;148;147;148 14:04:50 INFO - PROCESS | 19740 | |7;imaging-desaturate;96;96;96;95;95;96;97;96;95;96 14:04:50 INFO - PROCESS | 19740 | |8;json-parse-financial;53;52;52;56;55;53;54;58;53;58 14:04:50 INFO - PROCESS | 19740 | |9;json-stringify-tinderbox;60;61;61;60;60;59;60;61;65;60 14:04:50 INFO - PROCESS | 19740 | |10;stanford-crypto-aes;75;75;83;76;82;77;78;77;106;77 14:04:50 INFO - PROCESS | 19740 | |11;stanford-crypto-ccm;123;123;128;134;119;138;129;123;129;130 14:04:50 INFO - PROCESS | 19740 | |12;stanford-crypto-pbkdf2;157;155;153;158;153;153;155;150;150;151 14:04:50 INFO - PROCESS | 19740 | |13;stanford-crypto-sha256-iterative;62;63;61;65;68;62;63;60;61;61 14:04:50 INFO - PROCESS | 19740 | __end_tp_report 14:04:50 INFO - PROCESS | 19740 | __start_cc_report 14:04:50 INFO - PROCESS | 19740 | _x_x_mozilla_cycle_collect,853 14:04:50 INFO - PROCESS | 19740 | __end_cc_report 14:04:50 INFO - PROCESS | 19740 | __startTimestamp1465506290746__endTimestamp 14:04:50 INFO - PROCESS | 19740 | 14:04:50 INFO - PROCESS | 19740 | ------- Summary: start ------- 14:04:50 INFO - PROCESS | 19740 | Number of tests: 14 14:04:50 INFO - PROCESS | 19740 | 14:04:50 INFO - PROCESS | 19740 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:1.55 (1.4%) stddev-sans-first:1.62 14:04:50 INFO - PROCESS | 19740 | Values: 111.0 107.0 112.0 110.0 112.0 111.0 109.0 110.0 109.0 111.0 14:04:50 INFO - PROCESS | 19740 | 14:04:50 INFO - PROCESS | 19740 | [#1] audio-beat-detection Cycles:10 Average:150.10 Median:155.00 stddev:26.11 (16.8%) stddev-sans-first:27.65 14:04:50 INFO - PROCESS | 19740 | Values: 154.0 125.0 156.0 180.0 128.0 158.0 149.0 126.0 202.0 123.0 14:04:50 INFO - PROCESS | 19740 | 14:04:50 INFO - PROCESS | 19740 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.00 stddev:2.01 (1.2%) stddev-sans-first:1.90 14:04:50 INFO - PROCESS | 19740 | Values: 161.0 163.0 163.0 166.0 163.0 163.0 164.0 162.0 168.0 163.0 14:04:50 INFO - PROCESS | 19740 | 14:04:50 INFO - PROCESS | 19740 | [#3] audio-fft Cycles:10 Average:94.00 Median:76.00 stddev:38.34 (50.5%) stddev-sans-first:40.23 14:04:50 INFO - PROCESS | 19740 | Values: 78.0 76.0 76.0 173.0 76.0 75.0 75.0 76.0 160.0 75.0 14:04:50 INFO - PROCESS | 19740 | 14:04:50 INFO - PROCESS | 19740 | [#4] audio-oscillator Cycles:10 Average:103.50 Median:85.00 stddev:29.87 (35.1%) stddev-sans-first:30.93 14:04:50 INFO - PROCESS | 19740 | Values: 85.0 86.0 145.0 85.0 85.0 85.0 143.0 85.0 84.0 152.0 14:04:50 INFO - PROCESS | 19740 | 14:04:50 INFO - PROCESS | 19740 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:117.50 stddev:0.84 (0.7%) stddev-sans-first:0.87 14:04:50 INFO - PROCESS | 19740 | Values: 117.0 117.0 117.0 118.0 117.0 117.0 117.0 118.0 119.0 119.0 14:04:50 INFO - PROCESS | 19740 | 14:04:50 INFO - PROCESS | 19740 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.50 stddev:0.67 (0.5%) stddev-sans-first:0.53 14:04:50 INFO - PROCESS | 19740 | Values: 146.0 147.0 147.0 148.0 147.0 148.0 147.0 148.0 147.0 148.0 14:04:50 INFO - PROCESS | 19740 | 14:04:50 INFO - PROCESS | 19740 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 14:04:50 INFO - PROCESS | 19740 | Values: 96.0 96.0 96.0 95.0 95.0 96.0 97.0 96.0 95.0 96.0 14:04:50 INFO - PROCESS | 19740 | 14:04:50 INFO - PROCESS | 19740 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:54.50 stddev:2.27 (4.2%) stddev-sans-first:2.35 14:04:50 INFO - PROCESS | 19740 | Values: 53.0 52.0 52.0 56.0 55.0 53.0 54.0 58.0 53.0 58.0 14:04:50 INFO - PROCESS | 19740 | 14:04:50 INFO - PROCESS | 19740 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:60.50 stddev:1.64 (2.7%) stddev-sans-first:1.72 14:04:50 INFO - PROCESS | 19740 | Values: 60.0 61.0 61.0 60.0 60.0 59.0 60.0 61.0 65.0 60.0 14:04:50 INFO - PROCESS | 19740 | 14:04:50 INFO - PROCESS | 19740 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:77.00 stddev:9.32 (12.1%) stddev-sans-first:9.67 14:04:50 INFO - PROCESS | 19740 | Values: 75.0 75.0 83.0 76.0 82.0 77.0 78.0 77.0 106.0 77.0 14:04:50 INFO - PROCESS | 19740 | 14:04:50 INFO - PROCESS | 19740 | [#11] stanford-crypto-ccm Cycles:10 Average:127.60 Median:129.00 stddev:5.74 (4.4%) stddev-sans-first:5.84 14:04:50 INFO - PROCESS | 19740 | Values: 123.0 123.0 128.0 134.0 119.0 138.0 129.0 123.0 129.0 130.0 14:04:50 INFO - PROCESS | 19740 | 14:04:50 INFO - PROCESS | 19740 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.50 Median:154.00 stddev:2.76 (1.8%) stddev-sans-first:2.62 14:04:50 INFO - PROCESS | 19740 | Values: 157.0 155.0 153.0 158.0 153.0 153.0 155.0 150.0 150.0 151.0 14:04:50 INFO - PROCESS | 19740 | 14:04:50 INFO - PROCESS | 19740 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:62.50 stddev:2.37 (3.8%) stddev-sans-first:2.50 14:04:50 INFO - PROCESS | 19740 | Values: 62.0 63.0 61.0 65.0 68.0 62.0 63.0 60.0 61.0 61.0 14:04:50 INFO - PROCESS | 19740 | -------- Summary: end -------- 14:04:50 INFO - PROCESS | 19740 | 14:04:51 INFO - TEST-INFO | 19740: exit 0 14:04:51 INFO - TEST-OK | kraken | took 61558ms 14:04:51 INFO - SUITE-END | took 1171s 14:04:51 INFO - Completed test suite (00:19:32) 14:04:51 INFO - javascript benchmark 14:04:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7721.36437567792, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3379.8817041403554, 3400.5069264956596, 3416.0947348952523, 3438.4326586113293, 3446.5519482467275, 5758.30900291965, 5770.422957704228, 5779.884402311951, 5799.710014499274, 5804.535637149029, 5773.5381169506445, 5799.246098007253, 5809.883802323951, 5829.0, 5847.210626565412, 5214.270002199695, 5235.764390602432, 5282.445343238962, 5306.575473962073, 5346.465353464661, 5252.5010124038345, 5288.444713305105, 5303.178007408838, 5338.3060202173665, 5339.759710813003, 5330.946690533103, 5368.62419630626, 5374.355077390699, 5411.080116380205, 5426.104692725715, 5312.4687531246955, 5396.43337449566, 5401.4328495508, 5405.135178371442, 5407.053765591045, 5301.416844147141, 5306.389765176977, 5314.734263286859, 5356.607282106641, 5394.676319420808, 5603.775848966036, 5693.373728889819, 5694.316681998145, 5701.914471282934, 5801.01382764931, 6261.686915654199, 6285.560010799246, 6290.842728931813, 6317.05244213367, 6317.620942743404, 6091.360407157274, 6233.563650544464, 6277.905831412532, 6279.560430769848, 6291.842703932438, 5831.650100993954, 5874.1776151338845, 5878.382769809194, 5921.822345329647, 5922.881542369171, 6443.259025212067, 6474.805755827333, 6481.837954051187, 6482.416582507502, 6485.0, 6023.939760602338, 6086.726097325631, 6203.96898015516, 6249.75000999964, 6250.156228909039, 6186.133941248228, 6318.810435686937, 6321.3994670507145, 6325.430711235919, 6334.081558174131, 6240.7503699851495, 6258.468030217391, 6283.874322513524, 6290.811275661737, 6290.937090629035, 6071.453569178795, 6124.014786914997, 6161.168242287234, 6265.749370025148, 6274.341194174637, 4719.716816990992, 4734.692245004064, 4748.6438517111355, 4759.024399998061, 4770.308305295782, 4233.0, 4235.364695295731, 4235.53409124996, 4239.682023848224, 4246.681498887596, 5934.970325148433, 5996.640201587918, 6021.819345419644, 6025.066114752132, 6051.727672254671, 6111.561351782736, 6222.160008398808, 6223.782167624111, 6258.43674069336, 6330.841728956813, 6048.706589392613, 6059.7273122709585, 6065.2418447694035, 6070.848228794315, 6074.817755467343, 5223.738813059332, 5316.0962636351915, 5349.144136938071, 5356.196570514454, 5394.433584473652, 6447.838804029843, 6462.773802916875, 6482.967585162044, 6503.959366501337, 6537.0, 6134.846628834315, 6339.556231063873, 6343.651099189405, 6353.618782873043, 6359.109724638462, 6438.937575300023, 6451.225852897683, 6520.119783829123, 6596.3073877244115, 6601.33986601336, 6243.125962365363, 6255.56211065221, 6258.874822503433, 6260.186175797117, 6270.686465676789, 6122.846928826815, 6212.689365531795, 6326.6520341381665, 6342.016987366966, 6359.777407790705, 6116.8776624468155, 6118.938810611837, 6192.628442293477, 6195.318514963441, 6201.875962480815, 6103.908441373294, 6145.508359331332, 6171.105189747372, 6171.9074213887725, 6190.350013248724, 5904.3210030845285, 5932.021216499229, 6021.789237376671, 6100.450959413674, 6104.633721976518, 6153.323134455117, 6225.0, 6232.376762323732, 6247.96876015617, 6263.592866463665, 6107.938920610737, 6108.472881779555, 6114.908276375947, 6134.509239260759, 6138.14066030765], "value": 5782.290460655938, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.9911201331978, 627.2974268818923, 641.1216633212499, 647.5402464250382, 666.7033170239246, 46742.298865517005, 47933.0, 48035.51964480354, 48265.0, 51037.489625103735, 49820.50179498204, 50020.749896250556, 50240.24639630409, 50265.24602130962, 50536.747316263456, 9011.324150688692, 9223.308251881135, 9229.077092290785, 9232.953835230814, 9249.167574918256, 9145.131212534832, 9202.723918282429, 9241.861372079424, 9249.260059195281, 9265.814683706321, 9251.0, 9269.490178040205, 9314.068593140666, 9320.02139775324, 9324.207442367408, 9214.861777073349, 9276.489793061379, 9283.39657922233, 9284.164425201765, 9290.163885250326, 9003.954980225122, 9066.818663626691, 9103.08969103091, 9104.772380690469, 9124.954375228148, 45146.774266128785, 45563.54436455626, 45883.31175032377, 45940.0, 46111.0, 3769.9434508482395, 3833.4249862520564, 3840.8079596020366, 3865.265599536079, 4047.5750046245016, 34408.139796505035, 34859.82570087159, 34938.650613493795, 35083.0, 35346.469802952975, 4755.0489902019735, 4763.666543341968, 4807.567318941277, 4808.230683090689, 4819.6385271104455, 372947.0, 373409.0, 373667.0, 375036.0, 375090.99999999726, 54486.45513544814, 55286.44713552813, 55738.0, 65522.34477655258, 65616.0, 69925.65037174782, 70414.2958570418, 70861.64569177224, 70868.0, 71421.28578714251, 16219.107949062678, 16379.0, 16406.83593164077, 16409.58976025585, 16440.260188291555, 13321.200727956353, 13326.200427974352, 13360.599182024554, 13362.131461454974, 13491.460341586422, 19060.428187154408, 19369.225230990603, 19467.610647786965, 19478.496309458016, 19524.079997608464, 6060.545459090586, 6125.540584456184, 6129.632222066691, 6136.723847426876, 6275.46293990495, 1030.5568605499707, 1077.5420446310286, 1103.6413165721174, 1116.3692513729716, 1136.7271854754965, 33419.49870751941, 33528.32943341119, 33566.49650255248, 33913.49129763056, 33928.982130536126, 1146.8451759012594, 1170.0814860334597, 1219.451246938881, 1225.2281062930474, 1302.0885380233685, 17736.733948990775, 17740.0, 17847.46457606274, 17878.28486860537, 17967.382935535865, 538205.0, 553055.0, 559791.0, 565507.0, 567697.0, 62003.0, 62777.372226278065, 63127.0, 63173.36826631675, 63234.683826581495, 1423.4946593958996, 1433.6129245103764, 1436.2531483628454, 1441.0273065680833, 1482.844301348343, 31965.840170798998, 32536.34927301488, 32693.673063269063, 33241.33517329688, 33331.333373332884, 54320.0, 64024.67987660032, 66703.33296666971, 66787.33212668005, 66966.0, 466838.0, 469271.0, 472057.0, 472800.0, 472969.0, 28281.85859070774, 28734.712652873204, 28917.277068073465, 29049.7095029047, 31305.8434707825, 53252.201216981004, 53898.730506347216, 54398.45601543934, 55485.0, 55868.0, 44062.55937440713, 44443.33334999913, 44621.10757784891, 44653.0, 44704.55295447004, 44614.0, 44795.77602112099, 44827.551724483645, 46006.53993460156, 46106.0, 44577.0, 44969.100617986805, 45164.0, 45328.54671453243, 45747.0, 38421.6157838418, 38823.223535529694, 39027.0, 39331.6066839328, 39835.60164398319, 29454.558181627723, 29791.957281495044, 30434.543481847348, 30456.84771576128, 30508.237294067825], "value": 21441.344771375738, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.7684808083433, 411.27615396901456, 412.38760440745506, 414.2067939895101, 427.3632287891043, 18604.34884779033, 19660.410187694357, 20103.0, 20105.798942010595, 20662.07020684069, 12951.41718622662, 16626.00243985362, 18830.623387532276, 19638.0, 19690.606187876234, 5216.634835561522, 5365.839024829242, 5369.62412631116, 5384.542313903323, 5392.595555333366, 4976.701397916118, 5105.438401775802, 5271.077561426754, 5312.946870531284, 5385.084535628953, 4991.201407774757, 5040.42035165957, 5046.6467347285525, 5049.3183420238165, 5085.313482679846, 4997.325361076245, 5033.094043072246, 5154.974225128888, 5724.856878578027, 5728.570357223183, 5030.144875371196, 5053.267276244961, 5061.974690126563, 5069.264956581275, 5167.638265321429, 14475.565733028026, 20359.676621019586, 22816.429589260402, 24327.391815204584, 24343.269701908972, 2457.7542245775458, 2532.683414573178, 2537.5051864886354, 2573.2537564106387, 2740.9995351696684, 11062.0, 11331.886681133166, 11787.882121178764, 14576.562703118923, 15747.685046299124, 2021.4946263434142, 2109.725735654355, 2146.388279340396, 2151.08578853988, 2164.826813854888, 82614.17385826186, 86911.0, 87878.5606071972, 87888.56055719744, 87955.0, 11472.082233421306, 11564.306141631529, 11728.354940478184, 11912.940435297767, 11940.582079627171, 13213.14114582549, 16620.501384958472, 16798.748018779726, 16951.321947121978, 17071.914640426967, 7641.617919104134, 7973.44185906981, 8417.242448179693, 8436.578171091422, 8500.70247541333, 8326.875096873551, 8328.625211865481, 8356.791080223044, 8432.704855330034, 8549.829003419896, 4351.477822661301, 4403.0, 4404.1411924674385, 4534.750588717587, 4538.319252112144, 2030.7461567304088, 2065.731454910882, 2066.638338290793, 2106.9051892664866, 2110.6622940329476, 972.1979367022235, 1011.0647650923014, 1029.7374169586708, 1085.571199376242, 1104.3429159649995, 17062.914685426495, 19474.513137171685, 19626.50933726668, 19703.310384136486, 19995.800041999686, 1005.2962925951863, 1055.145332280855, 1077.0844781935448, 1084.38732116354, 1088.3905013192636, 10880.67357979262, 11127.443627818577, 11131.220814543067, 11165.441727913572, 11167.441627918734, 474137.0, 475449.0, 478785.0, 479481.0, 482354.0, 60803.39196608066, 92977.53511232536, 97228.51385743025, 97599.0, 100039.0, 1058.6188971970084, 1060.9893901061046, 1088.1838621034224, 1118.6196693124377, 1130.4404319861721, 17399.391021314193, 17465.38871139504, 17544.73682894732, 17779.822201777817, 17832.84086534371, 35050.474242886885, 39311.0, 41273.0, 42421.363679544214, 45069.09861802811, 58209.70895145667, 58262.12606810986, 58706.119408208055, 58743.4125658738, 59125.0, 8715.607797648994, 9048.095190480899, 9078.137576930181, 9125.498097604695, 9292.58183381736, 7806.921930780847, 9428.245740340893, 12691.111622186358, 13269.66825829362, 13625.86374136246, 11988.940055299669, 12037.337946413032, 12101.273923564615, 12165.939170304446, 12257.26456412618, 10207.0, 11651.53393864236, 11707.2975621463, 11805.468753906267, 11886.583969561023, 11860.703482413008, 11896.702582435508, 11971.341576213392, 12059.457324420599, 12306.0, 8995.415298005608, 9010.738496610611, 9122.452652840851, 9223.76940576491, 9320.254379649747, 11117.722056948642, 11165.330080195214, 11329.320240785579, 11376.94311528437, 11415.486303116213], "value": 9287.3843760086, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1514.5683480208136, 1521.1633601519163, 1692.9746053809195, 1697.702901992151, 1822.0434272007194, 8196.713115040975, 8654.307655387569, 8826.558672066396, 9381.530923453825, 9402.81194376113, 8736.825263494726, 8835.734927952171, 9044.728658140266, 9051.275897928166, 9052.72841814745, 2480.131953816168, 2520.420303330235, 2521.9747802521924, 2530.063876365747, 2532.1011041080337, 2449.9877500612474, 2498.5002999400103, 2516.5973444248925, 2519.1560827122935, 2521.218422289087, 2442.1696623148127, 2442.5237078769646, 2449.2774631483667, 2453.9631905521433, 2463.4580392313665, 2384.451576137481, 2397.5564520563667, 2431.8054555635595, 2481.404462928902, 2484.3292311075907, 2432.4648577312964, 2439.9634005489934, 2446.6330050492393, 2462.2982450001664, 2465.0263146057205, 8937.285017198608, 9007.369484136114, 9018.63925442988, 9021.097890210993, 9032.683856065072, 5552.333719953632, 5706.400827913092, 5707.600467967244, 5711.086226203787, 5717.313922329306, 3397.371486275047, 3465.480177973299, 3567.661072198137, 3644.580873199563, 3650.4159334506353, 1114.3202646385698, 1126.1553834624033, 1148.844905937696, 1162.3839365136491, 1169.3626973299572, 12844.935775321064, 12877.67805804853, 12925.870741292561, 12955.417006234742, 12968.35158242084, 4924.1875090610365, 4980.477049909779, 5043.36957880265, 5044.974775126174, 5073.847784566469, 10743.462826858782, 10826.729331766612, 10876.184286178568, 10876.564937402574, 10877.510512026978, 5473.0969390050195, 5489.780408783684, 5504.724763761796, 5521.696306703089, 5727.255456790674, 4464.441944756905, 4956.603471722254, 5103.8468845934685, 5109.9744501277255, 5121.948780512222, 4271.508776490743, 4320.913581728348, 4338.609525142752, 4342.500612429548, 4491.348754430589, 1371.732512160119, 1388.5001399496173, 1391.415605445695, 1412.5903487988369, 1421.7014426970452, 1045.1429827541494, 1058.6083149234678, 1074.8602681651491, 1077.1329080090602, 1094.2504384496644, 6361.236651601837, 6445.323241059715, 6470.352964703586, 6505.902411463831, 6585.209774826955, 489.87263311538544, 496.5406998526349, 501.1780679685319, 502.5979216626684, 508.80919655129327, 4323.870283891489, 4379.4525684289465, 4408.823647054146, 4425.269830478, 4474.127545128734, 11208.607698730506, 11638.76722465546, 11640.650780476599, 11715.121365897592, 11717.472713727902, 10902.563897444013, 11346.432678366049, 11352.659420217407, 11491.080713542897, 11644.708882278012, 8430.747077587683, 8558.315334773204, 8565.314774818, 8636.265917396966, 8700.521471319138, 6540.247871494648, 6568.310327415553, 6715.56348837324, 6720.899186512109, 6825.668994546016, 10067.0, 10333.534990925576, 10584.84122738175, 10673.679789606324, 10719.410432425979, 10647.467626618793, 10796.514156862802, 10797.56809727602, 10822.56709731602, 10921.508532116233, 7477.775666730006, 7914.169012253861, 7964.482308649919, 8006.479578827358, 8241.50550966944, 8668.0, 8688.261497772508, 8701.651933922572, 8709.782255443664, 8778.692745753868, 8008.959955200186, 8158.551279679437, 8251.793705157419, 8265.917340826514, 8310.584470776315, 7965.880511792212, 8053.275205231323, 8101.351891848756, 8188.222118898695, 8231.300339471212, 7071.43428525727, 7141.143062832493, 7287.125544934642, 7463.738769143054, 7478.663460144416, 5487.341519017584, 5493.368262649847, 5501.881775516375, 5587.273654424899, 5649.519790817826, 5631.802886898939, 5652.434756524314, 5689.431056894277, 5728.828135155952, 5755.539556835527], "value": 4824.764826199411, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.18497421214875, 346.9954481775262, 351.51490942499345, 354.36037951497536, 355.5111721383098, 5712.771489140429, 5761.337446193689, 5919.585629005971, 5995.790147344844, 6007.939920600793, 5767.798127065554, 5785.27684039495, 5792.449717276862, 5795.652260864351, 5804.390538993408, 4451.28779395296, 4492.2812350024005, 4497.2129877271345, 4502.816134174923, 4536.56902594253, 4439.1565602535575, 4498.842540511083, 4516.0, 4516.638668906479, 4538.727676339414, 4460.553944605546, 4463.174312752151, 4474.284114541674, 4491.550844915515, 4508.594226519613, 4508.684392092555, 4509.391232183662, 4537.773111344452, 4550.704204226715, 4579.656525760582, 3914.706397020206, 4016.2369149861433, 4025.75845449274, 4083.224187404384, 4083.9591604083876, 5581.804636837691, 5616.747246373923, 5641.097424412074, 5646.887062258773, 5676.574256930747, 5219.0, 5222.328854766476, 5237.528622424, 5242.423333433319, 5251.55582214894, 5951.256092988377, 6097.17688112108, 6124.908126378108, 6129.804688085825, 6167.969160154215, 4455.6830448166775, 4459.888502787424, 4464.15181115587, 4484.596386325214, 4498.730076195438, 6221.782237621662, 6411.679416029227, 6438.195225596801, 6456.451201647866, 6477.255115661665, 4560.977195114003, 4565.589096981287, 4566.49768525462, 4571.634269258451, 4584.518625544337, 4602.7698615069785, 4615.538446155358, 4630.383833134269, 4649.0, 4653.6509761768, 5156.7421628919155, 5228.660137091077, 5229.0, 5264.1840514719515, 5269.499397557226, 5837.081459270365, 5884.47039766423, 6106.786262480792, 6145.784897528565, 6155.84610384735, 1563.1012168003217, 1573.2920185916155, 1583.8099428068474, 1585.888987770845, 1586.841315868427, 996.6312464388222, 1008.0121480948711, 1012.3015119567475, 1013.8732658417698, 1031.7884833609091, 5259.579233661298, 5263.526142712919, 5289.153735402318, 5295.046891559557, 5339.893202135935, 5501.642393244426, 5533.6403133796175, 5566.304211973504, 5604.299462567179, 5654.97172514143, 5327.680339179662, 5331.4401987790725, 5533.22534845122, 5980.282366116007, 5994.28068631767, 3350.0619826448633, 3351.983240083784, 3353.714934230569, 3370.6966373026544, 3391.6269210386836, 6247.0629405589525, 6528.37980391862, 6539.593987292755, 6567.704453299613, 6590.439812615981, 6259.4679452246155, 6420.7752728655205, 6424.646644434601, 6457.61254324742, 6478.792997466285, 6368.5860419072615, 6409.519286053658, 6453.838654033687, 6507.934920650733, 6529.836754081186, 6236.937630623635, 6247.531435142291, 6259.655718935503, 6261.78083767066, 6322.143492469681, 6190.823743488722, 6194.5044396449075, 6201.0, 6207.844803879939, 6214.564980451325, 6229.501639868709, 6414.711337989895, 6453.709583068679, 6509.479241660751, 6545.494536256783, 4318.978405107954, 4331.891702707458, 4340.47914250292, 4360.9127817444105, 4379.58393952574, 6039.516838652985, 6189.907151392643, 6293.496520278275, 6305.684715764101, 6365.440467085594, 6146.877062458815, 6147.200863887666, 6157.84605384869, 6178.66017369049, 6181.258249010148, 5982.312034116132, 6139.815805525842, 6144.8771024580155, 6154.261488621394, 6219.564630475823, 5990.610610310316, 6044.576879618385, 6073.848153796191, 6129.816105516842, 6141.201643786279, 6063.848403789941, 6082.847928801815, 6177.1969643945995, 6196.172129221981, 6248.875022499434, 5849.94150058511, 6089.4776305923515, 6091.573589848668, 6093.086037094294, 6104.694765261808], "value": 4633.519795156819, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [760.7983884270669, 794.7337641889967, 848.1772680499913, 855.4525103933483, 901.8602116671914, 16529.586760330996, 16971.3211471541, 17099.658006839873, 17105.82894171058, 17161.14194290285, 15636.687266254668, 15836.366545338202, 15863.206839658029, 15869.920650396733, 15886.285117169726, 722.0973782771536, 833.7957200485889, 857.2584714222215, 857.2884505860121, 859.6733241368271, 867.2281669314284, 868.1622234543696, 872.149654087263, 873.8383399071192, 874.2830878679486, 921.0651189043126, 926.2404828041009, 930.06993006993, 930.9255259579252, 933.943963362197, 900.2617853360215, 918.4213945214506, 921.345844450441, 921.5438358012759, 922.3681777982104, 671.5802623360399, 673.6699017481399, 676.2257215488288, 677.2753154125088, 679.7179170644176, 15987.280572374271, 16104.919475402665, 16109.516714498584, 16116.83883161165, 16180.433684820975, 15123.924380378137, 15226.543203703906, 15301.0, 15399.769003464957, 15495.92252038744, 12917.031222658245, 12941.676458088528, 12954.287514186715, 12988.0, 13037.282949437777, 3887.3197190491833, 3916.6083391660604, 3918.4122381642696, 3942.2706799242233, 4080.81636326366, 81533.0, 81536.59231703804, 81998.0, 82356.0, 83084.0, 11939.88060119405, 12180.695482613006, 12314.938425307817, 12383.19509231915, 12598.937005314914, 22849.657255141185, 23158.652620210374, 23650.172243971378, 23668.763312367002, 23899.0, 8951.104889511127, 9043.502607356528, 9052.140046695553, 9244.214241789388, 9288.7677808054, 5004.124278251292, 5015.3480047593575, 5053.646244762905, 5104.183330667075, 5173.611979101583, 3897.7466464679705, 4020.8793736187963, 4025.174839158024, 4029.37544680575, 4032.274190645653, 665.9200895892524, 677.7356830835978, 682.1813823411926, 686.0361192524512, 704.0389867830477, 748.4162353364385, 795.0, 796.0685997383076, 802.4864086984335, 810.6190090657382, 10695.197860160519, 11228.326300421837, 11231.157663175294, 11259.774804504028, 11275.32348059119, 767.976960691169, 773.6286582440348, 773.6827900560743, 781.1368437876179, 781.5310813511961, 5194.0, 5241.9737901310245, 5252.264682944391, 5299.2316114164005, 5327.254184414185, 116395.41802290935, 124956.37521812333, 126201.0, 126621.0, 126888.36555817162, 101842.49078754558, 104664.47667761765, 105540.47229763801, 105909.0, 106956.0, 85697.57151214204, 87685.56157219173, 87703.0, 88267.55866220628, 95160.52419737857, 10033.04415537768, 10218.284720069523, 10295.330803497749, 10297.588096476356, 10321.380717156995, 54502.7274863639, 54544.0, 55566.16650750323, 56212.71893640506, 56554.7172264136, 73183.0, 84521.57739211265, 85213.57393213242, 85837.57081214554, 86400.56799715961, 13418.127821691558, 13786.862131378557, 13866.930665346608, 14021.509247176708, 14769.556913292618, 16368.918155409146, 16478.505644830195, 16824.915875421033, 16851.325946962475, 16939.576510587332, 14985.475508357154, 15021.173835438718, 15432.691346173238, 15461.149636770086, 15591.142487163315, 14885.776713349092, 15141.242937852843, 15284.082955022734, 15369.077855328716, 15491.147986860831, 15017.549473515812, 15068.773968390702, 15209.77185342243, 15287.61780955485, 15302.476937315345, 12165.660910955752, 12211.26732396059, 12500.687482813002, 12752.42614082387, 12752.74494510123, 12185.69535761613, 12663.620091397273, 12918.418671159632, 12939.223646581235, 13059.34703264852], "value": 8231.720744832475, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1521.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 107.0, 112.0, 110.0, 112.0, 111.0, 109.0, 110.0, 109.0, 111.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 125.0, 156.0, 180.0, 128.0, 158.0, 149.0, 126.0, 202.0, 123.0], "value": 150.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 163.0, 166.0, 163.0, 163.0, 164.0, 162.0, 168.0, 163.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 76.0, 173.0, 76.0, 75.0, 75.0, 76.0, 160.0, 75.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 145.0, 85.0, 85.0, 85.0, 143.0, 85.0, 84.0, 152.0], "value": 103.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 119.0, 119.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 148.0, 147.0, 148.0, 147.0, 148.0, 147.0, 148.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 97.0, 96.0, 95.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 52.0, 56.0, 55.0, 53.0, 54.0, 58.0, 53.0, 58.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 60.0, 60.0, 59.0, 60.0, 61.0, 65.0, 60.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 83.0, 76.0, 82.0, 77.0, 78.0, 77.0, 106.0, 77.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 123.0, 128.0, 134.0, 119.0, 138.0, 129.0, 123.0, 129.0, 130.0], "value": 127.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 155.0, 153.0, 158.0, 153.0, 153.0, 155.0, 150.0, 150.0, 151.0], "value": 153.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 61.0, 65.0, 68.0, 62.0, 63.0, 60.0, 61.0, 61.0], "value": 62.6, "unit": "score"}]}]} 14:04:52 INFO - Return code: 0 14:04:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:04:52 ERROR - # TBPL SUCCESS # 14:04:52 INFO - Running post-action listener: _resource_record_post_action 14:04:52 INFO - ##### 14:04:52 INFO - ##### Finished run-tests step (success) 14:04:52 INFO - ##### 14:04:52 INFO - Running post-run listener: _resource_record_post_run 14:04:52 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 510197760; Read time: 0; Write time: 528672 14:04:52 INFO - TinderboxPrint: CPU usage
13.4% 14:04:52 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 14:04:52 INFO - TinderboxPrint: I/O write bytes / time
510,197,760 / 528,672 14:04:52 INFO - TinderboxPrint: CPU idle
8,214.5 (86.6%) 14:04:52 INFO - TinderboxPrint: CPU user
1,214.6 (12.8%) 14:04:52 INFO - TinderboxPrint: Swap in / out
0 / 0 14:04:52 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 249573376; Read time: 0; Write time: 297084 14:04:52 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 249892864; Read time: 0; Write time: 222908 14:04:52 INFO - Running post-run listener: _upload_blobber_files 14:04:52 INFO - Blob upload gear active. 14:04:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:04:52 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 14:04:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:04:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:04:53 INFO - (blobuploader) - INFO - Open directory for files ... 14:04:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:04:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:04:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:04:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:04:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:04:53 INFO - (blobuploader) - INFO - Done attempting. 14:04:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:04:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:04:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:04:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:04:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:04:54 INFO - (blobuploader) - INFO - Done attempting. 14:04:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:04:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:04:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:04:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:04:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:04:59 INFO - (blobuploader) - INFO - Done attempting. 14:04:59 INFO - (blobuploader) - INFO - Iteration through files over. 14:04:59 INFO - Return code: 0 14:04:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:04:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:04:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b8525706bf0cfac6b7571f2fdbd85569b9a0937b685e2bf0e0c648779e03f1973279b8a855edb7f7384c579c5bf9f9c3b27271b48db30f813d5a4a51dbefba88", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/14ec6e6d1d5c424b987a8532b594831b41621f954ec68320ae8d6ef0ada75f8c8c79b242ea9739c7f7c8f5b4edb565d6cd94e04aa3ec679e5bd6c3ed2f51651f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b4365447d4bb7fe1db67842a258bca2de4b2eb778c94e5fffa0b481126be1131f32725d4cdd11e696ef80cdb36bdbd109f649eb641284928bd059523d4111499"} 14:04:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:04:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:04:59 INFO - Contents: 14:04:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b8525706bf0cfac6b7571f2fdbd85569b9a0937b685e2bf0e0c648779e03f1973279b8a855edb7f7384c579c5bf9f9c3b27271b48db30f813d5a4a51dbefba88", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/14ec6e6d1d5c424b987a8532b594831b41621f954ec68320ae8d6ef0ada75f8c8c79b242ea9739c7f7c8f5b4edb565d6cd94e04aa3ec679e5bd6c3ed2f51651f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b4365447d4bb7fe1db67842a258bca2de4b2eb778c94e5fffa0b481126be1131f32725d4cdd11e696ef80cdb36bdbd109f649eb641284928bd059523d4111499"} 14:04:59 INFO - Running post-run listener: copy_logs_to_upload_dir 14:04:59 INFO - Copying logs to upload dir... 14:04:59 INFO - mkdir: /builds/slave/test/build/upload/logs 14:04:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.917343 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-06-09 14:04:59.363963) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 14:04:59.367938) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1465505064.271795-1226615883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b8525706bf0cfac6b7571f2fdbd85569b9a0937b685e2bf0e0c648779e03f1973279b8a855edb7f7384c579c5bf9f9c3b27271b48db30f813d5a4a51dbefba88", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/14ec6e6d1d5c424b987a8532b594831b41621f954ec68320ae8d6ef0ada75f8c8c79b242ea9739c7f7c8f5b4edb565d6cd94e04aa3ec679e5bd6c3ed2f51651f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b4365447d4bb7fe1db67842a258bca2de4b2eb778c94e5fffa0b481126be1131f32725d4cdd11e696ef80cdb36bdbd109f649eb641284928bd059523d4111499"} build_url:https://queue.taskcluster.net/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011777 build_url: 'https://queue.taskcluster.net/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b8525706bf0cfac6b7571f2fdbd85569b9a0937b685e2bf0e0c648779e03f1973279b8a855edb7f7384c579c5bf9f9c3b27271b48db30f813d5a4a51dbefba88", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/14ec6e6d1d5c424b987a8532b594831b41621f954ec68320ae8d6ef0ada75f8c8c79b242ea9739c7f7c8f5b4edb565d6cd94e04aa3ec679e5bd6c3ed2f51651f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b4365447d4bb7fe1db67842a258bca2de4b2eb778c94e5fffa0b481126be1131f32725d4cdd11e696ef80cdb36bdbd109f649eb641284928bd059523d4111499"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 14:04:59.393886) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:04:59.394225) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1465505064.271795-1226615883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004414 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:04:59.478447) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 14:04:59.478784) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 14:04:59.479082) ========= ========= Total master_lag: 0.16 =========