builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-046 starttime: 1465505070.52 results: success (0) buildid: 20160609031135 builduid: b7e12a9c3411425faa1664d3e023b6f5 revision: 1ae7a82e2b1d2b18ccfa9a578040b46c774bc501 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 13:44:30.517522) ========= 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:30.517939) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 13:44:30.518208) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 13:44:30.532903) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 13:44:30.533206) ========= 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=652eb03db935cfc1c15ebda0000001ad-1465505069.816311-585326722 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 13:44:30-- 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% 46.1M=0s 2016-06-09 13:44:30 (46.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.092279 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 13:44:30.639345) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 13:44:30.639776) ========= 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=652eb03db935cfc1c15ebda0000001ad-1465505069.816311-585326722 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014861 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 13:44:30.729145) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 13:44:30.729510) ========= 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=652eb03db935cfc1c15ebda0000001ad-1465505069.816311-585326722 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 13:44:30,746 truncating revision to first 12 chars 2016-06-09 13:44:30,746 Setting DEBUG logging. 2016-06-09 13:44:30,747 attempt 1/10 2016-06-09 13:44:30,747 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:31,054 unpacking tar archive at: mozilla-aurora-1ae7a82e2b1d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.654396 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 13:44:31.397162) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 13:44:31.397516) ========= script_repo_revision: 1ae7a82e2b1d2b18ccfa9a578040b46c774bc501 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 13:44:31.397914) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 13:44:31.398193) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 13:44:31.408473) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-06-09 13:44:31.408757) ========= /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=652eb03db935cfc1c15ebda0000001ad-1465505069.816311-585326722 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:44:31 INFO - MultiFileLogger online at 20160609 13:44:31 in /builds/slave/test 13:44:31 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:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:44:31 INFO - {'append_to_log': False, 13:44:31 INFO - 'base_work_dir': '/builds/slave/test', 13:44:31 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 13:44:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:44:31 INFO - 'branch': 'Mozilla-Aurora', 13:44:31 INFO - 'buildbot_json_path': 'buildprops.json', 13:44:31 INFO - 'config_files': ('talos/linux_config.py',), 13:44:31 INFO - 'default_actions': ('clobber', 13:44:31 INFO - 'read-buildbot-config', 13:44:31 INFO - 'download-and-extract', 13:44:31 INFO - 'populate-webroot', 13:44:31 INFO - 'create-virtualenv', 13:44:31 INFO - 'install', 13:44:31 INFO - 'run-tests'), 13:44:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:44:31 INFO - 'download_minidump_stackwalk': True, 13:44:31 INFO - 'download_symbols': 'ondemand', 13:44:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:44:31 INFO - 'tooltool.py': '/tools/tooltool.py', 13:44:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:44:31 INFO - '/tools/misc-python/virtualenv.py')}, 13:44:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:44:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:44:31 INFO - 'installer_path': 'installer.exe', 13:44:31 INFO - 'log_level': 'info', 13:44:31 INFO - 'log_name': 'talos', 13:44:31 INFO - 'log_to_console': True, 13:44:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:44:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:44:31 INFO - 'opt_config_files': (), 13:44:31 INFO - 'pip_index': False, 13:44:31 INFO - 'sps_profile': False, 13:44:31 INFO - 'sps_profile_interval': 0, 13:44:31 INFO - 'suite': 'dromaeojs-e10s', 13:44:31 INFO - 'system_bits': '32', 13:44:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:44:31 INFO - 'title': 'talos-linux64-ix-046', 13:44:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:44:31 INFO - 'use_talos_json': True, 13:44:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:44:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:44:31 INFO - 'work_dir': 'build'} 13:44:31 INFO - ##### 13:44:31 INFO - ##### Running clobber step. 13:44:31 INFO - ##### 13:44:31 INFO - Running pre-action listener: _resource_record_pre_action 13:44:31 INFO - Running main action method: clobber 13:44:31 INFO - rmtree: /builds/slave/test/build 13:44:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:44:32 INFO - Running post-action listener: _resource_record_post_action 13:44:32 INFO - ##### 13:44:32 INFO - ##### Finished clobber step (success) 13:44:32 INFO - ##### 13:44:32 INFO - ##### 13:44:32 INFO - ##### Running read-buildbot-config step. 13:44:32 INFO - ##### 13:44:32 INFO - Running pre-action listener: _resource_record_pre_action 13:44:32 INFO - Running main action method: read_buildbot_config 13:44:32 INFO - Using buildbot properties: 13:44:32 INFO - { 13:44:32 INFO - "project": "", 13:44:32 INFO - "product": "firefox", 13:44:32 INFO - "script_repo_revision": "production", 13:44:32 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 13:44:32 INFO - "repository": "", 13:44:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 13:44:32 INFO - "buildid": "20160609031135", 13:44:32 INFO - "pgo_build": "True", 13:44:32 INFO - "basedir": "/builds/slave/test", 13:44:32 INFO - "buildnumber": 399, 13:44:32 INFO - "slavename": "talos-linux64-ix-046", 13:44:32 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:44:32 INFO - "platform": "ubuntu64_hw", 13:44:32 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 13:44:32 INFO - "branch": "mozilla-aurora", 13:44:32 INFO - "repo_path": "releases/mozilla-aurora", 13:44:32 INFO - "revision": "1ae7a82e2b1d2b18ccfa9a578040b46c774bc501", 13:44:32 INFO - "stage_platform": "linux64-pgo", 13:44:32 INFO - "builduid": "b7e12a9c3411425faa1664d3e023b6f5", 13:44:32 INFO - "slavebuilddir": "test" 13:44:32 INFO - } 13:44:32 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:32 INFO - Running post-action listener: _resource_record_post_action 13:44:32 INFO - ##### 13:44:32 INFO - ##### Finished read-buildbot-config step (success) 13:44:32 INFO - ##### 13:44:32 INFO - ##### 13:44:32 INFO - ##### Running download-and-extract step. 13:44:32 INFO - ##### 13:44:32 INFO - Running pre-action listener: _resource_record_pre_action 13:44:32 INFO - Running main action method: download_and_extract 13:44:32 INFO - mkdir: /builds/slave/test/build/tests 13:44:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:32 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:32 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:32 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:32 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:32 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:32 INFO - Downloaded 1361 bytes. 13:44:32 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 13:44:32 INFO - Using the following test package requirements: 13:44:32 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 13:44:32 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 13:44:32 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 13:44:32 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 13:44:32 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 13:44:32 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 13:44:32 INFO - u'jsshell-linux-x86_64.zip'], 13:44:32 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 13:44:32 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 13:44:32 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 13:44:32 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 13:44:32 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 13:44:32 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 13:44:32 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 13:44:32 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 13:44:32 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 13:44:32 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 13:44:32 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 13:44:32 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:44:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:32 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:32 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:32 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:32 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:32 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:33 INFO - Downloaded 24472728 bytes. 13:44:33 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:33 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:34 INFO - Return code: 0 13:44:34 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:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:34 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:34 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:34 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:34 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:34 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:36 INFO - Downloaded 24472728 bytes. 13:44:36 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:36 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:37 INFO - Return code: 0 13:44:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:37 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:37 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:37 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:37 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:37 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:38 INFO - Downloaded 10833369 bytes. 13:44:38 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:38 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:38 INFO - Return code: 0 13:44:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:38 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:38 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:38 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:38 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:38 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:40 INFO - Downloaded 63540841 bytes. 13:44:40 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:40 INFO - mkdir: /builds/slave/test/properties 13:44:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:44:40 INFO - Writing to file /builds/slave/test/properties/build_url 13:44:40 INFO - Contents: 13:44:40 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:41 INFO - Running post-action listener: _resource_record_post_action 13:44:41 INFO - Running post-action listener: set_extra_try_arguments 13:44:41 INFO - ##### 13:44:41 INFO - ##### Finished download-and-extract step (success) 13:44:41 INFO - ##### 13:44:41 INFO - ##### 13:44:41 INFO - ##### Running populate-webroot step. 13:44:41 INFO - ##### 13:44:41 INFO - Running pre-action listener: _resource_record_pre_action 13:44:41 INFO - Running main action method: populate_webroot 13:44:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:44:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:44:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:44:41 INFO - '--tppagecycles', 13:44:41 INFO - '7'], 13:44:41 INFO - 'tests': ['tsvgm']}}, 13:44:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:44:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:44:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:44:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:44:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:44:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:44:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:44:41 INFO - 'talos_options': ['--disable-e10s'], 13:44:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:44:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:44:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:44:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:44:41 INFO - 'talos_options': ['--disable-e10s'], 13:44:41 INFO - 'tests': ['damp', 'tps']}, 13:44:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:44:41 INFO - 'tests': ['damp', 'tps']}, 13:44:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:44:41 INFO - 'tests': ['dromaeo_dom']}, 13:44:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:44:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:44:41 INFO - 'tests': ['a11yr', 13:44:41 INFO - 'ts_paint', 13:44:41 INFO - 'tpaint', 13:44:41 INFO - 'sessionrestore', 13:44:41 INFO - 'sessionrestore_no_auto_restore', 13:44:41 INFO - 'tabpaint']}, 13:44:41 INFO - 'other-e10s': {'tests': ['a11yr', 13:44:41 INFO - 'ts_paint', 13:44:41 INFO - 'tpaint', 13:44:41 INFO - 'sessionrestore', 13:44:41 INFO - 'sessionrestore_no_auto_restore', 13:44:41 INFO - 'tabpaint']}, 13:44:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:44:41 INFO - 'ts_paint', 13:44:41 INFO - 'tpaint', 13:44:41 INFO - 'sessionrestore', 13:44:41 INFO - 'sessionrestore_no_auto_restore', 13:44:41 INFO - 'tabpaint']}, 13:44:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:44:41 INFO - 'ts_paint', 13:44:41 INFO - 'tpaint', 13:44:41 INFO - 'sessionrestore', 13:44:41 INFO - 'sessionrestore_no_auto_restore', 13:44:41 INFO - 'tabpaint']}, 13:44:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:44:41 INFO - 'tests': ['a11yr', 13:44:41 INFO - 'ts_paint', 13:44:41 INFO - 'tpaint', 13:44:41 INFO - 'sessionrestore', 13:44:41 INFO - 'sessionrestore_no_auto_restore', 13:44:41 INFO - 'tabpaint']}, 13:44:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:44:41 INFO - 'tests': ['a11yr', 13:44:41 INFO - 'ts_paint', 13:44:41 INFO - 'tpaint', 13:44:41 INFO - 'sessionrestore', 13:44:41 INFO - 'sessionrestore_no_auto_restore', 13:44:41 INFO - 'tabpaint']}, 13:44:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:44:41 INFO - 'tests': ['tsvgx', 13:44:41 INFO - 'tsvgr_opacity', 13:44:41 INFO - 'tart', 13:44:41 INFO - 'tscrollx', 13:44:41 INFO - 'cart']}, 13:44:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:44:41 INFO - 'tsvgr_opacity', 13:44:41 INFO - 'tart', 13:44:41 INFO - 'tscrollx', 13:44:41 INFO - 'cart']}, 13:44:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:44:41 INFO - 'talos_options': ['--disable-e10s'], 13:44:41 INFO - 'tests': ['tp5o']}, 13:44:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:44:41 INFO - 'tests': ['tp5o']}, 13:44:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:44:41 INFO - 'talos_options': ['--disable-e10s', 13:44:41 INFO - '--xperf_path', 13:44:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:44:41 INFO - 'tests': ['tp5n']}, 13:44:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:44:41 INFO - 'talos_options': ['--xperf_path', 13:44:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:44:41 INFO - 'tests': ['tp5n']}}, 13:44:41 INFO - 'talos.zip': {'path': '', 13:44:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:44:41 INFO - Running post-action listener: _resource_record_post_action 13:44:41 INFO - ##### 13:44:41 INFO - ##### Finished populate-webroot step (success) 13:44:41 INFO - ##### 13:44:41 INFO - ##### 13:44:41 INFO - ##### Running create-virtualenv step. 13:44:41 INFO - ##### 13:44:41 INFO - Running pre-action listener: _resource_record_pre_action 13:44:41 INFO - Running main action method: create_virtualenv 13:44:41 INFO - Creating virtualenv /builds/slave/test/build/venv 13:44:41 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:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:44:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:44:41 INFO - Using real prefix '/usr' 13:44:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:44:41 INFO - Installing distribute.............................................................................................................................................................................................done. 13:44:43 INFO - Installing pip.................done. 13:44:43 INFO - Return code: 0 13:44:43 INFO - Installing pip>=1.5 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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f608fe2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x232b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ba1c0>, '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 0x23bb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23bb550>, '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': '652eb03db935cfc1c15ebda0000001ad-1465505069.816311-585326722', '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', 'pip>=1.5'] 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 pip>=1.5 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': '652eb03db935cfc1c15ebda0000001ad-1465505069.816311-585326722', 13:44:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:43 INFO - '_': '/tools/buildbot/bin/python'} 13:44:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:44 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:44 INFO - Cleaning up... 13:44:44 INFO - Return code: 0 13:44:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:44:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f608fe2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x232b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ba1c0>, '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 0x23bb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23bb550>, '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': '652eb03db935cfc1c15ebda0000001ad-1465505069.816311-585326722', '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:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:44:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:44:44 INFO - Using env: {'DISPLAY': ':0', 13:44:44 INFO - 'HOME': '/home/cltbld', 13:44:44 INFO - 'LANG': 'en_US.UTF-8', 13:44:44 INFO - 'LANGUAGE': 'en_US:en', 13:44:44 INFO - 'LOGNAME': 'cltbld', 13:44:44 INFO - 'MAIL': '/var/mail/cltbld', 13:44:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:44 INFO - 'MOZ_NO_REMOTE': '1', 13:44:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:44 INFO - 'NO_EM_RESTART': '1', 13:44:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:44 INFO - 'PWD': '/builds/slave/test', 13:44:44 INFO - 'SHELL': '/bin/bash', 13:44:44 INFO - 'SHLVL': '1', 13:44:44 INFO - 'TERM': 'linux', 13:44:44 INFO - 'TMOUT': '86400', 13:44:44 INFO - 'USER': 'cltbld', 13:44:44 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1465505069.816311-585326722', 13:44:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:44 INFO - '_': '/tools/buildbot/bin/python'} 13:44:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:44 INFO - Downloading/unpacking psutil>=3.1.1 13:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:44:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:44:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:44:46 INFO - Installing collected packages: psutil 13:44:46 INFO - Running setup.py install for psutil 13:44:46 INFO - building 'psutil._psutil_linux' extension 13:44:46 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:46 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:46 INFO - building 'psutil._psutil_posix' extension 13:44:46 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:46 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:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:44:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:44:46 INFO - Successfully installed psutil 13:44:46 INFO - Cleaning up... 13:44:46 INFO - Return code: 0 13:44:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:44:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f608fe2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x232b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ba1c0>, '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 0x23bb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23bb550>, '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': '652eb03db935cfc1c15ebda0000001ad-1465505069.816311-585326722', '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:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:44:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:44:46 INFO - Using env: {'DISPLAY': ':0', 13:44:46 INFO - 'HOME': '/home/cltbld', 13:44:46 INFO - 'LANG': 'en_US.UTF-8', 13:44:46 INFO - 'LANGUAGE': 'en_US:en', 13:44:46 INFO - 'LOGNAME': 'cltbld', 13:44:46 INFO - 'MAIL': '/var/mail/cltbld', 13:44:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:46 INFO - 'MOZ_NO_REMOTE': '1', 13:44:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:46 INFO - 'NO_EM_RESTART': '1', 13:44:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:46 INFO - 'PWD': '/builds/slave/test', 13:44:46 INFO - 'SHELL': '/bin/bash', 13:44:46 INFO - 'SHLVL': '1', 13:44:46 INFO - 'TERM': 'linux', 13:44:46 INFO - 'TMOUT': '86400', 13:44:46 INFO - 'USER': 'cltbld', 13:44:46 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1465505069.816311-585326722', 13:44:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:46 INFO - '_': '/tools/buildbot/bin/python'} 13:44:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:44:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:44:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:44:49 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:49 INFO - Installing collected packages: mozsystemmonitor 13:44:49 INFO - Running setup.py install for mozsystemmonitor 13:44:49 INFO - Successfully installed mozsystemmonitor 13:44:49 INFO - Cleaning up... 13:44:49 INFO - Return code: 0 13:44:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:44:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f608fe2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x232b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ba1c0>, '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 0x23bb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23bb550>, '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': '652eb03db935cfc1c15ebda0000001ad-1465505069.816311-585326722', '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:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:44:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:44:49 INFO - Using env: {'DISPLAY': ':0', 13:44:49 INFO - 'HOME': '/home/cltbld', 13:44:49 INFO - 'LANG': 'en_US.UTF-8', 13:44:49 INFO - 'LANGUAGE': 'en_US:en', 13:44:49 INFO - 'LOGNAME': 'cltbld', 13:44:49 INFO - 'MAIL': '/var/mail/cltbld', 13:44:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:49 INFO - 'MOZ_NO_REMOTE': '1', 13:44:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:49 INFO - 'NO_EM_RESTART': '1', 13:44:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:49 INFO - 'PWD': '/builds/slave/test', 13:44:49 INFO - 'SHELL': '/bin/bash', 13:44:49 INFO - 'SHLVL': '1', 13:44:49 INFO - 'TERM': 'linux', 13:44:49 INFO - 'TMOUT': '86400', 13:44:49 INFO - 'USER': 'cltbld', 13:44:49 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1465505069.816311-585326722', 13:44:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:49 INFO - '_': '/tools/buildbot/bin/python'} 13:44:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:49 INFO - Downloading/unpacking jsonschema==2.5.1 13:44:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:44:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 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 functools32-3.2.3-2.tar.gz 13:44:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:44:51 INFO - warning: no files found matching '*.txt' 13:44:51 INFO - no previously-included directories found matching 'build' 13:44:51 INFO - no previously-included directories found matching 'dist' 13:44:51 INFO - no previously-included directories found matching '.git*' 13:44:51 INFO - Installing collected packages: jsonschema, functools32 13:44:51 INFO - Running setup.py install for functools32 13:44:51 INFO - warning: no files found matching '*.txt' 13:44:51 INFO - no previously-included directories found matching 'build' 13:44:51 INFO - no previously-included directories found matching 'dist' 13:44:51 INFO - no previously-included directories found matching '.git*' 13:44:51 INFO - Successfully installed jsonschema functools32 13:44:51 INFO - Cleaning up... 13:44:51 INFO - Return code: 0 13:44:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:44:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:51 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 0x7f608fe2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x232b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ba1c0>, '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 0x23bb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23bb550>, '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': '652eb03db935cfc1c15ebda0000001ad-1465505069.816311-585326722', '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:51 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:51 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:51 INFO - Using env: {'DISPLAY': ':0', 13:44:51 INFO - 'HOME': '/home/cltbld', 13:44:51 INFO - 'LANG': 'en_US.UTF-8', 13:44:51 INFO - 'LANGUAGE': 'en_US:en', 13:44:51 INFO - 'LOGNAME': 'cltbld', 13:44:51 INFO - 'MAIL': '/var/mail/cltbld', 13:44:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:51 INFO - 'MOZ_NO_REMOTE': '1', 13:44:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:51 INFO - 'NO_EM_RESTART': '1', 13:44:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:51 INFO - 'PWD': '/builds/slave/test', 13:44:51 INFO - 'SHELL': '/bin/bash', 13:44:51 INFO - 'SHLVL': '1', 13:44:51 INFO - 'TERM': 'linux', 13:44:51 INFO - 'TMOUT': '86400', 13:44:51 INFO - 'USER': 'cltbld', 13:44:51 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1465505069.816311-585326722', 13:44:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:51 INFO - '_': '/tools/buildbot/bin/python'} 13:44:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:51 INFO - Downloading/unpacking 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:53 INFO - Downloading blobuploader-1.2.4.tar.gz 13:44:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:44:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:44:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:44:54 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:54 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:54 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:54 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:54 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:54 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:54 INFO - Downloading docopt-0.6.1.tar.gz 13:44:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:44:54 INFO - Installing collected packages: blobuploader, requests, docopt 13:44:54 INFO - Running setup.py install for blobuploader 13:44:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:44:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:44:54 INFO - Running setup.py install for requests 13:44:55 INFO - Running setup.py install for docopt 13:44:55 INFO - Successfully installed blobuploader requests docopt 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', '--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 0x7f608fe2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x232b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ba1c0>, '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 0x23bb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23bb550>, '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': '652eb03db935cfc1c15ebda0000001ad-1465505069.816311-585326722', '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', '--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:55 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: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': '652eb03db935cfc1c15ebda0000001ad-1465505069.816311-585326722', 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-fP0oQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:44:55 INFO - Running setup.py (path:/tmp/pip-9Ufm41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:44:55 INFO - Running setup.py (path:/tmp/pip-e66MHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:44:55 INFO - Running setup.py (path:/tmp/pip-Ckd3ZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:44:55 INFO - Running setup.py (path:/tmp/pip-Hs8t06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:44:55 INFO - Running setup.py (path:/tmp/pip-hvGvAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:44:55 INFO - Running setup.py (path:/tmp/pip-9n2R4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:44:55 INFO - Running setup.py (path:/tmp/pip-OTYqFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:44:56 INFO - Running setup.py (path:/tmp/pip-9IKLnR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:44:56 INFO - Running setup.py (path:/tmp/pip-mfJU0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:44:56 INFO - Running setup.py (path:/tmp/pip-Y5bMaZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:44:56 INFO - Running setup.py (path:/tmp/pip-yiaSnD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:44:56 INFO - Running setup.py (path:/tmp/pip-16zle8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:44:56 INFO - Running setup.py (path:/tmp/pip-DnmYj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:44:56 INFO - Running setup.py (path:/tmp/pip-xQrAuD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:44:56 INFO - Running setup.py (path:/tmp/pip-s5MxFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:44:56 INFO - Running setup.py (path:/tmp/pip-V9VOUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:44:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:44:56 INFO - Running setup.py install for manifestparser 13:44:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:44:56 INFO - Running setup.py install for mozcrash 13:44:56 INFO - Running setup.py install for mozdebug 13:44:56 INFO - Running setup.py install for mozdevice 13:44:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:44:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:44:57 INFO - Running setup.py install for mozfile 13:44:57 INFO - Running setup.py install for mozhttpd 13:44:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:44:57 INFO - Running setup.py install for mozinfo 13:44:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:44:57 INFO - Running setup.py install for mozInstall 13:44:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:44:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:44:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:44:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:44:57 INFO - Running setup.py install for mozleak 13:44:57 INFO - Running setup.py install for mozlog 13:44:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:44:57 INFO - Running setup.py install for moznetwork 13:44:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:44:57 INFO - Running setup.py install for mozprocess 13:44:57 INFO - Running setup.py install for mozprofile 13:44:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:44:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:44:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:44:58 INFO - Running setup.py install for mozrunner 13:44:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:44:58 INFO - Running setup.py install for mozscreenshot 13:44:58 INFO - Running setup.py install for moztest 13:44:58 INFO - Running setup.py install for mozversion 13:44:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:44:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:44:58 INFO - Cleaning up... 13:44:58 INFO - Return code: 0 13:44:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:44:58 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:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:58 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:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:58 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 0x7f608fe2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x232b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ba1c0>, '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 0x23bb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23bb550>, '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': '652eb03db935cfc1c15ebda0000001ad-1465505069.816311-585326722', '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:58 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:58 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:58 INFO - Using env: {'DISPLAY': ':0', 13:44:58 INFO - 'HOME': '/home/cltbld', 13:44:58 INFO - 'LANG': 'en_US.UTF-8', 13:44:58 INFO - 'LANGUAGE': 'en_US:en', 13:44:58 INFO - 'LOGNAME': 'cltbld', 13:44:58 INFO - 'MAIL': '/var/mail/cltbld', 13:44:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:58 INFO - 'MOZ_NO_REMOTE': '1', 13:44:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:58 INFO - 'NO_EM_RESTART': '1', 13:44:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:58 INFO - 'PWD': '/builds/slave/test', 13:44:58 INFO - 'SHELL': '/bin/bash', 13:44:58 INFO - 'SHLVL': '1', 13:44:58 INFO - 'TERM': 'linux', 13:44:58 INFO - 'TMOUT': '86400', 13:44:58 INFO - 'USER': 'cltbld', 13:44:58 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1465505069.816311-585326722', 13:44:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:58 INFO - '_': '/tools/buildbot/bin/python'} 13:44:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:44:58 INFO - Running setup.py (path:/tmp/pip-f7d3Ej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:44:58 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:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:44:58 INFO - Running setup.py (path:/tmp/pip-2SgVwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:44:58 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:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:44:58 INFO - Running setup.py (path:/tmp/pip-nBPV52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:44:58 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:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:44:58 INFO - Running setup.py (path:/tmp/pip-jTxqdL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:44:58 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:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:44:58 INFO - Running setup.py (path:/tmp/pip-gY6iLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:44:59 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:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:44:59 INFO - Running setup.py (path:/tmp/pip-NUUsq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:44:59 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:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:44:59 INFO - Running setup.py (path:/tmp/pip-mQ9Noy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:44:59 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:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:44:59 INFO - Running setup.py (path:/tmp/pip-NPbY3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:44:59 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:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:44:59 INFO - Running setup.py (path:/tmp/pip-Zaz3xk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:44:59 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:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:44:59 INFO - Running setup.py (path:/tmp/pip-608sRd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:44:59 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:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:44:59 INFO - Running setup.py (path:/tmp/pip-tgvpfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:44:59 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:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:44:59 INFO - Running setup.py (path:/tmp/pip-JMPu2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:44:59 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:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:44:59 INFO - Running setup.py (path:/tmp/pip-Rz1lCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:44:59 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:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:44:59 INFO - Running setup.py (path:/tmp/pip-MPFHWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:44:59 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:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:44:59 INFO - Running setup.py (path:/tmp/pip-L7RvUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:44:59 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:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:44:59 INFO - Running setup.py (path:/tmp/pip-AyT8pW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:44:59 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:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:44:59 INFO - Running setup.py (path:/tmp/pip-9ltEEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:44:59 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:59 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:59 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:59 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:59 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:59 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:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 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 blessings-1.6.tar.gz 13:45:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:45:01 INFO - Installing collected packages: blessings 13:45:01 INFO - Running setup.py install for blessings 13:45:01 INFO - Successfully installed blessings 13:45:01 INFO - Cleaning up... 13:45:02 INFO - Return code: 0 13:45:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 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 - Current package versions: 13:45:02 INFO - argparse == 1.2.1 13:45:02 INFO - blessings == 1.6 13:45:02 INFO - blobuploader == 1.2.4 13:45:02 INFO - docopt == 0.6.1 13:45:02 INFO - functools32 == 3.2.3-2 13:45:02 INFO - jsonschema == 2.5.1 13:45:02 INFO - manifestparser == 1.1 13:45:02 INFO - mozInstall == 1.12 13:45:02 INFO - mozcrash == 0.17 13:45:02 INFO - mozdebug == 0.1 13:45:02 INFO - mozdevice == 0.48 13:45:02 INFO - mozfile == 1.2 13:45:02 INFO - mozhttpd == 0.7 13:45:02 INFO - mozinfo == 0.9 13:45:02 INFO - mozleak == 0.1 13:45:02 INFO - mozlog == 3.2 13:45:02 INFO - moznetwork == 0.27 13:45:02 INFO - mozprocess == 0.22 13:45:02 INFO - mozprofile == 0.28 13:45:02 INFO - mozrunner == 6.11 13:45:02 INFO - mozscreenshot == 0.1 13:45:02 INFO - mozsystemmonitor == 0.3 13:45:02 INFO - moztest == 0.7 13:45:02 INFO - mozversion == 1.4 13:45:02 INFO - psutil == 3.1.1 13:45:02 INFO - requests == 1.2.3 13:45:02 INFO - wsgiref == 0.1.2 13:45:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:45:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:45:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:45:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:02 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 0x7f608fe2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x232b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ba1c0>, '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 0x23bb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23bb550>, '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': '652eb03db935cfc1c15ebda0000001ad-1465505069.816311-585326722', '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:45:02 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:45:02 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:45:02 INFO - Using env: {'DISPLAY': ':0', 13:45:02 INFO - 'HOME': '/home/cltbld', 13:45:02 INFO - 'LANG': 'en_US.UTF-8', 13:45:02 INFO - 'LANGUAGE': 'en_US:en', 13:45:02 INFO - 'LOGNAME': 'cltbld', 13:45:02 INFO - 'MAIL': '/var/mail/cltbld', 13:45:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:02 INFO - 'MOZ_NO_REMOTE': '1', 13:45:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:45:02 INFO - 'NO_EM_RESTART': '1', 13:45:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:45:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:02 INFO - 'PWD': '/builds/slave/test', 13:45:02 INFO - 'SHELL': '/bin/bash', 13:45:02 INFO - 'SHLVL': '1', 13:45:02 INFO - 'TERM': 'linux', 13:45:02 INFO - 'TMOUT': '86400', 13:45:02 INFO - 'USER': 'cltbld', 13:45:02 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1465505069.816311-585326722', 13:45:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:02 INFO - '_': '/tools/buildbot/bin/python'} 13:45:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:02 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:45:02 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:45:02 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:45:02 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:45:02 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:45:02 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:45:02 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:45:02 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:45:02 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:45:02 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:45:02 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:45:02 INFO - Cleaning up... 13:45:02 INFO - Return code: 0 13:45:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:45:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:45:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:45:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:02 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 0x7f608fe2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x232b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ba1c0>, '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 0x23bb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23bb550>, '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': '652eb03db935cfc1c15ebda0000001ad-1465505069.816311-585326722', '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:45:02 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:45:02 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:45:02 INFO - Using env: {'DISPLAY': ':0', 13:45:02 INFO - 'HOME': '/home/cltbld', 13:45:02 INFO - 'LANG': 'en_US.UTF-8', 13:45:02 INFO - 'LANGUAGE': 'en_US:en', 13:45:02 INFO - 'LOGNAME': 'cltbld', 13:45:02 INFO - 'MAIL': '/var/mail/cltbld', 13:45:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:02 INFO - 'MOZ_NO_REMOTE': '1', 13:45:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:45:02 INFO - 'NO_EM_RESTART': '1', 13:45:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:45:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:02 INFO - 'PWD': '/builds/slave/test', 13:45:02 INFO - 'SHELL': '/bin/bash', 13:45:02 INFO - 'SHLVL': '1', 13:45:02 INFO - 'TERM': 'linux', 13:45:02 INFO - 'TMOUT': '86400', 13:45:02 INFO - 'USER': 'cltbld', 13:45:02 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1465505069.816311-585326722', 13:45:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:02 INFO - '_': '/tools/buildbot/bin/python'} 13:45:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:45:02 INFO - Cleaning up... 13:45:02 INFO - Return code: 0 13:45:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:45:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:45:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:45:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:02 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 0x7f608fe2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x232b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ba1c0>, '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 0x23bb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23bb550>, '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': '652eb03db935cfc1c15ebda0000001ad-1465505069.816311-585326722', '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:45:02 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:45:02 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:45:02 INFO - Using env: {'DISPLAY': ':0', 13:45:02 INFO - 'HOME': '/home/cltbld', 13:45:02 INFO - 'LANG': 'en_US.UTF-8', 13:45:02 INFO - 'LANGUAGE': 'en_US:en', 13:45:02 INFO - 'LOGNAME': 'cltbld', 13:45:02 INFO - 'MAIL': '/var/mail/cltbld', 13:45:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:02 INFO - 'MOZ_NO_REMOTE': '1', 13:45:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:45:02 INFO - 'NO_EM_RESTART': '1', 13:45:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:45:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:02 INFO - 'PWD': '/builds/slave/test', 13:45:02 INFO - 'SHELL': '/bin/bash', 13:45:02 INFO - 'SHLVL': '1', 13:45:02 INFO - 'TERM': 'linux', 13:45:02 INFO - 'TMOUT': '86400', 13:45:02 INFO - 'USER': 'cltbld', 13:45:02 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1465505069.816311-585326722', 13:45:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:02 INFO - '_': '/tools/buildbot/bin/python'} 13:45:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:02 INFO - Downloading/unpacking 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:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:45:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:45:04 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:04 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:04 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:04 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:04 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:04 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:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:45:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:45:05 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:05 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:05 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:05 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:05 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:05 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:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:45:05 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:05 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:05 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:05 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:05 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:05 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:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:45:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:45:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:45:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:45:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:45:05 INFO - no previously-included directories found matching 'docs/_build' 13:45:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:45:05 INFO - Running setup.py install for pep8 13:45:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:45:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:45:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:45:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:45:05 INFO - no previously-included directories found matching 'docs/_build' 13:45:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:45:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:45:05 INFO - Cleaning up... 13:45:05 INFO - Return code: 0 13:45:05 INFO - Running post-action listener: _resource_record_post_action 13:45:05 INFO - Running post-action listener: _start_resource_monitoring 13:45:05 INFO - Starting resource monitoring. 13:45:05 INFO - ##### 13:45:05 INFO - ##### Finished create-virtualenv step (success) 13:45:05 INFO - ##### 13:45:05 INFO - ##### 13:45:05 INFO - ##### Running install step. 13:45:05 INFO - ##### 13:45:05 INFO - Running pre-action listener: _resource_record_pre_action 13:45:05 INFO - Running main action method: install 13:45:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:45:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:45:06 INFO - Reading from file tmpfile_stdout 13:45:06 INFO - Detecting whether we're running mozinstall >=1.0... 13:45:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:45:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:45:06 INFO - Reading from file tmpfile_stdout 13:45:06 INFO - Output received: 13:45:06 INFO - Usage: mozinstall [options] installer 13:45:06 INFO - Options: 13:45:06 INFO - -h, --help show this help message and exit 13:45:06 INFO - -d DEST, --destination=DEST 13:45:06 INFO - Directory to install application into. [default: 13:45:06 INFO - "/builds/slave/test"] 13:45:06 INFO - --app=APP Application being installed. [default: firefox] 13:45:06 INFO - mkdir: /builds/slave/test/build/application 13:45:06 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:06 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:21 INFO - Reading from file tmpfile_stdout 13:45:21 INFO - Output received: 13:45:21 INFO - /builds/slave/test/build/application/firefox/firefox 13:45:21 INFO - Running post-action listener: _resource_record_post_action 13:45:21 INFO - ##### 13:45:21 INFO - ##### Finished install step (success) 13:45:21 INFO - ##### 13:45:21 INFO - ##### 13:45:21 INFO - ##### Running run-tests step. 13:45:21 INFO - ##### 13:45:21 INFO - Running pre-action listener: _resource_record_pre_action 13:45:21 INFO - Running main action method: run_tests 13:45:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:45:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:45:21 INFO - Python 2.7.3 13:45:21 INFO - Return code: 0 13:45:21 INFO - grabbing minidump binary from tooltool 13:45:21 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:21 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 0x23ba1c0>, '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 0x23bb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23bb550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:45:21 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:21 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:21 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:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:45:22 INFO - Return code: 0 13:45:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:45:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:45:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:45:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:45:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:45:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:45:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:45:22 INFO - Return code: 0 13:45:22 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-046', '--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:22 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-046 --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:23 INFO - Using env: {'DISPLAY': ':0', 13:45:23 INFO - 'HOME': '/home/cltbld', 13:45:23 INFO - 'LANG': 'en_US.UTF-8', 13:45:23 INFO - 'LANGUAGE': 'en_US:en', 13:45:23 INFO - 'LOGNAME': 'cltbld', 13:45:23 INFO - 'MAIL': '/var/mail/cltbld', 13:45:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:45:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:45:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:23 INFO - 'MOZ_NO_REMOTE': '1', 13:45:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:45:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:45:23 INFO - 'NO_EM_RESTART': '1', 13:45:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:45:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:23 INFO - 'PWD': '/builds/slave/test', 13:45:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:45:23 INFO - 'SHELL': '/bin/bash', 13:45:23 INFO - 'SHLVL': '1', 13:45:23 INFO - 'TERM': 'linux', 13:45:23 INFO - 'TMOUT': '86400', 13:45:23 INFO - 'USER': 'cltbld', 13:45:23 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1465505069.816311-585326722', 13:45:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:23 INFO - '_': '/tools/buildbot/bin/python'} 13:45:23 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-046', '--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:23 INFO - mozversion application_buildid: 20160609031135 13:45:23 INFO - mozversion application_changeset: 1ae7a82e2b1d2b18ccfa9a578040b46c774bc501 13:45:23 INFO - mozversion application_display_name: FirefoxDeveloperEdition 13:45:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:45:23 INFO - mozversion application_name: Firefox 13:45:23 INFO - mozversion application_remotingname: firefox-dev 13:45:23 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:45:23 INFO - mozversion application_vendor: Mozilla 13:45:23 INFO - mozversion application_version: 49.0a2 13:45:23 INFO - mozversion platform_buildid: 20160609031135 13:45:23 INFO - mozversion platform_changeset: 1ae7a82e2b1d2b18ccfa9a578040b46c774bc501 13:45:23 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:45:23 INFO - mozversion platform_version: 49.0a2 13:45:23 INFO - using testdate: 1465505123 13:45:23 INFO - actual date: 1465505123 13:45:23 INFO - starting webserver on 'localhost:51880' 13:45:23 INFO - SUITE-START | Running 2 tests 13:45:23 INFO - TEST-START | dromaeo_css 13:45:23 INFO - operating with platform_type : linux_ 13:45:23 INFO - Initialising browser for dromaeo_css test... 13:45:23 INFO - TEST-INFO | started process 4125 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJ8dDV9/profile http://localhost:51880/getInfo.html) 13:45:27 INFO - PROCESS | 4125 | __metrics Screen width/height:1600/1200 13:45:27 INFO - PROCESS | 4125 | colorDepth:24 13:45:27 INFO - PROCESS | 4125 | Browser inner width/height: 1024/697 13:45:27 INFO - PROCESS | 4125 | __metrics 13:45:28 ERROR - PROCESS | 4125 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 13:45:29 INFO - TEST-INFO | 4125: exit 0 13:45:29 INFO - Browser initialized. 13:45:29 INFO - Running cycle 1/1 for dromaeo_css test... 13:45:29 INFO - TEST-INFO | started process 4254 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJ8dDV9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:45:41 INFO - PROCESS | 4254 | RSS: Main: 155922432 13:45:41 INFO - PROCESS | 4254 | 13:46:30 INFO - PROCESS | 4254 | 1465505190609 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:38 INFO - PROCESS | 4254 | Cycle 1(1): loaded http://localhost:51880/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51880/tests/dromaeo/cssquery-ext.html) 13:48:39 INFO - PROCESS | 4254 | RSS: Main: 159506432 13:48:39 INFO - PROCESS | 4254 | 13:51:41 INFO - PROCESS | 4254 | Cycle 1(1): loaded http://localhost:51880/tests/dromaeo/cssquery-ext.html (next: http://localhost:51880/tests/dromaeo/cssquery-jquery.html) 13:51:42 INFO - PROCESS | 4254 | RSS: Main: 156962816 13:51:42 INFO - PROCESS | 4254 | 13:54:43 INFO - PROCESS | 4254 | Cycle 1(1): loaded http://localhost:51880/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51880/tests/dromaeo/cssquery-mootools.html) 13:54:44 INFO - PROCESS | 4254 | RSS: Main: 156692480 13:54:44 INFO - PROCESS | 4254 | 13:57:46 INFO - PROCESS | 4254 | Cycle 1(1): loaded http://localhost:51880/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51880/tests/dromaeo/cssquery-prototype.html) 13:57:46 INFO - PROCESS | 4254 | RSS: Main: 156303360 13:57:46 INFO - PROCESS | 4254 | 14:00:49 INFO - PROCESS | 4254 | Cycle 1(1): loaded http://localhost:51880/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51880/tests/dromaeo/cssquery-yui.html) 14:00:49 INFO - PROCESS | 4254 | RSS: Main: 158363648 14:00:49 INFO - PROCESS | 4254 | 14:03:52 INFO - PROCESS | 4254 | Cycle 1(1): loaded http://localhost:51880/tests/dromaeo/cssquery-yui.html (next: http://localhost:51880/tests/dromaeo/cssquery-dojo.html) 14:03:52 INFO - PROCESS | 4254 | RSS: Main: 158539776 14:03:52 INFO - PROCESS | 4254 | 14:03:52 INFO - PROCESS | 4254 | __start_tp_report 14:03:52 INFO - PROCESS | 4254 | _x_x_mozilla_page_load 14:03:52 INFO - PROCESS | 4254 | _x_x_mozilla_page_load_details 14:03:52 INFO - PROCESS | 4254 | |i|pagename|runs| 14:03:52 INFO - PROCESS | 4254 | |0;dojo.html;3350.7267238449394;3397.4394224952885;3419.4186988212;3437.2781715839687;3439.587249530055;5720.141978703196;5747.453991870776;5753.050746626806;5774.711264436777;5787.363390027104;5741.397153298906;5784.971075144618;5794.884102317951;5832.154337621042;5859.736311865966;5201.8439446816565;5242.501962313574;5266.420693723688;5312.043832110218;5359.678419294835;5115.207142892839;5169.508896654812;5273.182656688219;5311.760970756325;5326.813561525348;5258.290130832327;5267.920981185285;5293.602979776513;5320.787168513274;5336.866578335554;5276.287701160351;5361.705106219157;5363.785448582052;5368.1679339702405;5372.973135134338;5087.618428617831;5215;5262.60530460217;5317.9202311965355;5326.520613144836;5545.251391062236;5590.832275031715;5619.129034999582;5639.2668953035845;5664.490195882349;6166.260048794128;6200.348963358872;6214.502839772807;6214.5649804513705;6221.035739460391;6139.109829074804;6209.348018458042;6217.440430361244;6225.003999360126;6233.096201050867;5835.620684655484;5934.050551911717;5937.020391635375;5970.850728731816;5978.252718410199;6370.840728981812;6406.135171751847;6441.484681225491;6451.870962580722;6467.838304042342;5965.55258355625;6049.334573196945;6067.423594758491;6206.782762603287;6211.223597050369;6240.781572644935;6245.937540624626;6249.156363890907;6250.249970003538;6250.9062364064575;6152.569320147636;6164.229471316085;6212.254529456403;6219.689015549295;6224.564280500322;5997.940020599825;6093.664848433379;6110.541709371726;6133.754649813957;6217.191765070512;4659.068186362741;4692.319613656001;4702.52974702527;4716.245400735935;4737.6683632146105;4206.72656277341;4215.304474761691;4222.408862759216;4234.216669916075;4252.87241382759;5832.387599302097;5967.940320596826;5972.313183983811;5997.910031349533;6067.635941843503;6185.319614842364;6191.907121393183;6218.22272215973;6304.716287767062;6313;5890.2342695449315;6028.487578555872;6041.305249896231;6057.848553786191;6071.574989750675;5305.946940530623;5315.335583052119;5343.465653434703;5368.3826359968325;5372.758225879845;6435.581687190318;6478.740850365933;6498.54510184292;6510.893148164823;6521.706523206467;6080.513558915364;6133.815985520441;6261.812145635456;6264;6271.090691849565;6318.557700960889;6446.065320528591;6449.7097630605795;6451.387118223761;6461.224653041665;6074.271087469355;6108.053251745987;6113.633182009094;6115.938840611715;6129.724162412791;6114.419130182626;6189.381061893775;6194.876102477835;6215.34738852414;6235;6129.387061293835;6145.170401995852;6168.629882207082;6173.84565385851;6195.690215489118;6104.328523862283;6107.4197951194565;6155.169052178077;6159.414855588712;6166.383361663798;5908.763649453974;5967.701614919323;5978.432048955342;6004.609700369462;6079.452849243412;6163.736434031102;6165.815025549241;6182.752689892354;6198.318184999556;6201.10084037803;6096.542759293159;6099.573029887865;6101.78271676276;6105.328413874381;6125.479334256638 14:03:52 INFO - PROCESS | 4254 | |1;ext.html;588.5350573047293;646.3278190681691;656.7701304543409;668.4886062162443;671.6775947545178;35335.82332088339;47971.76014119929;48568;48588;48884.511154888394;49292.75353623236;49786.751066244615;49790.75104624472;50055;50151.24773128406;9002.954985225064;9150.313726470507;9166.40418372807;9185;9192.35653504255;8987.191152796247;9119.63521459144;9129.543522823866;9147.771305717344;9205.263578913671;9217.631294748235;9256.583453744597;9319.021502742216;9323.487208203545;9332.580033898457;9252.028537003618;9264.49045302508;9265.397749146285;9272;9276.768080798034;9046.638134474613;9156.450612963243;9163.40437871543;9167.816643667156;9188.678396256098;45839.31241031387;46217.30674039892;46358.30462543065;46390.30414543785;46484.53515464836;3674.1182116292166;3826.693864490834;3849.961500384988;3857.9807100964317;3931.82306796192;34741.47887781685;35289.64710352889;35530.822345888366;35885.28229435423;35917.64082359169;4423.469183697945;4617.792199351037;4705.247160454345;4710.78801453932;4717.693349932243;379251;381526.09236953914;381914;382121.9999999972;382507;35730.10674733153;69478.30521694718;69484.30515694778;69888;69920.65039674769;37808.43287350692;40003;40032.39951400732;40099;40137.197256054715;15982.280797364147;16182.352705891868;16223.269952851913;16256.59358516023;16257.674846503003;13176.670583235496;13200.339983000811;13202.471901123847;13254.73490530184;13263.602091937257;9151.679691210775;9204.953975230215;9238.95380523093;9259.398139120936;9331.440113593206;3439.0886415100017;3489.249811290534;3505.719542436599;3508.929821403609;3519.63043880394;1088.3198001249218;1092.3991804507489;1102.5975518935531;1172.7009612548745;1190.6904204906787;34213.48679769805;34382.14044648904;34456;34826.47760283598;34883.30233395318;1108.2519299472824;1144.822552504363;1185.8102703567388;1212.0373299588864;1217.829503869459;17724.734128988075;18080.547986300186;18084.095795210185;18099.909500452413;18227.817721822612;598346;606740;608749;612976;959799;66579;66897;67350.3264967344;67514.66242668756;67575.66212169005;1456.2281990545027;1456.6504039030556;1469.2066284206624;1480.6446452851237;1480.9259537023106;33986.32027359489;34067.4889876657;34542.13644658904;34975.475367868996;35456.46815297824;58102;58911;59019.70490147522;59042.11436828537;59059;529383;531982;536295;536711;537091;31625;32119.357612847143;32590.34819303648;32602.51096233606;32608.184795380304;54194.187087192935;54313;54619.72690136524;54716.72641636767;55331.44668553263;45058;45352;45454;45639.771801140785;46406.767966159954;45429;45824;45837;46173.538264616924;46283.305750414445;45704;45821.77089114533;45831.31253031141;45844.7707761459;46450.535494644624;38504.614953850105;38544.749260177916;38959.72768577889;39594.40608390819;40060.59939400685;30092.849535752182;30330;30425.847870760503;30608.234794130323;30925 14:03:52 INFO - PROCESS | 4254 | |2;jquery.html;414.81955349423;415.63631822155617;415.68615695150174;418.3390243415404;430.91166310906266;19150.138243779027;20783.792162078393;20929.68605470917;22156.22453214138;22242.221522246724;12915.547955821548;17878.37425690101;19213.42359729207;19785;19873.40379788605;5263.157894736833;5396.676199428047;5414.620976531644;5424.457554244584;5452.890942181174;5227.607929405291;5253.684778913277;5779.537636989031;6135.754569817202;6145.385461453863;6160.722767475452;6182.907256391158;6189.195404597396;6190.473809726156;6203.31763506014;6026.96986515069;6138.662373569452;6142.723577439004;6213.378662133796;6234.844128896769;5818.941810581925;5903.79336723217;5941.940580594182;5950.196723442323;5959.791407300723;14425.78361324581;14766.852331476655;20498.66758660697;24162.51674966491;24592.754072459225;2299.7930186283315;2454.085653574894;2462.384403899025;2478.8512689238705;2836.744692977621;10086.193104551618;10722.946385268024;10734.248602597821;11042.834357484644;11103.111751059896;1809.936692126185;1877.1646617255326;1936.9903150484158;1973.73354597129;1975.2494052260192;77943;81108.59445702734;81527;84000.57999709963;84004.15995840024;11618.95429411357;11669.824952625717;11739.119566032581;11771.529138834521;11813.940930295294;12673.30296833683;16009;16435.09606971628;16615.169241537875;16645.0012999218;6345.428911397997;6582.440492558187;7762.6894924203525;8205.302549283379;8399.412041157182;8185.467944583583;8221.753347399588;8232.423730338818;8360.414770966096;8381.49711017341;4263.16868210696;4292.678049146327;4426.800793964279;4494.70784399013;4501.054778496552;1942.7183058456728;1991.178072064074;2003.6293285741892;2020.1313435222996;2030.1879248300502;994.9801003979879;1032.9380237185792;1065.1053115383115;1070.9303895246785;1125.4372813593204;19773.209071636975;20003;20073.799262007484;20144;20334.186632534827;1027.6300531808542;1062.4900047977014;1073.5652060915343;1074.8441475985937;1078.2129045796612;11142.108631309477;11325.830112548318;11328.603498877499;11385.14611404148;11449.828252576219;462247;465016;474907;478596;479661;94910.5254473737;98147.50926245465;99810.5009474948;100718.49640751896;101267.4936625327;1010.242318261304;1040.8646875906236;1056.7727938493108;1057.740853490915;1067.3969207397795;17779.19993600317;17912.552186195448;17991.550211244823;18190.90904545469;18325.633487329913;31512.842435787676;35722.28555428929;37683;41583.58416415797;42058.78970605128;60338.39661603503;61335.38664613297;61389;62941;62950.68524657348;8940;9031.548422578977;9047.366684332033;9086.772830679021;9133.132352426508;10430.426326552113;13072.738545228853;13767.518136865161;14261.358238879482;14310.356033978704;12287.692807679521;12515.311657858905;12606.306653134166;12630.684232894251;12751.234925904104;12321.691957701129;12491.125621206429;12599.244045357307;12622;12981.286029268482;12748.298843563693;12833.679158021125;12857.935710321763;12934.288614126313;13005.674858128623;9364.953175234352;9431.575579099093;9463.195628371666;9545.618175272912;9644.662436814679;10966;12365.319907405179;12489.18820276679;12669.493220271455;12843.229406235656 14:03:52 INFO - PROCESS | 4254 | |3;mootools.html;1549.519648908838;1550.5193390049085;1750.4748575427377;1817.3094224194804;1874.0723341945738;8399.370047246466;8529.360297977653;9001.45991240526;9106.99999999999;9121.133492318228;9025.684101056464;9192.770180745485;9207.585658645361;9278.118578735026;9282.350235483518;2481.516104359646;2501.3371456564023;2521.6595759572406;2521.8739063046864;2524.5329614021375;2437.81716371272;2472.5673007223754;2491.626256061596;2499.825012249143;2505.1983365323103;2468.568000599888;2483.888225029869;2489.8381605195696;2499.512595043967;2502.949941001179;2446.9755302447015;2453.2149712092228;2464.630305454178;2465.938351541226;2469.790067844235;2381.7022872140983;2391.796697280733;2393.1863166523467;2407.0732767884315;2413.5655581995234;9137.862932056025;9323.906760932372;9332.58003389849;9343.345965782399;9355.532223388804;5650.943490565124;5764.654120752768;5768.74040668171;5794.217780599607;5795.942040579583;3372.258103217313;3568.1793187566745;3632.5640923089136;3651.452282157671;3700.777953322809;1108.772701596171;1139.9259048161844;1156.444906444911;1167.3404526442532;1191.4757506697026;13077.869221307761;13204.60386188416;13228.933855330759;13277.535286264934;13311.800322995163;4955.603551715854;4978.427480839678;5026.447090820006;5082.822101226439;5089.618278629117;11132.220744547803;11228.494717737722;11234.15743819217;11237.3257604544;11247.212695111264;5641.943580564224;5645.745941432645;5711.857203569861;5737.971310143506;5742.052561327334;4608.516105808909;4995.850124496271;5138.58891288696;5158.484151584811;5211.140161873249;4229.386738922901;4358.607725304738;4410.933835992462;4466.3747075409465;4485.080558485568;1376.6489545165919;1395.7487652222696;1397.8043073969652;1403.1791402029723;1418.7446259673152;906.954652267384;967.6806653804227;973.075578200698;977.6871401151706;1081.416035340907;6337.651429171347;6431.646259455775;6477.805665830033;6597;6618.371254730793;489.9093667671492;492.83736366998806;494.2808214048551;502.94719054499484;520.0794593569436;4546.568076032771;4565.817367305337;4604.309353596987;4610.031893302444;4616.146012987608;11223.438828058564;11579.073674106052;11592.942035289938;11594.304341739522;11597.478113484745;11072;11461.083113350913;11488.19582629208;11498.655040348804;11510.884891151149;8702.260307873901;8748.518831464331;8826.161514656098;8838.911610883937;8843.0714774949;6249.281332646804;6269.185005949197;6430.5177111715875;6485.0596663484475;6616.470682345497;9967.40195588267;10730.570777169138;10837.837432438677;10845.132389408986;10933.343999360064;10368.637097701545;10485.423301718478;10510.527026283988;10547.525361358605;10704.250702451065;7427.925720742724;8117.675292988451;8270.297024752723;8272.793180170544;8296.958515207385;9225.446473211628;9234.445933244027;9242.445453272825;9276.62893484253;9298.116678915492;7937;8165.061017983008;8165.305948994402;8194.918050819653;8353.916460835313;8040.718574849852;8154.918450815416;8172.305354044973;8217.95891020541;8271.627776750182;7452.180260171268;7510.774676759706;7704.961475192588;7753;7790.493617914817;5525.143602741581;5532;5563.499285064364;5604.243427137284;5664.291963504562;5436.700981446058;5471.917921231265;5575.665460072409;5618.438156184349;5722.399148089391 14:03:52 INFO - PROCESS | 4254 | |4;prototype.html;348.34163431115195;350.65460521386433;352.4237871080782;358.0940221240263;362.1615959054788;5598.244237028;5688.573356998221;5754.16564598133;5838;5841.474267315941;5761.012450704511;5766.192733017381;5784.971075144629;5794.362620111795;5803.941960580393;4508.458984921814;4516.819327226915;4528.864134075983;4552.248878934988;4554.567316104964;4453.799579018936;4477.171723231197;4492.236319825637;4497.640188784906;4543;4442.466903971528;4462.12988467249;4464.8214071437105;4483.193025255453;4483.551644835523;4477.10457908418;4498.842540511099;4530.207213737615;4542.500324964268;4552.544745525454;3908.257431088084;3944.467496887941;3958.44581758554;4027.9597204027878;4049.3116170250833;5495.890082198373;5500.1749737539685;5548.5838562108;5566.137248726453;5587.329520457531;5136.332276803992;5213.4004589472315;5222.817201397933;5233.293505376763;5243.86890327741;5926.614770039933;6057.880191701277;6072.449571180115;6110.236220472441;6155.230596175478;4416.3596278539435;4418.74643931594;4423.778811059434;4435.977820110911;4454.28731402974;6238.282597501346;6349.619022858643;6354.777582784626;6365.331640177761;6412.294647588761;4162.188373267244;4396.582324679151;4402.977985110054;4411.647068234533;4431.645468362523;4439.844605438794;4443.977780111143;4444.755538445416;4452.154090722753;4453.087117140978;5120.2063680128895;5123.538881500683;5154.834969312898;5185.481451854785;5192.7152053096515;5895.7052147393315;5971.4327138921735;6057.818265452043;6076.392360763976;6116.969415152896;1505.9849401506065;1528.7630417285338;1532.949929298412;1537.2313843078462;1544.5829626000916;962.9229661627053;965.5558443116105;968.8692026576322;972.557486343712;997.4165113408592;5197.375325460694;5249.028929648028;5304.708241046702;5374.414547708436;5403.486668766461;5557.610967232255;5609.242752228479;5616.438356164351;5622.566245607344;5677.744501497443;5054.7472626368535;5235.424103348629;5246.947530524646;5293.311869457023;5380;2973.405318936221;2981.7912746108;2983.4182334444577;2985.7161420588923;3017.6227971503563;5716.541492397123;5722.452079710606;5733.971330143323;5750.217432595909;5767.183337248754;5915.994280972245;6411.589450320922;6426.4216220540375;6436.517261205428;6447.548671593037;6501.772437964649;6531.183602049744;6538.215414150332;6547.508936829757;6561.901571476336;6064.605800622945;6256.718447669957;6307.716152773044;6326.8734625306315;6327.430531252209;6138.723757430837;6194.566380353332;6252.124702541557;6256.5599416228615;6268.341824108403;6504.739810407531;6516.706748196438;6541.6402097883165;6563.9343606563325;6598.538102332983;4396.384506169203;4443.3115416142955;4452.530664880517;4460.330950357472;4483.372327874165;6085;6100.786472473442;6374.458171055512;6400.935990640034;6422.6467544285515;6075.483583895241;6114.113453549299;6179.721912513858;6206.72069756871;6234.345393733593;6124.908126378019;6135.509159267337;6171.228596425447;6175.814725558241;6194.907076393948;5929.733162007807;6000.489958353414;6032.306284777307;6038.486728628116;6046.54650901193;6165.815025549241;6199.783007594712;6209.875802484015;6217.487119777311;6267;5860.120981852756;5933.9109913352195;6041.6677082759115;6051.213342265477;6141.447269745566 14:03:52 INFO - PROCESS | 4254 | |5;yui.html;796.8525822722796;812.7114874219648;853.581744944977;869.4392117084478;880.1726377205423;16439.34242630295;17031.06329151896;17233.82766172338;17247.82752172478;17248.655026899454;15612.765808512853;15648;15745.527634170992;15797.684046319067;15987.360505579793;864.9740507784761;884.6461415433813;886.352962337494;886.6143227695941;886.9645214191424;858.5321000054954;875.299760191844;877.2937785083005;882.2016075451694;888.6711916590871;916.0793402630347;917.5045475443253;921.8801555797737;926.3885835348672;927.7077720518015;914.314264301777;917.9127982841653;918.9081091890757;919.0258326174277;919.7608621758358;669.4978765925556;672.6300534705892;673.7574473189648;674.3458844920419;678.759040540606;17126.05806680632;17223.569410764707;17349.826501734948;17356.132193390407;17364.739528907077;15122;15146.621334466616;15384.076955382712;15439.845601544066;15586.610334741608;14365.138091714425;14415.927920360436;14491.42034318626;14525.201113938729;14756.188409637465;4788.592969597588;4789.688670236458;4794.232922732381;4833.516648335173;4853.927191092136;93305.53347233289;96522;96628;96768.51615741877;97011.0298897009;12205.755884882252;12338.691532711755;12379.75240495203;12450.377481125908;12677.429515671816;22647.88676056642;22979.655305170436;23059.538809223723;23074.077036918334;23412.64881026786;8729.694460693845;8972.102789721106;8999.730008099768;9045.140711632515;9154.725358239264;4593.908121837545;4594.724316541018;4600.5629465200755;4621.5378462154185;4632.629389648888;3512.08685741709;3616.8734094306574;3616.945745813815;3622.0220540454457;3627.854885804591;650.3788881618138;665.2349797732646;665.3944910131756;668.4685674888475;670.3363669966698;613.6502193749609;654.1463390275736;686.8866637004838;692.6744430117836;700.8177873752759;9082.954585227031;9537.475438850792;9549.331546791658;9671.854922176173;9752.561134748954;654.6137778710583;742.8440027594265;748.3115533709001;796.3191471292077;813.0162403734986;4967.677100988424;4982.77577509013;5009.248612708123;5062.772175252123;5231.869203269873;70346.29653703398;80867.59566202131;123943;125311.3734431322;126411.3679431597;62606.68696656488;63608.681956590844;107372;108013.4599327014;110196.69409917555;89168;93548;95641;96635.51682241684;97702;10727.249092563447;10841.457927103771;10846.783064338826;10998.945005274922;11058.557657693602;40769.388459172544;43261.78369108134;48115.03769924512;48152.759236203594;53007.20489192588;74250;78940.21059789328;81186.18813811787;81607.5919620398;84658;13821.308934553032;13876.098053626481;14054.437822486985;14160.291985400483;14315.856841431452;15983.760243596123;15984.600384990468;16154.757678634594;16467;16615.41846035383;15047.548573542812;15278.388864445298;15344.846551534789;15377;15454.150021748912;15047.677882843147;15202.239888005335;15315;15340.232988350315;15412.845871541142;14417;14704.632384190481;14717.116972981656;15023.924880375529;15613;12437.191582547106;12480.563180288646;12666;12837.229766214057;12942.54701085495;12380.81428778551;12427.813582796085;12662;12795.296258705861;13052.412641431349 14:03:52 INFO - PROCESS | 4254 | __end_tp_report 14:03:52 INFO - PROCESS | 4254 | __start_cc_report 14:03:52 INFO - PROCESS | 4254 | _x_x_mozilla_cycle_collect,325 14:03:52 INFO - PROCESS | 4254 | __end_cc_report 14:03:52 INFO - PROCESS | 4254 | __startTimestamp1465506232412__endTimestamp 14:03:52 INFO - PROCESS | 4254 | 14:03:52 INFO - PROCESS | 4254 | ------- Summary: start ------- 14:03:52 INFO - PROCESS | 4254 | Number of tests: 6 14:03:52 INFO - PROCESS | 4254 | 14:03:52 INFO - PROCESS | 4254 | [#0] dojo.html Cycles:165 Average:5784.56 Median:6071.57 stddev:663.11 (10.9%) stddev-sans-first:637.06 14:03:52 INFO - PROCESS | 4254 | Values: 3350.7 3397.4 3419.4 3437.3 3439.6 5720.1 5747.5 5753.1 5774.7 5787.4 5741.4 5785.0 5794.9 5832.2 5859.7 5201.8 5242.5 5266.4 5312.0 5359.7 5115.2 5169.5 5273.2 5311.8 5326.8 5258.3 5267.9 5293.6 5320.8 5336.9 5276.3 5361.7 5363.8 5368.2 5373.0 5087.6 5215.0 5262.6 5317.9 5326.5 5545.3 5590.8 5619.1 5639.3 5664.5 6166.3 6200.3 6214.5 6214.6 6221.0 6139.1 6209.3 6217.4 6225.0 6233.1 5835.6 5934.1 5937.0 5970.9 5978.3 6370.8 6406.1 6441.5 6451.9 6467.8 5965.6 6049.3 6067.4 6206.8 6211.2 6240.8 6245.9 6249.2 6250.2 6250.9 6152.6 6164.2 6212.3 6219.7 6224.6 5997.9 6093.7 6110.5 6133.8 6217.2 4659.1 4692.3 4702.5 4716.2 4737.7 4206.7 4215.3 4222.4 4234.2 4252.9 5832.4 5967.9 5972.3 5997.9 6067.6 6185.3 6191.9 6218.2 6304.7 6313.0 5890.2 6028.5 6041.3 6057.8 6071.6 5305.9 5315.3 5343.5 5368.4 5372.8 6435.6 6478.7 6498.5 6510.9 6521.7 6080.5 6133.8 6261.8 6264.0 6271.1 6318.6 6446.1 6449.7 6451.4 6461.2 6074.3 6108.1 6113.6 6115.9 6129.7 6114.4 6189.4 6194.9 6215.3 6235.0 6129.4 6145.2 6168.6 6173.8 6195.7 6104.3 6107.4 6155.2 6159.4 6166.4 5908.8 5967.7 5978.4 6004.6 6079.5 6163.7 6165.8 6182.8 6198.3 6201.1 6096.5 6099.6 6101.8 6105.3 6125.5 14:03:52 INFO - PROCESS | 4254 | 14:03:52 INFO - PROCESS | 4254 | [#1] ext.html Cycles:180 Average:68921.28 Median:45827.66 stddev:147315.17 (321.5%) stddev-sans-first:147639.09 14:03:52 INFO - PROCESS | 4254 | Values: 588.5 646.3 656.8 668.5 671.7 35335.8 47971.8 48568.0 48588.0 48884.5 49292.8 49786.8 49790.8 50055.0 50151.2 9003.0 9150.3 9166.4 9185.0 9192.4 8987.2 9119.6 9129.5 9147.8 9205.3 9217.6 9256.6 9319.0 9323.5 9332.6 9252.0 9264.5 9265.4 9272.0 9276.8 9046.6 9156.5 9163.4 9167.8 9188.7 45839.3 46217.3 46358.3 46390.3 46484.5 3674.1 3826.7 3850.0 3858.0 3931.8 34741.5 35289.6 35530.8 35885.3 35917.6 4423.5 4617.8 4705.2 4710.8 4717.7 379251.0 381526.1 381914.0 382122.0 382507.0 35730.1 69478.3 69484.3 69888.0 69920.7 37808.4 40003.0 40032.4 40099.0 40137.2 15982.3 16182.4 16223.3 16256.6 16257.7 13176.7 13200.3 13202.5 13254.7 13263.6 9151.7 9205.0 9239.0 9259.4 9331.4 3439.1 3489.2 3505.7 3508.9 3519.6 1088.3 1092.4 1102.6 1172.7 1190.7 34213.5 34382.1 34456.0 34826.5 34883.3 1108.3 1144.8 1185.8 1212.0 1217.8 17724.7 18080.5 18084.1 18099.9 18227.8 598346.0 606740.0 608749.0 612976.0 959799.0 66579.0 66897.0 67350.3 67514.7 67575.7 1456.2 1456.7 1469.2 1480.6 1480.9 33986.3 34067.5 34542.1 34975.5 35456.5 58102.0 58911.0 59019.7 59042.1 59059.0 529383.0 531982.0 536295.0 536711.0 537091.0 31625.0 32119.4 32590.3 32602.5 32608.2 54194.2 54313.0 54619.7 54716.7 55331.4 45058.0 45352.0 45454.0 45639.8 46406.8 45429.0 45824.0 45837.0 46173.5 46283.3 45704.0 45821.8 45831.3 45844.8 46450.5 38504.6 38544.7 38959.7 39594.4 40060.6 30092.8 30330.0 30425.8 30608.2 30925.0 14:03:52 INFO - PROCESS | 4254 | 14:03:52 INFO - PROCESS | 4254 | [#2] jquery.html Cycles:180 Average:28889.33 Median:20856.74 stddev:78117.23 (374.5%) stddev-sans-first:78307.11 14:03:52 INFO - PROCESS | 4254 | Values: 414.8 415.6 415.7 418.3 430.9 19150.1 20783.8 20929.7 22156.2 22242.2 12915.5 17878.4 19213.4 19785.0 19873.4 5263.2 5396.7 5414.6 5424.5 5452.9 5227.6 5253.7 5779.5 6135.8 6145.4 6160.7 6182.9 6189.2 6190.5 6203.3 6027.0 6138.7 6142.7 6213.4 6234.8 5818.9 5903.8 5941.9 5950.2 5959.8 14425.8 14766.9 20498.7 24162.5 24592.8 2299.8 2454.1 2462.4 2478.9 2836.7 10086.2 10722.9 10734.2 11042.8 11103.1 1809.9 1877.2 1937.0 1973.7 1975.2 77943.0 81108.6 81527.0 84000.6 84004.2 11619.0 11669.8 11739.1 11771.5 11813.9 12673.3 16009.0 16435.1 16615.2 16645.0 6345.4 6582.4 7762.7 8205.3 8399.4 8185.5 8221.8 8232.4 8360.4 8381.5 4263.2 4292.7 4426.8 4494.7 4501.1 1942.7 1991.2 2003.6 2020.1 2030.2 995.0 1032.9 1065.1 1070.9 1125.4 19773.2 20003.0 20073.8 20144.0 20334.2 1027.6 1062.5 1073.6 1074.8 1078.2 11142.1 11325.8 11328.6 11385.1 11449.8 462247.0 465016.0 474907.0 478596.0 479661.0 94910.5 98147.5 99810.5 100718.5 101267.5 1010.2 1040.9 1056.8 1057.7 1067.4 17779.2 17912.6 17991.6 18190.9 18325.6 31512.8 35722.3 37683.0 41583.6 42058.8 60338.4 61335.4 61389.0 62941.0 62950.7 8940.0 9031.5 9047.4 9086.8 9133.1 10430.4 13072.7 13767.5 14261.4 14310.4 12287.7 12515.3 12606.3 12630.7 12751.2 12321.7 12491.1 12599.2 12622.0 12981.3 12748.3 12833.7 12857.9 12934.3 13005.7 9365.0 9431.6 9463.2 9545.6 9644.7 10966.0 12365.3 12489.2 12669.5 12843.2 14:03:52 INFO - PROCESS | 4254 | 14:03:52 INFO - PROCESS | 4254 | [#3] mootools.html Cycles:180 Average:6171.19 Median:4987.14 stddev:3501.18 (70.2%) stddev-sans-first:3493.78 14:03:52 INFO - PROCESS | 4254 | Values: 1549.5 1550.5 1750.5 1817.3 1874.1 8399.4 8529.4 9001.5 9107.0 9121.1 9025.7 9192.8 9207.6 9278.1 9282.4 2481.5 2501.3 2521.7 2521.9 2524.5 2437.8 2472.6 2491.6 2499.8 2505.2 2468.6 2483.9 2489.8 2499.5 2502.9 2447.0 2453.2 2464.6 2465.9 2469.8 2381.7 2391.8 2393.2 2407.1 2413.6 9137.9 9323.9 9332.6 9343.3 9355.5 5650.9 5764.7 5768.7 5794.2 5795.9 3372.3 3568.2 3632.6 3651.5 3700.8 1108.8 1139.9 1156.4 1167.3 1191.5 13077.9 13204.6 13228.9 13277.5 13311.8 4955.6 4978.4 5026.4 5082.8 5089.6 11132.2 11228.5 11234.2 11237.3 11247.2 5641.9 5645.7 5711.9 5738.0 5742.1 4608.5 4995.9 5138.6 5158.5 5211.1 4229.4 4358.6 4410.9 4466.4 4485.1 1376.6 1395.7 1397.8 1403.2 1418.7 907.0 967.7 973.1 977.7 1081.4 6337.7 6431.6 6477.8 6597.0 6618.4 489.9 492.8 494.3 502.9 520.1 4546.6 4565.8 4604.3 4610.0 4616.1 11223.4 11579.1 11592.9 11594.3 11597.5 11072.0 11461.1 11488.2 11498.7 11510.9 8702.3 8748.5 8826.2 8838.9 8843.1 6249.3 6269.2 6430.5 6485.1 6616.5 9967.4 10730.6 10837.8 10845.1 10933.3 10368.6 10485.4 10510.5 10547.5 10704.3 7427.9 8117.7 8270.3 8272.8 8297.0 9225.4 9234.4 9242.4 9276.6 9298.1 7937.0 8165.1 8165.3 8194.9 8353.9 8040.7 8154.9 8172.3 8218.0 8271.6 7452.2 7510.8 7705.0 7753.0 7790.5 5525.1 5532.0 5563.5 5604.2 5664.3 5436.7 5471.9 5575.7 5618.4 5722.4 14:03:52 INFO - PROCESS | 4254 | 14:03:52 INFO - PROCESS | 4254 | [#4] prototype.html Cycles:180 Average:5055.59 Median:5683.16 stddev:1507.06 (26.5%) stddev-sans-first:1469.29 14:03:52 INFO - PROCESS | 4254 | Values: 348.3 350.7 352.4 358.1 362.2 5598.2 5688.6 5754.2 5838.0 5841.5 5761.0 5766.2 5785.0 5794.4 5803.9 4508.5 4516.8 4528.9 4552.2 4554.6 4453.8 4477.2 4492.2 4497.6 4543.0 4442.5 4462.1 4464.8 4483.2 4483.6 4477.1 4498.8 4530.2 4542.5 4552.5 3908.3 3944.5 3958.4 4028.0 4049.3 5495.9 5500.2 5548.6 5566.1 5587.3 5136.3 5213.4 5222.8 5233.3 5243.9 5926.6 6057.9 6072.4 6110.2 6155.2 4416.4 4418.7 4423.8 4436.0 4454.3 6238.3 6349.6 6354.8 6365.3 6412.3 4162.2 4396.6 4403.0 4411.6 4431.6 4439.8 4444.0 4444.8 4452.2 4453.1 5120.2 5123.5 5154.8 5185.5 5192.7 5895.7 5971.4 6057.8 6076.4 6117.0 1506.0 1528.8 1532.9 1537.2 1544.6 962.9 965.6 968.9 972.6 997.4 5197.4 5249.0 5304.7 5374.4 5403.5 5557.6 5609.2 5616.4 5622.6 5677.7 5054.7 5235.4 5246.9 5293.3 5380.0 2973.4 2981.8 2983.4 2985.7 3017.6 5716.5 5722.5 5734.0 5750.2 5767.2 5916.0 6411.6 6426.4 6436.5 6447.5 6501.8 6531.2 6538.2 6547.5 6561.9 6064.6 6256.7 6307.7 6326.9 6327.4 6138.7 6194.6 6252.1 6256.6 6268.3 6504.7 6516.7 6541.6 6563.9 6598.5 4396.4 4443.3 4452.5 4460.3 4483.4 6085.0 6100.8 6374.5 6400.9 6422.6 6075.5 6114.1 6179.7 6206.7 6234.3 6124.9 6135.5 6171.2 6175.8 6194.9 5929.7 6000.5 6032.3 6038.5 6046.5 6165.8 6199.8 6209.9 6217.5 6267.0 5860.1 5933.9 6041.7 6051.2 6141.4 14:03:52 INFO - PROCESS | 4254 | 14:03:52 INFO - PROCESS | 4254 | [#5] yui.html Cycles:180 Average:21784.19 Median:4611.05 stddev:30773.74 (667.4%) stddev-sans-first:30819.72 14:03:52 INFO - PROCESS | 4254 | Values: 796.9 812.7 853.6 869.4 880.2 16439.3 17031.1 17233.8 17247.8 17248.7 15612.8 15648.0 15745.5 15797.7 15987.4 865.0 884.6 886.4 886.6 887.0 858.5 875.3 877.3 882.2 888.7 916.1 917.5 921.9 926.4 927.7 914.3 917.9 918.9 919.0 919.8 669.5 672.6 673.8 674.3 678.8 17126.1 17223.6 17349.8 17356.1 17364.7 15122.0 15146.6 15384.1 15439.8 15586.6 14365.1 14415.9 14491.4 14525.2 14756.2 4788.6 4789.7 4794.2 4833.5 4853.9 93305.5 96522.0 96628.0 96768.5 97011.0 12205.8 12338.7 12379.8 12450.4 12677.4 22647.9 22979.7 23059.5 23074.1 23412.6 8729.7 8972.1 8999.7 9045.1 9154.7 4593.9 4594.7 4600.6 4621.5 4632.6 3512.1 3616.9 3616.9 3622.0 3627.9 650.4 665.2 665.4 668.5 670.3 613.7 654.1 686.9 692.7 700.8 9083.0 9537.5 9549.3 9671.9 9752.6 654.6 742.8 748.3 796.3 813.0 4967.7 4982.8 5009.2 5062.8 5231.9 70346.3 80867.6 123943.0 125311.4 126411.4 62606.7 63608.7 107372.0 108013.5 110196.7 89168.0 93548.0 95641.0 96635.5 97702.0 10727.2 10841.5 10846.8 10998.9 11058.6 40769.4 43261.8 48115.0 48152.8 53007.2 74250.0 78940.2 81186.2 81607.6 84658.0 13821.3 13876.1 14054.4 14160.3 14315.9 15983.8 15984.6 16154.8 16467.0 16615.4 15047.5 15278.4 15344.8 15377.0 15454.2 15047.7 15202.2 15315.0 15340.2 15412.8 14417.0 14704.6 14717.1 15023.9 15613.0 12437.2 12480.6 12666.0 12837.2 12942.5 12380.8 12427.8 12662.0 12795.3 13052.4 14:03:52 INFO - PROCESS | 4254 | -------- Summary: end -------- 14:03:52 INFO - PROCESS | 4254 | 14:03:53 INFO - TEST-INFO | 4254: exit 0 14:03:53 INFO - TEST-OK | dromaeo_css | took 1109908ms 14:03:53 INFO - TEST-START | kraken 14:03:53 INFO - operating with platform_type : linux_ 14:03:53 INFO - Initialising browser for kraken test... 14:03:53 INFO - TEST-INFO | started process 4498 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHcgSmK/profile http://localhost:51880/getInfo.html) 14:03:57 INFO - PROCESS | 4498 | __metrics Screen width/height:1600/1200 14:03:57 INFO - PROCESS | 4498 | colorDepth:24 14:03:57 INFO - PROCESS | 4498 | Browser inner width/height: 1024/697 14:03:57 INFO - PROCESS | 4498 | __metrics 14:03:58 ERROR - PROCESS | 4498 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 14:03:58 INFO - TEST-INFO | 4498: exit 0 14:03:58 INFO - Browser initialized. 14:03:58 INFO - Running cycle 1/1 for kraken test... 14:03:58 INFO - TEST-INFO | started process 4629 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHcgSmK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:04:10 INFO - PROCESS | 4629 | RSS: Main: 156184576 14:04:10 INFO - PROCESS | 4629 | 14:04:13 INFO - PROCESS | 4629 | Cycle 1(1): loaded http://localhost:51880/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51880/tests/kraken/driver.html?testName=audio-beat-detection) 14:04:14 INFO - PROCESS | 4629 | RSS: Main: 160796672 14:04:14 INFO - PROCESS | 4629 | 14:04:16 INFO - PROCESS | 4629 | Cycle 1(1): loaded http://localhost:51880/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51880/tests/kraken/driver.html?testName=audio-dft) 14:04:17 INFO - PROCESS | 4629 | RSS: Main: 160677888 14:04:17 INFO - PROCESS | 4629 | 14:04:20 INFO - PROCESS | 4629 | Cycle 1(1): loaded http://localhost:51880/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51880/tests/kraken/driver.html?testName=audio-fft) 14:04:20 INFO - PROCESS | 4629 | RSS: Main: 161095680 14:04:20 INFO - PROCESS | 4629 | 14:04:22 INFO - PROCESS | 4629 | Cycle 1(1): loaded http://localhost:51880/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51880/tests/kraken/driver.html?testName=audio-oscillator) 14:04:23 INFO - PROCESS | 4629 | RSS: Main: 160817152 14:04:23 INFO - PROCESS | 4629 | 14:04:25 INFO - PROCESS | 4629 | Cycle 1(1): loaded http://localhost:51880/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51880/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:04:26 INFO - PROCESS | 4629 | RSS: Main: 160722944 14:04:26 INFO - PROCESS | 4629 | 14:04:29 INFO - PROCESS | 4629 | Cycle 1(1): loaded http://localhost:51880/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51880/tests/kraken/driver.html?testName=imaging-darkroom) 14:04:30 INFO - PROCESS | 4629 | RSS: Main: 160514048 14:04:30 INFO - PROCESS | 4629 | 14:04:33 INFO - PROCESS | 4629 | Cycle 1(1): loaded http://localhost:51880/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51880/tests/kraken/driver.html?testName=imaging-desaturate) 14:04:34 INFO - PROCESS | 4629 | RSS: Main: 157011968 14:04:34 INFO - PROCESS | 4629 | 14:04:36 INFO - PROCESS | 4629 | Cycle 1(1): loaded http://localhost:51880/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51880/tests/kraken/driver.html?testName=json-parse-financial) 14:04:37 INFO - PROCESS | 4629 | RSS: Main: 158638080 14:04:37 INFO - PROCESS | 4629 | 14:04:39 INFO - PROCESS | 4629 | Cycle 1(1): loaded http://localhost:51880/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51880/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:04:39 INFO - PROCESS | 4629 | RSS: Main: 159227904 14:04:39 INFO - PROCESS | 4629 | 14:04:41 INFO - PROCESS | 4629 | Cycle 1(1): loaded http://localhost:51880/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51880/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:04:42 INFO - PROCESS | 4629 | RSS: Main: 159117312 14:04:42 INFO - PROCESS | 4629 | 14:04:44 INFO - PROCESS | 4629 | Cycle 1(1): loaded http://localhost:51880/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51880/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:04:44 INFO - PROCESS | 4629 | RSS: Main: 159866880 14:04:44 INFO - PROCESS | 4629 | 14:04:47 INFO - PROCESS | 4629 | Cycle 1(1): loaded http://localhost:51880/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51880/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:04:47 INFO - PROCESS | 4629 | RSS: Main: 159936512 14:04:47 INFO - PROCESS | 4629 | 14:04:50 INFO - PROCESS | 4629 | Cycle 1(1): loaded http://localhost:51880/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51880/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:04:51 INFO - PROCESS | 4629 | RSS: Main: 159457280 14:04:51 INFO - PROCESS | 4629 | 14:04:52 INFO - PROCESS | 4629 | Cycle 1(1): loaded http://localhost:51880/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51880/tests/kraken/driver.html?testName=ai-astar) 14:04:53 INFO - PROCESS | 4629 | RSS: Main: 160210944 14:04:53 INFO - PROCESS | 4629 | 14:04:53 INFO - PROCESS | 4629 | __start_tp_report 14:04:53 INFO - PROCESS | 4629 | _x_x_mozilla_page_load 14:04:53 INFO - PROCESS | 4629 | _x_x_mozilla_page_load_details 14:04:53 INFO - PROCESS | 4629 | |i|pagename|runs| 14:04:53 INFO - PROCESS | 4629 | |0;ai-astar;112;105;112;111;112;111;109;111;111;109 14:04:53 INFO - PROCESS | 4629 | |1;audio-beat-detection;163;125;154;167;133;154;147;127;180;127 14:04:53 INFO - PROCESS | 4629 | |2;audio-dft;162;162;160;164;163;163;162;176;162;172 14:04:53 INFO - PROCESS | 4629 | |3;audio-fft;74;80;75;176;76;76;75;74;168;76 14:04:53 INFO - PROCESS | 4629 | |4;audio-oscillator;88;83;148;85;83;86;137;85;84;145 14:04:53 INFO - PROCESS | 4629 | |5;imaging-gaussian-blur;120;117;118;122;118;117;117;117;118;118 14:04:53 INFO - PROCESS | 4629 | |6;imaging-darkroom;150;151;148;149;149;149;149;150;149;146 14:04:53 INFO - PROCESS | 4629 | |7;imaging-desaturate;96;96;97;95;96;96;95;97;97;95 14:04:53 INFO - PROCESS | 4629 | |8;json-parse-financial;54;53;52;52;52;52;53;53;54;53 14:04:53 INFO - PROCESS | 4629 | |9;json-stringify-tinderbox;60;61;60;61;62;62;61;61;60;59 14:04:53 INFO - PROCESS | 4629 | |10;stanford-crypto-aes;77;76;76;76;78;78;79;83;109;77 14:04:53 INFO - PROCESS | 4629 | |11;stanford-crypto-ccm;120;122;121;125;119;127;135;126;122;131 14:04:53 INFO - PROCESS | 4629 | |12;stanford-crypto-pbkdf2;160;152;154;157;150;152;150;159;153;159 14:04:53 INFO - PROCESS | 4629 | |13;stanford-crypto-sha256-iterative;60;67;63;63;62;61;62;62;61;60 14:04:53 INFO - PROCESS | 4629 | __end_tp_report 14:04:53 INFO - PROCESS | 4629 | __start_cc_report 14:04:53 INFO - PROCESS | 4629 | _x_x_mozilla_cycle_collect,872 14:04:53 INFO - PROCESS | 4629 | __end_cc_report 14:04:53 INFO - PROCESS | 4629 | __startTimestamp1465506293151__endTimestamp 14:04:53 INFO - PROCESS | 4629 | 14:04:53 INFO - PROCESS | 4629 | ------- Summary: start ------- 14:04:53 INFO - PROCESS | 4629 | Number of tests: 14 14:04:53 INFO - PROCESS | 4629 | 14:04:53 INFO - PROCESS | 4629 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:2.16 (1.9%) stddev-sans-first:2.20 14:04:53 INFO - PROCESS | 4629 | Values: 112.0 105.0 112.0 111.0 112.0 111.0 109.0 111.0 111.0 109.0 14:04:53 INFO - PROCESS | 4629 | 14:04:53 INFO - PROCESS | 4629 | [#1] audio-beat-detection Cycles:10 Average:147.70 Median:154.00 stddev:19.20 (12.5%) stddev-sans-first:19.55 14:04:53 INFO - PROCESS | 4629 | Values: 163.0 125.0 154.0 167.0 133.0 154.0 147.0 127.0 180.0 127.0 14:04:53 INFO - PROCESS | 4629 | 14:04:53 INFO - PROCESS | 4629 | [#2] audio-dft Cycles:10 Average:164.60 Median:163.00 stddev:5.15 (3.2%) stddev-sans-first:5.37 14:04:53 INFO - PROCESS | 4629 | Values: 162.0 162.0 160.0 164.0 163.0 163.0 162.0 176.0 162.0 172.0 14:04:53 INFO - PROCESS | 4629 | 14:04:53 INFO - PROCESS | 4629 | [#3] audio-fft Cycles:10 Average:95.00 Median:75.50 stddev:40.66 (53.9%) stddev-sans-first:42.41 14:04:53 INFO - PROCESS | 4629 | Values: 74.0 80.0 75.0 176.0 76.0 76.0 75.0 74.0 168.0 76.0 14:04:53 INFO - PROCESS | 4629 | 14:04:53 INFO - PROCESS | 4629 | [#4] audio-oscillator Cycles:10 Average:102.40 Median:84.50 stddev:28.41 (33.6%) stddev-sans-first:29.65 14:04:53 INFO - PROCESS | 4629 | Values: 88.0 83.0 148.0 85.0 83.0 86.0 137.0 85.0 84.0 145.0 14:04:53 INFO - PROCESS | 4629 | 14:04:53 INFO - PROCESS | 4629 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:118.00 stddev:1.62 (1.4%) stddev-sans-first:1.58 14:04:53 INFO - PROCESS | 4629 | Values: 120.0 117.0 118.0 122.0 118.0 117.0 117.0 117.0 118.0 118.0 14:04:53 INFO - PROCESS | 4629 | 14:04:53 INFO - PROCESS | 4629 | [#6] imaging-darkroom Cycles:10 Average:149.00 Median:149.00 stddev:1.33 (0.9%) stddev-sans-first:1.36 14:04:53 INFO - PROCESS | 4629 | Values: 150.0 151.0 148.0 149.0 149.0 149.0 149.0 150.0 149.0 146.0 14:04:53 INFO - PROCESS | 4629 | 14:04:53 INFO - PROCESS | 4629 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 14:04:53 INFO - PROCESS | 4629 | Values: 96.0 96.0 97.0 95.0 96.0 96.0 95.0 97.0 97.0 95.0 14:04:53 INFO - PROCESS | 4629 | 14:04:53 INFO - PROCESS | 4629 | [#8] json-parse-financial Cycles:10 Average:52.80 Median:53.00 stddev:0.79 (1.5%) stddev-sans-first:0.71 14:04:53 INFO - PROCESS | 4629 | Values: 54.0 53.0 52.0 52.0 52.0 52.0 53.0 53.0 54.0 53.0 14:04:53 INFO - PROCESS | 4629 | 14:04:53 INFO - PROCESS | 4629 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:61.00 stddev:0.95 (1.6%) stddev-sans-first:0.97 14:04:53 INFO - PROCESS | 4629 | Values: 60.0 61.0 60.0 61.0 62.0 62.0 61.0 61.0 60.0 59.0 14:04:53 INFO - PROCESS | 4629 | 14:04:53 INFO - PROCESS | 4629 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:77.50 stddev:10.09 (13.0%) stddev-sans-first:10.61 14:04:53 INFO - PROCESS | 4629 | Values: 77.0 76.0 76.0 76.0 78.0 78.0 79.0 83.0 109.0 77.0 14:04:53 INFO - PROCESS | 4629 | 14:04:53 INFO - PROCESS | 4629 | [#11] stanford-crypto-ccm Cycles:10 Average:124.80 Median:125.50 stddev:5.12 (4.1%) stddev-sans-first:5.12 14:04:53 INFO - PROCESS | 4629 | Values: 120.0 122.0 121.0 125.0 119.0 127.0 135.0 126.0 122.0 131.0 14:04:53 INFO - PROCESS | 4629 | 14:04:53 INFO - PROCESS | 4629 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.60 Median:155.50 stddev:3.84 (2.5%) stddev-sans-first:3.54 14:04:53 INFO - PROCESS | 4629 | Values: 160.0 152.0 154.0 157.0 150.0 152.0 150.0 159.0 153.0 159.0 14:04:53 INFO - PROCESS | 4629 | 14:04:53 INFO - PROCESS | 4629 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.10 Median:62.00 stddev:2.02 (3.3%) stddev-sans-first:2.00 14:04:53 INFO - PROCESS | 4629 | Values: 60.0 67.0 63.0 63.0 62.0 61.0 62.0 62.0 61.0 60.0 14:04:53 INFO - PROCESS | 4629 | -------- Summary: end -------- 14:04:53 INFO - PROCESS | 4629 | 14:04:54 INFO - TEST-INFO | 4629: exit 0 14:04:54 INFO - TEST-OK | kraken | took 60982ms 14:04:54 INFO - SUITE-END | took 1170s 14:04:54 INFO - Completed test suite (00:19:31) 14:04:54 INFO - javascript benchmark 14:04:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7664.067508307206, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3350.7267238449394, 3397.4394224952885, 3419.4186988212, 3437.2781715839687, 3439.587249530055, 5720.141978703196, 5747.453991870776, 5753.050746626806, 5774.711264436777, 5787.363390027104, 5741.397153298906, 5784.971075144618, 5794.884102317951, 5832.154337621042, 5859.736311865966, 5201.8439446816565, 5242.501962313574, 5266.420693723688, 5312.043832110218, 5359.678419294835, 5115.207142892839, 5169.508896654812, 5273.182656688219, 5311.760970756325, 5326.813561525348, 5258.290130832327, 5267.920981185285, 5293.602979776513, 5320.787168513274, 5336.866578335554, 5276.287701160351, 5361.705106219157, 5363.785448582052, 5368.1679339702405, 5372.973135134338, 5087.618428617831, 5215.0, 5262.60530460217, 5317.9202311965355, 5326.520613144836, 5545.251391062236, 5590.832275031715, 5619.129034999582, 5639.2668953035845, 5664.490195882349, 6166.260048794128, 6200.348963358872, 6214.502839772807, 6214.5649804513705, 6221.035739460391, 6139.109829074804, 6209.348018458042, 6217.440430361244, 6225.003999360126, 6233.096201050867, 5835.620684655484, 5934.050551911717, 5937.020391635375, 5970.850728731816, 5978.252718410199, 6370.840728981812, 6406.135171751847, 6441.484681225491, 6451.870962580722, 6467.838304042342, 5965.55258355625, 6049.334573196945, 6067.423594758491, 6206.782762603287, 6211.223597050369, 6240.781572644935, 6245.937540624626, 6249.156363890907, 6250.249970003538, 6250.9062364064575, 6152.569320147636, 6164.229471316085, 6212.254529456403, 6219.689015549295, 6224.564280500322, 5997.940020599825, 6093.664848433379, 6110.541709371726, 6133.754649813957, 6217.191765070512, 4659.068186362741, 4692.319613656001, 4702.52974702527, 4716.245400735935, 4737.6683632146105, 4206.72656277341, 4215.304474761691, 4222.408862759216, 4234.216669916075, 4252.87241382759, 5832.387599302097, 5967.940320596826, 5972.313183983811, 5997.910031349533, 6067.635941843503, 6185.319614842364, 6191.907121393183, 6218.22272215973, 6304.716287767062, 6313.0, 5890.2342695449315, 6028.487578555872, 6041.305249896231, 6057.848553786191, 6071.574989750675, 5305.946940530623, 5315.335583052119, 5343.465653434703, 5368.3826359968325, 5372.758225879845, 6435.581687190318, 6478.740850365933, 6498.54510184292, 6510.893148164823, 6521.706523206467, 6080.513558915364, 6133.815985520441, 6261.812145635456, 6264.0, 6271.090691849565, 6318.557700960889, 6446.065320528591, 6449.7097630605795, 6451.387118223761, 6461.224653041665, 6074.271087469355, 6108.053251745987, 6113.633182009094, 6115.938840611715, 6129.724162412791, 6114.419130182626, 6189.381061893775, 6194.876102477835, 6215.34738852414, 6235.0, 6129.387061293835, 6145.170401995852, 6168.629882207082, 6173.84565385851, 6195.690215489118, 6104.328523862283, 6107.4197951194565, 6155.169052178077, 6159.414855588712, 6166.383361663798, 5908.763649453974, 5967.701614919323, 5978.432048955342, 6004.609700369462, 6079.452849243412, 6163.736434031102, 6165.815025549241, 6182.752689892354, 6198.318184999556, 6201.10084037803, 6096.542759293159, 6099.573029887865, 6101.78271676276, 6105.328413874381, 6125.479334256638], "value": 5739.615273570844, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.5350573047293, 646.3278190681691, 656.7701304543409, 668.4886062162443, 671.6775947545178, 35335.82332088339, 47971.76014119929, 48568.0, 48588.0, 48884.511154888394, 49292.75353623236, 49786.751066244615, 49790.75104624472, 50055.0, 50151.24773128406, 9002.954985225064, 9150.313726470507, 9166.40418372807, 9185.0, 9192.35653504255, 8987.191152796247, 9119.63521459144, 9129.543522823866, 9147.771305717344, 9205.263578913671, 9217.631294748235, 9256.583453744597, 9319.021502742216, 9323.487208203545, 9332.580033898457, 9252.028537003618, 9264.49045302508, 9265.397749146285, 9272.0, 9276.768080798034, 9046.638134474613, 9156.450612963243, 9163.40437871543, 9167.816643667156, 9188.678396256098, 45839.31241031387, 46217.30674039892, 46358.30462543065, 46390.30414543785, 46484.53515464836, 3674.1182116292166, 3826.693864490834, 3849.961500384988, 3857.9807100964317, 3931.82306796192, 34741.47887781685, 35289.64710352889, 35530.822345888366, 35885.28229435423, 35917.64082359169, 4423.469183697945, 4617.792199351037, 4705.247160454345, 4710.78801453932, 4717.693349932243, 379251.0, 381526.09236953914, 381914.0, 382121.9999999972, 382507.0, 35730.10674733153, 69478.30521694718, 69484.30515694778, 69888.0, 69920.65039674769, 37808.43287350692, 40003.0, 40032.39951400732, 40099.0, 40137.197256054715, 15982.280797364147, 16182.352705891868, 16223.269952851913, 16256.59358516023, 16257.674846503003, 13176.670583235496, 13200.339983000811, 13202.471901123847, 13254.73490530184, 13263.602091937257, 9151.679691210775, 9204.953975230215, 9238.95380523093, 9259.398139120936, 9331.440113593206, 3439.0886415100017, 3489.249811290534, 3505.719542436599, 3508.929821403609, 3519.63043880394, 1088.3198001249218, 1092.3991804507489, 1102.5975518935531, 1172.7009612548745, 1190.6904204906787, 34213.48679769805, 34382.14044648904, 34456.0, 34826.47760283598, 34883.30233395318, 1108.2519299472824, 1144.822552504363, 1185.8102703567388, 1212.0373299588864, 1217.829503869459, 17724.734128988075, 18080.547986300186, 18084.095795210185, 18099.909500452413, 18227.817721822612, 598346.0, 606740.0, 608749.0, 612976.0, 959799.0, 66579.0, 66897.0, 67350.3264967344, 67514.66242668756, 67575.66212169005, 1456.2281990545027, 1456.6504039030556, 1469.2066284206624, 1480.6446452851237, 1480.9259537023106, 33986.32027359489, 34067.4889876657, 34542.13644658904, 34975.475367868996, 35456.46815297824, 58102.0, 58911.0, 59019.70490147522, 59042.11436828537, 59059.0, 529383.0, 531982.0, 536295.0, 536711.0, 537091.0, 31625.0, 32119.357612847143, 32590.34819303648, 32602.51096233606, 32608.184795380304, 54194.187087192935, 54313.0, 54619.72690136524, 54716.72641636767, 55331.44668553263, 45058.0, 45352.0, 45454.0, 45639.771801140785, 46406.767966159954, 45429.0, 45824.0, 45837.0, 46173.538264616924, 46283.305750414445, 45704.0, 45821.77089114533, 45831.31253031141, 45844.7707761459, 46450.535494644624, 38504.614953850105, 38544.749260177916, 38959.72768577889, 39594.40608390819, 40060.59939400685, 30092.849535752182, 30330.0, 30425.847870760503, 30608.234794130323, 30925.0], "value": 20672.123924393934, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [414.81955349423, 415.63631822155617, 415.68615695150174, 418.3390243415404, 430.91166310906266, 19150.138243779027, 20783.792162078393, 20929.68605470917, 22156.22453214138, 22242.221522246724, 12915.547955821548, 17878.37425690101, 19213.42359729207, 19785.0, 19873.40379788605, 5263.157894736833, 5396.676199428047, 5414.620976531644, 5424.457554244584, 5452.890942181174, 5227.607929405291, 5253.684778913277, 5779.537636989031, 6135.754569817202, 6145.385461453863, 6160.722767475452, 6182.907256391158, 6189.195404597396, 6190.473809726156, 6203.31763506014, 6026.96986515069, 6138.662373569452, 6142.723577439004, 6213.378662133796, 6234.844128896769, 5818.941810581925, 5903.79336723217, 5941.940580594182, 5950.196723442323, 5959.791407300723, 14425.78361324581, 14766.852331476655, 20498.66758660697, 24162.51674966491, 24592.754072459225, 2299.7930186283315, 2454.085653574894, 2462.384403899025, 2478.8512689238705, 2836.744692977621, 10086.193104551618, 10722.946385268024, 10734.248602597821, 11042.834357484644, 11103.111751059896, 1809.936692126185, 1877.1646617255326, 1936.9903150484158, 1973.73354597129, 1975.2494052260192, 77943.0, 81108.59445702734, 81527.0, 84000.57999709963, 84004.15995840024, 11618.95429411357, 11669.824952625717, 11739.119566032581, 11771.529138834521, 11813.940930295294, 12673.30296833683, 16009.0, 16435.09606971628, 16615.169241537875, 16645.0012999218, 6345.428911397997, 6582.440492558187, 7762.6894924203525, 8205.302549283379, 8399.412041157182, 8185.467944583583, 8221.753347399588, 8232.423730338818, 8360.414770966096, 8381.49711017341, 4263.16868210696, 4292.678049146327, 4426.800793964279, 4494.70784399013, 4501.054778496552, 1942.7183058456728, 1991.178072064074, 2003.6293285741892, 2020.1313435222996, 2030.1879248300502, 994.9801003979879, 1032.9380237185792, 1065.1053115383115, 1070.9303895246785, 1125.4372813593204, 19773.209071636975, 20003.0, 20073.799262007484, 20144.0, 20334.186632534827, 1027.6300531808542, 1062.4900047977014, 1073.5652060915343, 1074.8441475985937, 1078.2129045796612, 11142.108631309477, 11325.830112548318, 11328.603498877499, 11385.14611404148, 11449.828252576219, 462247.0, 465016.0, 474907.0, 478596.0, 479661.0, 94910.5254473737, 98147.50926245465, 99810.5009474948, 100718.49640751896, 101267.4936625327, 1010.242318261304, 1040.8646875906236, 1056.7727938493108, 1057.740853490915, 1067.3969207397795, 17779.19993600317, 17912.552186195448, 17991.550211244823, 18190.90904545469, 18325.633487329913, 31512.842435787676, 35722.28555428929, 37683.0, 41583.58416415797, 42058.78970605128, 60338.39661603503, 61335.38664613297, 61389.0, 62941.0, 62950.68524657348, 8940.0, 9031.548422578977, 9047.366684332033, 9086.772830679021, 9133.132352426508, 10430.426326552113, 13072.738545228853, 13767.518136865161, 14261.358238879482, 14310.356033978704, 12287.692807679521, 12515.311657858905, 12606.306653134166, 12630.684232894251, 12751.234925904104, 12321.691957701129, 12491.125621206429, 12599.244045357307, 12622.0, 12981.286029268482, 12748.298843563693, 12833.679158021125, 12857.935710321763, 12934.288614126313, 13005.674858128623, 9364.953175234352, 9431.575579099093, 9463.195628371666, 9545.618175272912, 9644.662436814679, 10966.0, 12365.319907405179, 12489.18820276679, 12669.493220271455, 12843.229406235656], "value": 9459.20745551801, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1549.519648908838, 1550.5193390049085, 1750.4748575427377, 1817.3094224194804, 1874.0723341945738, 8399.370047246466, 8529.360297977653, 9001.45991240526, 9106.99999999999, 9121.133492318228, 9025.684101056464, 9192.770180745485, 9207.585658645361, 9278.118578735026, 9282.350235483518, 2481.516104359646, 2501.3371456564023, 2521.6595759572406, 2521.8739063046864, 2524.5329614021375, 2437.81716371272, 2472.5673007223754, 2491.626256061596, 2499.825012249143, 2505.1983365323103, 2468.568000599888, 2483.888225029869, 2489.8381605195696, 2499.512595043967, 2502.949941001179, 2446.9755302447015, 2453.2149712092228, 2464.630305454178, 2465.938351541226, 2469.790067844235, 2381.7022872140983, 2391.796697280733, 2393.1863166523467, 2407.0732767884315, 2413.5655581995234, 9137.862932056025, 9323.906760932372, 9332.58003389849, 9343.345965782399, 9355.532223388804, 5650.943490565124, 5764.654120752768, 5768.74040668171, 5794.217780599607, 5795.942040579583, 3372.258103217313, 3568.1793187566745, 3632.5640923089136, 3651.452282157671, 3700.777953322809, 1108.772701596171, 1139.9259048161844, 1156.444906444911, 1167.3404526442532, 1191.4757506697026, 13077.869221307761, 13204.60386188416, 13228.933855330759, 13277.535286264934, 13311.800322995163, 4955.603551715854, 4978.427480839678, 5026.447090820006, 5082.822101226439, 5089.618278629117, 11132.220744547803, 11228.494717737722, 11234.15743819217, 11237.3257604544, 11247.212695111264, 5641.943580564224, 5645.745941432645, 5711.857203569861, 5737.971310143506, 5742.052561327334, 4608.516105808909, 4995.850124496271, 5138.58891288696, 5158.484151584811, 5211.140161873249, 4229.386738922901, 4358.607725304738, 4410.933835992462, 4466.3747075409465, 4485.080558485568, 1376.6489545165919, 1395.7487652222696, 1397.8043073969652, 1403.1791402029723, 1418.7446259673152, 906.954652267384, 967.6806653804227, 973.075578200698, 977.6871401151706, 1081.416035340907, 6337.651429171347, 6431.646259455775, 6477.805665830033, 6597.0, 6618.371254730793, 489.9093667671492, 492.83736366998806, 494.2808214048551, 502.94719054499484, 520.0794593569436, 4546.568076032771, 4565.817367305337, 4604.309353596987, 4610.031893302444, 4616.146012987608, 11223.438828058564, 11579.073674106052, 11592.942035289938, 11594.304341739522, 11597.478113484745, 11072.0, 11461.083113350913, 11488.19582629208, 11498.655040348804, 11510.884891151149, 8702.260307873901, 8748.518831464331, 8826.161514656098, 8838.911610883937, 8843.0714774949, 6249.281332646804, 6269.185005949197, 6430.5177111715875, 6485.0596663484475, 6616.470682345497, 9967.40195588267, 10730.570777169138, 10837.837432438677, 10845.132389408986, 10933.343999360064, 10368.637097701545, 10485.423301718478, 10510.527026283988, 10547.525361358605, 10704.250702451065, 7427.925720742724, 8117.675292988451, 8270.297024752723, 8272.793180170544, 8296.958515207385, 9225.446473211628, 9234.445933244027, 9242.445453272825, 9276.62893484253, 9298.116678915492, 7937.0, 8165.061017983008, 8165.305948994402, 8194.918050819653, 8353.916460835313, 8040.718574849852, 8154.918450815416, 8172.305354044973, 8217.95891020541, 8271.627776750182, 7452.180260171268, 7510.774676759706, 7704.961475192588, 7753.0, 7790.493617914817, 5525.143602741581, 5532.0, 5563.499285064364, 5604.243427137284, 5664.291963504562, 5436.700981446058, 5471.917921231265, 5575.665460072409, 5618.438156184349, 5722.399148089391], "value": 4861.559306584889, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.34163431115195, 350.65460521386433, 352.4237871080782, 358.0940221240263, 362.1615959054788, 5598.244237028, 5688.573356998221, 5754.16564598133, 5838.0, 5841.474267315941, 5761.012450704511, 5766.192733017381, 5784.971075144629, 5794.362620111795, 5803.941960580393, 4508.458984921814, 4516.819327226915, 4528.864134075983, 4552.248878934988, 4554.567316104964, 4453.799579018936, 4477.171723231197, 4492.236319825637, 4497.640188784906, 4543.0, 4442.466903971528, 4462.12988467249, 4464.8214071437105, 4483.193025255453, 4483.551644835523, 4477.10457908418, 4498.842540511099, 4530.207213737615, 4542.500324964268, 4552.544745525454, 3908.257431088084, 3944.467496887941, 3958.44581758554, 4027.9597204027878, 4049.3116170250833, 5495.890082198373, 5500.1749737539685, 5548.5838562108, 5566.137248726453, 5587.329520457531, 5136.332276803992, 5213.4004589472315, 5222.817201397933, 5233.293505376763, 5243.86890327741, 5926.614770039933, 6057.880191701277, 6072.449571180115, 6110.236220472441, 6155.230596175478, 4416.3596278539435, 4418.74643931594, 4423.778811059434, 4435.977820110911, 4454.28731402974, 6238.282597501346, 6349.619022858643, 6354.777582784626, 6365.331640177761, 6412.294647588761, 4162.188373267244, 4396.582324679151, 4402.977985110054, 4411.647068234533, 4431.645468362523, 4439.844605438794, 4443.977780111143, 4444.755538445416, 4452.154090722753, 4453.087117140978, 5120.2063680128895, 5123.538881500683, 5154.834969312898, 5185.481451854785, 5192.7152053096515, 5895.7052147393315, 5971.4327138921735, 6057.818265452043, 6076.392360763976, 6116.969415152896, 1505.9849401506065, 1528.7630417285338, 1532.949929298412, 1537.2313843078462, 1544.5829626000916, 962.9229661627053, 965.5558443116105, 968.8692026576322, 972.557486343712, 997.4165113408592, 5197.375325460694, 5249.028929648028, 5304.708241046702, 5374.414547708436, 5403.486668766461, 5557.610967232255, 5609.242752228479, 5616.438356164351, 5622.566245607344, 5677.744501497443, 5054.7472626368535, 5235.424103348629, 5246.947530524646, 5293.311869457023, 5380.0, 2973.405318936221, 2981.7912746108, 2983.4182334444577, 2985.7161420588923, 3017.6227971503563, 5716.541492397123, 5722.452079710606, 5733.971330143323, 5750.217432595909, 5767.183337248754, 5915.994280972245, 6411.589450320922, 6426.4216220540375, 6436.517261205428, 6447.548671593037, 6501.772437964649, 6531.183602049744, 6538.215414150332, 6547.508936829757, 6561.901571476336, 6064.605800622945, 6256.718447669957, 6307.716152773044, 6326.8734625306315, 6327.430531252209, 6138.723757430837, 6194.566380353332, 6252.124702541557, 6256.5599416228615, 6268.341824108403, 6504.739810407531, 6516.706748196438, 6541.6402097883165, 6563.9343606563325, 6598.538102332983, 4396.384506169203, 4443.3115416142955, 4452.530664880517, 4460.330950357472, 4483.372327874165, 6085.0, 6100.786472473442, 6374.458171055512, 6400.935990640034, 6422.6467544285515, 6075.483583895241, 6114.113453549299, 6179.721912513858, 6206.72069756871, 6234.345393733593, 6124.908126378019, 6135.509159267337, 6171.228596425447, 6175.814725558241, 6194.907076393948, 5929.733162007807, 6000.489958353414, 6032.306284777307, 6038.486728628116, 6046.54650901193, 6165.815025549241, 6199.783007594712, 6209.875802484015, 6217.487119777311, 6267.0, 5860.120981852756, 5933.9109913352195, 6041.6677082759115, 6051.213342265477, 6141.447269745566], "value": 4569.922280616128, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [796.8525822722796, 812.7114874219648, 853.581744944977, 869.4392117084478, 880.1726377205423, 16439.34242630295, 17031.06329151896, 17233.82766172338, 17247.82752172478, 17248.655026899454, 15612.765808512853, 15648.0, 15745.527634170992, 15797.684046319067, 15987.360505579793, 864.9740507784761, 884.6461415433813, 886.352962337494, 886.6143227695941, 886.9645214191424, 858.5321000054954, 875.299760191844, 877.2937785083005, 882.2016075451694, 888.6711916590871, 916.0793402630347, 917.5045475443253, 921.8801555797737, 926.3885835348672, 927.7077720518015, 914.314264301777, 917.9127982841653, 918.9081091890757, 919.0258326174277, 919.7608621758358, 669.4978765925556, 672.6300534705892, 673.7574473189648, 674.3458844920419, 678.759040540606, 17126.05806680632, 17223.569410764707, 17349.826501734948, 17356.132193390407, 17364.739528907077, 15122.0, 15146.621334466616, 15384.076955382712, 15439.845601544066, 15586.610334741608, 14365.138091714425, 14415.927920360436, 14491.42034318626, 14525.201113938729, 14756.188409637465, 4788.592969597588, 4789.688670236458, 4794.232922732381, 4833.516648335173, 4853.927191092136, 93305.53347233289, 96522.0, 96628.0, 96768.51615741877, 97011.0298897009, 12205.755884882252, 12338.691532711755, 12379.75240495203, 12450.377481125908, 12677.429515671816, 22647.88676056642, 22979.655305170436, 23059.538809223723, 23074.077036918334, 23412.64881026786, 8729.694460693845, 8972.102789721106, 8999.730008099768, 9045.140711632515, 9154.725358239264, 4593.908121837545, 4594.724316541018, 4600.5629465200755, 4621.5378462154185, 4632.629389648888, 3512.08685741709, 3616.8734094306574, 3616.945745813815, 3622.0220540454457, 3627.854885804591, 650.3788881618138, 665.2349797732646, 665.3944910131756, 668.4685674888475, 670.3363669966698, 613.6502193749609, 654.1463390275736, 686.8866637004838, 692.6744430117836, 700.8177873752759, 9082.954585227031, 9537.475438850792, 9549.331546791658, 9671.854922176173, 9752.561134748954, 654.6137778710583, 742.8440027594265, 748.3115533709001, 796.3191471292077, 813.0162403734986, 4967.677100988424, 4982.77577509013, 5009.248612708123, 5062.772175252123, 5231.869203269873, 70346.29653703398, 80867.59566202131, 123943.0, 125311.3734431322, 126411.3679431597, 62606.68696656488, 63608.681956590844, 107372.0, 108013.4599327014, 110196.69409917555, 89168.0, 93548.0, 95641.0, 96635.51682241684, 97702.0, 10727.249092563447, 10841.457927103771, 10846.783064338826, 10998.945005274922, 11058.557657693602, 40769.388459172544, 43261.78369108134, 48115.03769924512, 48152.759236203594, 53007.20489192588, 74250.0, 78940.21059789328, 81186.18813811787, 81607.5919620398, 84658.0, 13821.308934553032, 13876.098053626481, 14054.437822486985, 14160.291985400483, 14315.856841431452, 15983.760243596123, 15984.600384990468, 16154.757678634594, 16467.0, 16615.41846035383, 15047.548573542812, 15278.388864445298, 15344.846551534789, 15377.0, 15454.150021748912, 15047.677882843147, 15202.239888005335, 15315.0, 15340.232988350315, 15412.845871541142, 14417.0, 14704.632384190481, 14717.116972981656, 15023.924880375529, 15613.0, 12437.191582547106, 12480.563180288646, 12666.0, 12837.229766214057, 12942.54701085495, 12380.81428778551, 12427.813582796085, 12662.0, 12795.296258705861, 13052.412641431349], "value": 8126.59297328521, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1519.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 105.0, 112.0, 111.0, 112.0, 111.0, 109.0, 111.0, 111.0, 109.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 125.0, 154.0, 167.0, 133.0, 154.0, 147.0, 127.0, 180.0, 127.0], "value": 147.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 160.0, 164.0, 163.0, 163.0, 162.0, 176.0, 162.0, 172.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 80.0, 75.0, 176.0, 76.0, 76.0, 75.0, 74.0, 168.0, 76.0], "value": 95.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 83.0, 148.0, 85.0, 83.0, 86.0, 137.0, 85.0, 84.0, 145.0], "value": 102.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 117.0, 118.0, 122.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 148.0, 149.0, 149.0, 149.0, 149.0, 150.0, 149.0, 146.0], "value": 149.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 95.0, 96.0, 96.0, 95.0, 97.0, 97.0, 95.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 52.0, 52.0, 52.0, 52.0, 53.0, 53.0, 54.0, 53.0], "value": 52.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 61.0, 62.0, 62.0, 61.0, 61.0, 60.0, 59.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 76.0, 78.0, 78.0, 79.0, 83.0, 109.0, 77.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 122.0, 121.0, 125.0, 119.0, 127.0, 135.0, 126.0, 122.0, 131.0], "value": 124.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 152.0, 154.0, 157.0, 150.0, 152.0, 150.0, 159.0, 153.0, 159.0], "value": 154.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 67.0, 63.0, 63.0, 62.0, 61.0, 62.0, 62.0, 61.0, 60.0], "value": 62.1, "unit": "score"}]}]} 14:04:54 INFO - Return code: 0 14:04:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:04:54 ERROR - # TBPL SUCCESS # 14:04:54 INFO - Running post-action listener: _resource_record_post_action 14:04:54 INFO - ##### 14:04:54 INFO - ##### Finished run-tests step (success) 14:04:54 INFO - ##### 14:04:54 INFO - Running post-run listener: _resource_record_post_run 14:04:54 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 421888; Write bytes: 329031680; Read time: 28; Write time: 232248 14:04:54 INFO - TinderboxPrint: CPU usage
13.4% 14:04:54 INFO - TinderboxPrint: I/O read bytes / time
421,888 / 28 14:04:54 INFO - TinderboxPrint: I/O write bytes / time
329,031,680 / 232,248 14:04:54 INFO - TinderboxPrint: CPU idle
8,211.3 (86.6%) 14:04:54 INFO - TinderboxPrint: CPU user
1,213.4 (12.8%) 14:04:54 INFO - TinderboxPrint: Swap in / out
0 / 0 14:04:54 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 81752064; Read time: 0; Write time: 80064 14:04:54 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 421888; Write bytes: 247279616; Read time: 28; Write time: 152184 14:04:55 INFO - Running post-run listener: _upload_blobber_files 14:04:55 INFO - Blob upload gear active. 14:04:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:04:55 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:55 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:55 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:55 INFO - (blobuploader) - INFO - Open directory for files ... 14:04:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:04:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:04:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:04:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:04:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:04:56 INFO - (blobuploader) - INFO - Done attempting. 14:04:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:04:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:04:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:04:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:04:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:04:57 INFO - (blobuploader) - INFO - Done attempting. 14:04:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:04:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:04:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:05:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:05:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:05:00 INFO - (blobuploader) - INFO - Done attempting. 14:05:00 INFO - (blobuploader) - INFO - Iteration through files over. 14:05:00 INFO - Return code: 0 14:05:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:05:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:05:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fee581325edcf1958b788ccdd9a718f3af18677d80a4d82c9fa1c869ccacf366247d2434c1bfb0b8af46851ff8ca86d41ac326bdf608a9cc958870d6bb4389a2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7280f844bc2bdc19787c14757632f3933e581545c557ade84a2597d0b95e82fa25e092961da721d1f10ef598954567d3484f37b61c781bcf6b2d101081a4aca0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/146d7bbbcda48ee342f2b3dbaa247d67ecf7bd5c2128abc0a9a8bf139dbfae83bb7cbafac1e8a4746ce568e521bc1294eb19479bf7f3dee5f0287cffe92f4fd5"} 14:05:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:05:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:05:00 INFO - Contents: 14:05:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fee581325edcf1958b788ccdd9a718f3af18677d80a4d82c9fa1c869ccacf366247d2434c1bfb0b8af46851ff8ca86d41ac326bdf608a9cc958870d6bb4389a2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7280f844bc2bdc19787c14757632f3933e581545c557ade84a2597d0b95e82fa25e092961da721d1f10ef598954567d3484f37b61c781bcf6b2d101081a4aca0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/146d7bbbcda48ee342f2b3dbaa247d67ecf7bd5c2128abc0a9a8bf139dbfae83bb7cbafac1e8a4746ce568e521bc1294eb19479bf7f3dee5f0287cffe92f4fd5"} 14:05:00 INFO - Running post-run listener: copy_logs_to_upload_dir 14:05:00 INFO - Copying logs to upload dir... 14:05:00 INFO - mkdir: /builds/slave/test/build/upload/logs 14:05:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.282545 ========= master_lag: 9.33 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-06-09 14:05:10.021151) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 14:05:10.027187) ========= 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=652eb03db935cfc1c15ebda0000001ad-1465505069.816311-585326722 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/fee581325edcf1958b788ccdd9a718f3af18677d80a4d82c9fa1c869ccacf366247d2434c1bfb0b8af46851ff8ca86d41ac326bdf608a9cc958870d6bb4389a2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7280f844bc2bdc19787c14757632f3933e581545c557ade84a2597d0b95e82fa25e092961da721d1f10ef598954567d3484f37b61c781bcf6b2d101081a4aca0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/146d7bbbcda48ee342f2b3dbaa247d67ecf7bd5c2128abc0a9a8bf139dbfae83bb7cbafac1e8a4746ce568e521bc1294eb19479bf7f3dee5f0287cffe92f4fd5"} 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.011277 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/fee581325edcf1958b788ccdd9a718f3af18677d80a4d82c9fa1c869ccacf366247d2434c1bfb0b8af46851ff8ca86d41ac326bdf608a9cc958870d6bb4389a2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7280f844bc2bdc19787c14757632f3933e581545c557ade84a2597d0b95e82fa25e092961da721d1f10ef598954567d3484f37b61c781bcf6b2d101081a4aca0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/146d7bbbcda48ee342f2b3dbaa247d67ecf7bd5c2128abc0a9a8bf139dbfae83bb7cbafac1e8a4746ce568e521bc1294eb19479bf7f3dee5f0287cffe92f4fd5"}' ========= master_lag: 0.19 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 14:05:10.228600) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:05:10.228921) ========= 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=652eb03db935cfc1c15ebda0000001ad-1465505069.816311-585326722 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004463 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:05:10.245306) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 14:05:10.245625) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 14:05:10.245911) ========= ========= Total master_lag: 9.63 =========