builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-046 starttime: 1468405081.13 results: success (0) buildid: 20160713004015 builduid: 755f4042e1df40d6868d3b6ea36891cc revision: bd3207c8ef3811b55e2073248c6ca39576fcf3a6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 03:18:01.130947) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 03:18:01.131403) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 03:18:01.131792) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 03:18:01.151325) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 03:18:01.151603) ========= 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-1468404999.960070-124126227 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-13 03:18:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-07-13 03:18:01 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.094362 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 03:18:01.259861) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 03:18:01.260171) ========= 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-1468404999.960070-124126227 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014826 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 03:18:01.321961) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 03:18:01.322283) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev bd3207c8ef3811b55e2073248c6ca39576fcf3a6 --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 bd3207c8ef3811b55e2073248c6ca39576fcf3a6 --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-1468404999.960070-124126227 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-13 03:18:01,424 truncating revision to first 12 chars 2016-07-13 03:18:01,424 Setting DEBUG logging. 2016-07-13 03:18:01,424 attempt 1/10 2016-07-13 03:18:01,424 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/bd3207c8ef38?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-13 03:18:01,733 unpacking tar archive at: mozilla-aurora-bd3207c8ef38/testing/mozharness/ program finished with exit code 0 elapsedTime=0.649634 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 03:18:01.985209) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 03:18:01.985510) ========= script_repo_revision: bd3207c8ef3811b55e2073248c6ca39576fcf3a6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 03:18:01.985882) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 03:18:01.986160) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 03:18:01.996449) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-13 03:18:01.996717) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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-1468404999.960070-124126227 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:18:02 INFO - MultiFileLogger online at 20160713 03:18:02 in /builds/slave/test 03:18:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:18:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:18:02 INFO - {'append_to_log': False, 03:18:02 INFO - 'base_work_dir': '/builds/slave/test', 03:18:02 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:18:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:18:02 INFO - 'branch': 'Mozilla-Aurora', 03:18:02 INFO - 'buildbot_json_path': 'buildprops.json', 03:18:02 INFO - 'config_files': ('talos/linux_config.py',), 03:18:02 INFO - 'default_actions': ('clobber', 03:18:02 INFO - 'read-buildbot-config', 03:18:02 INFO - 'download-and-extract', 03:18:02 INFO - 'populate-webroot', 03:18:02 INFO - 'create-virtualenv', 03:18:02 INFO - 'install', 03:18:02 INFO - 'run-tests'), 03:18:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:18:02 INFO - 'download_minidump_stackwalk': True, 03:18:02 INFO - 'download_symbols': 'ondemand', 03:18:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:18:02 INFO - 'tooltool.py': '/tools/tooltool.py', 03:18:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:18:02 INFO - '/tools/misc-python/virtualenv.py')}, 03:18:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:18:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:18:02 INFO - 'installer_path': 'installer.exe', 03:18:02 INFO - 'log_level': 'info', 03:18:02 INFO - 'log_name': 'talos', 03:18:02 INFO - 'log_to_console': True, 03:18:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:18:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:18:02 INFO - 'opt_config_files': (), 03:18:02 INFO - 'pip_index': False, 03:18:02 INFO - 'sps_profile': False, 03:18:02 INFO - 'sps_profile_interval': 0, 03:18:02 INFO - 'suite': 'dromaeojs', 03:18:02 INFO - 'system_bits': '32', 03:18:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:18:02 INFO - 'title': 'talos-linux64-ix-046', 03:18:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:18:02 INFO - 'use_talos_json': True, 03:18:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:18:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:18:02 INFO - 'work_dir': 'build'} 03:18:02 INFO - ##### 03:18:02 INFO - ##### Running clobber step. 03:18:02 INFO - ##### 03:18:02 INFO - Running pre-action listener: _resource_record_pre_action 03:18:02 INFO - Running main action method: clobber 03:18:02 INFO - rmtree: /builds/slave/test/build 03:18:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:18:03 INFO - Running post-action listener: _resource_record_post_action 03:18:03 INFO - ##### 03:18:03 INFO - ##### Finished clobber step (success) 03:18:03 INFO - ##### 03:18:03 INFO - ##### 03:18:03 INFO - ##### Running read-buildbot-config step. 03:18:03 INFO - ##### 03:18:03 INFO - Running pre-action listener: _resource_record_pre_action 03:18:03 INFO - Running main action method: read_buildbot_config 03:18:03 INFO - Using buildbot properties: 03:18:03 INFO - { 03:18:03 INFO - "project": "", 03:18:03 INFO - "product": "firefox", 03:18:03 INFO - "script_repo_revision": "production", 03:18:03 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:18:03 INFO - "repository": "", 03:18:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:18:03 INFO - "buildid": "20160713004015", 03:18:03 INFO - "stage_platform": "linux64-pgo", 03:18:03 INFO - "basedir": "/builds/slave/test", 03:18:03 INFO - "nightly_build": "True", 03:18:03 INFO - "buildnumber": 604, 03:18:03 INFO - "slavename": "talos-linux64-ix-046", 03:18:03 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:18:03 INFO - "platform": "ubuntu64_hw", 03:18:03 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:18:03 INFO - "branch": "mozilla-aurora", 03:18:03 INFO - "repo_path": "releases/mozilla-aurora", 03:18:03 INFO - "revision": "bd3207c8ef3811b55e2073248c6ca39576fcf3a6", 03:18:03 INFO - "pgo_build": "True", 03:18:03 INFO - "builduid": "755f4042e1df40d6868d3b6ea36891cc", 03:18:03 INFO - "slavebuilddir": "test" 03:18:03 INFO - } 03:18:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/SRIHvpyuS0Grvc32KuQmsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 03:18:03 INFO - Running post-action listener: _resource_record_post_action 03:18:03 INFO - ##### 03:18:03 INFO - ##### Finished read-buildbot-config step (success) 03:18:03 INFO - ##### 03:18:03 INFO - ##### 03:18:03 INFO - ##### Running download-and-extract step. 03:18:03 INFO - ##### 03:18:03 INFO - Running pre-action listener: _resource_record_pre_action 03:18:03 INFO - Running main action method: download_and_extract 03:18:03 INFO - mkdir: /builds/slave/test/build/tests 03:18:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:03 INFO - https://queue.taskcluster.net/v1/task/SRIHvpyuS0Grvc32KuQmsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:18:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRIHvpyuS0Grvc32KuQmsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:18:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRIHvpyuS0Grvc32KuQmsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:18:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRIHvpyuS0Grvc32KuQmsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:18:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRIHvpyuS0Grvc32KuQmsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:18:08 INFO - Downloaded 1361 bytes. 03:18:08 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:18:08 INFO - Using the following test package requirements: 03:18:08 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:18:08 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:18:08 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:18:08 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:18:08 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:18:08 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:18:08 INFO - u'jsshell-linux-x86_64.zip'], 03:18:08 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:18:08 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:18:08 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:18:08 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:18:08 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:18:08 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:18:08 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:18:08 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:18:08 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:18:08 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:18:08 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:18:08 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:18:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:08 INFO - https://queue.taskcluster.net/v1/task/SRIHvpyuS0Grvc32KuQmsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:18:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRIHvpyuS0Grvc32KuQmsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:18:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRIHvpyuS0Grvc32KuQmsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:18:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRIHvpyuS0Grvc32KuQmsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:18:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRIHvpyuS0Grvc32KuQmsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:18:09 INFO - Downloaded 24528017 bytes. 03:18:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:18:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:18:11 INFO - Return code: 0 03:18:11 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:18:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:11 INFO - https://queue.taskcluster.net/v1/task/SRIHvpyuS0Grvc32KuQmsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:18:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRIHvpyuS0Grvc32KuQmsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:18:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRIHvpyuS0Grvc32KuQmsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:18:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRIHvpyuS0Grvc32KuQmsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:18:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRIHvpyuS0Grvc32KuQmsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:18:13 INFO - Downloaded 24528017 bytes. 03:18:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:18:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:18:14 INFO - Return code: 0 03:18:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:14 INFO - https://queue.taskcluster.net/v1/task/SRIHvpyuS0Grvc32KuQmsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:18:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRIHvpyuS0Grvc32KuQmsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:18:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRIHvpyuS0Grvc32KuQmsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:18:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRIHvpyuS0Grvc32KuQmsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:18:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRIHvpyuS0Grvc32KuQmsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:18:15 INFO - Downloaded 10833369 bytes. 03:18:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:18:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:18:15 INFO - Return code: 0 03:18:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:15 INFO - https://queue.taskcluster.net/v1/task/SRIHvpyuS0Grvc32KuQmsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:18:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRIHvpyuS0Grvc32KuQmsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:18:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRIHvpyuS0Grvc32KuQmsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:18:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRIHvpyuS0Grvc32KuQmsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:18:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRIHvpyuS0Grvc32KuQmsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:18:17 INFO - Downloaded 63599904 bytes. 03:18:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SRIHvpyuS0Grvc32KuQmsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:18:17 INFO - mkdir: /builds/slave/test/properties 03:18:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:18:17 INFO - Writing to file /builds/slave/test/properties/build_url 03:18:17 INFO - Contents: 03:18:17 INFO - build_url:https://queue.taskcluster.net/v1/task/SRIHvpyuS0Grvc32KuQmsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:18:17 INFO - Running post-action listener: _resource_record_post_action 03:18:17 INFO - Running post-action listener: set_extra_try_arguments 03:18:17 INFO - ##### 03:18:17 INFO - ##### Finished download-and-extract step (success) 03:18:17 INFO - ##### 03:18:17 INFO - ##### 03:18:17 INFO - ##### Running populate-webroot step. 03:18:17 INFO - ##### 03:18:17 INFO - Running pre-action listener: _resource_record_pre_action 03:18:17 INFO - Running main action method: populate_webroot 03:18:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:18:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:18:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:18:17 INFO - '--tppagecycles', 03:18:17 INFO - '7'], 03:18:17 INFO - 'tests': ['tsvgm']}}, 03:18:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:18:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:18:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:18:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:18:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:18:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:18:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:17 INFO - 'talos_options': ['--disable-e10s'], 03:18:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:18:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:18:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:17 INFO - 'talos_options': ['--disable-e10s'], 03:18:17 INFO - 'tests': ['damp', 'tps']}, 03:18:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:17 INFO - 'tests': ['damp', 'tps']}, 03:18:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:18:17 INFO - 'tests': ['dromaeo_dom']}, 03:18:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:18:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:18:17 INFO - 'tests': ['a11yr', 03:18:17 INFO - 'ts_paint', 03:18:17 INFO - 'tpaint', 03:18:17 INFO - 'sessionrestore', 03:18:17 INFO - 'sessionrestore_no_auto_restore', 03:18:17 INFO - 'tabpaint']}, 03:18:17 INFO - 'other-e10s': {'tests': ['a11yr', 03:18:17 INFO - 'ts_paint', 03:18:17 INFO - 'tpaint', 03:18:17 INFO - 'sessionrestore', 03:18:17 INFO - 'sessionrestore_no_auto_restore', 03:18:17 INFO - 'tabpaint']}, 03:18:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:18:17 INFO - 'ts_paint', 03:18:17 INFO - 'tpaint', 03:18:17 INFO - 'sessionrestore', 03:18:17 INFO - 'sessionrestore_no_auto_restore', 03:18:17 INFO - 'tabpaint']}, 03:18:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:18:17 INFO - 'ts_paint', 03:18:17 INFO - 'tpaint', 03:18:17 INFO - 'sessionrestore', 03:18:17 INFO - 'sessionrestore_no_auto_restore', 03:18:17 INFO - 'tabpaint']}, 03:18:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:18:17 INFO - 'tests': ['a11yr', 03:18:17 INFO - 'ts_paint', 03:18:17 INFO - 'tpaint', 03:18:17 INFO - 'sessionrestore', 03:18:17 INFO - 'sessionrestore_no_auto_restore', 03:18:17 INFO - 'tabpaint']}, 03:18:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:18:17 INFO - 'tests': ['a11yr', 03:18:17 INFO - 'ts_paint', 03:18:17 INFO - 'tpaint', 03:18:17 INFO - 'sessionrestore', 03:18:17 INFO - 'sessionrestore_no_auto_restore', 03:18:17 INFO - 'tabpaint']}, 03:18:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:18:17 INFO - 'tests': ['tsvgx', 03:18:17 INFO - 'tsvgr_opacity', 03:18:17 INFO - 'tart', 03:18:17 INFO - 'tscrollx', 03:18:17 INFO - 'cart']}, 03:18:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:18:17 INFO - 'tsvgr_opacity', 03:18:17 INFO - 'tart', 03:18:17 INFO - 'tscrollx', 03:18:17 INFO - 'cart']}, 03:18:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:17 INFO - 'talos_options': ['--disable-e10s'], 03:18:17 INFO - 'tests': ['tp5o']}, 03:18:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:17 INFO - 'tests': ['tp5o']}, 03:18:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:17 INFO - 'talos_options': ['--disable-e10s', 03:18:17 INFO - '--xperf_path', 03:18:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:18:17 INFO - 'tests': ['tp5n']}, 03:18:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:17 INFO - 'talos_options': ['--xperf_path', 03:18:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:18:17 INFO - 'tests': ['tp5n']}}, 03:18:17 INFO - 'talos.zip': {'path': '', 03:18:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:18:17 INFO - Running post-action listener: _resource_record_post_action 03:18:17 INFO - ##### 03:18:17 INFO - ##### Finished populate-webroot step (success) 03:18:17 INFO - ##### 03:18:17 INFO - ##### 03:18:17 INFO - ##### Running create-virtualenv step. 03:18:17 INFO - ##### 03:18:17 INFO - Running pre-action listener: _resource_record_pre_action 03:18:17 INFO - Running main action method: create_virtualenv 03:18:17 INFO - Creating virtualenv /builds/slave/test/build/venv 03:18:17 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:18:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:18:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:18:17 INFO - Using real prefix '/usr' 03:18:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:18:18 INFO - Installing distribute.............................................................................................................................................................................................done. 03:18:20 INFO - Installing pip.................done. 03:18:20 INFO - Return code: 0 03:18:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:18:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:20 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 0x7fcf328ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24471c0>, '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 0x24480c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2448550>, '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-1468404999.960070-124126227', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:18:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:18:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:18:20 INFO - Using env: {'DISPLAY': ':0', 03:18:20 INFO - 'HOME': '/home/cltbld', 03:18:20 INFO - 'LANG': 'en_US.UTF-8', 03:18:20 INFO - 'LANGUAGE': 'en_US:en', 03:18:20 INFO - 'LOGNAME': 'cltbld', 03:18:20 INFO - 'MAIL': '/var/mail/cltbld', 03:18:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:20 INFO - 'MOZ_NO_REMOTE': '1', 03:18:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:20 INFO - 'NO_EM_RESTART': '1', 03:18:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:20 INFO - 'PWD': '/builds/slave/test', 03:18:20 INFO - 'SHELL': '/bin/bash', 03:18:20 INFO - 'SHLVL': '1', 03:18:20 INFO - 'TERM': 'linux', 03:18:20 INFO - 'TMOUT': '86400', 03:18:20 INFO - 'USER': 'cltbld', 03:18:20 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1468404999.960070-124126227', 03:18:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:20 INFO - '_': '/tools/buildbot/bin/python'} 03:18:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:20 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:18:20 INFO - Cleaning up... 03:18:20 INFO - Return code: 0 03:18:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:18:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:20 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 0x7fcf328ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24471c0>, '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 0x24480c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2448550>, '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-1468404999.960070-124126227', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:18:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:18:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:18:20 INFO - Using env: {'DISPLAY': ':0', 03:18:20 INFO - 'HOME': '/home/cltbld', 03:18:20 INFO - 'LANG': 'en_US.UTF-8', 03:18:20 INFO - 'LANGUAGE': 'en_US:en', 03:18:20 INFO - 'LOGNAME': 'cltbld', 03:18:20 INFO - 'MAIL': '/var/mail/cltbld', 03:18:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:20 INFO - 'MOZ_NO_REMOTE': '1', 03:18:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:20 INFO - 'NO_EM_RESTART': '1', 03:18:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:20 INFO - 'PWD': '/builds/slave/test', 03:18:20 INFO - 'SHELL': '/bin/bash', 03:18:20 INFO - 'SHLVL': '1', 03:18:20 INFO - 'TERM': 'linux', 03:18:20 INFO - 'TMOUT': '86400', 03:18:20 INFO - 'USER': 'cltbld', 03:18:20 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1468404999.960070-124126227', 03:18:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:20 INFO - '_': '/tools/buildbot/bin/python'} 03:18:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:20 INFO - Downloading/unpacking psutil>=3.1.1 03:18:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:18:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:18:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:18:22 INFO - Installing collected packages: psutil 03:18:22 INFO - Running setup.py install for psutil 03:18:22 INFO - building 'psutil._psutil_linux' extension 03:18:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:18:23 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:18:23 INFO - building 'psutil._psutil_posix' extension 03:18:23 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:18:23 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:18:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:18:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:18:23 INFO - Successfully installed psutil 03:18:23 INFO - Cleaning up... 03:18:23 INFO - Return code: 0 03:18:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:18:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:23 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 0x7fcf328ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24471c0>, '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 0x24480c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2448550>, '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-1468404999.960070-124126227', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:18:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:18:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:18:23 INFO - Using env: {'DISPLAY': ':0', 03:18:23 INFO - 'HOME': '/home/cltbld', 03:18:23 INFO - 'LANG': 'en_US.UTF-8', 03:18:23 INFO - 'LANGUAGE': 'en_US:en', 03:18:23 INFO - 'LOGNAME': 'cltbld', 03:18:23 INFO - 'MAIL': '/var/mail/cltbld', 03:18:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:23 INFO - 'MOZ_NO_REMOTE': '1', 03:18:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:23 INFO - 'NO_EM_RESTART': '1', 03:18:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:23 INFO - 'PWD': '/builds/slave/test', 03:18:23 INFO - 'SHELL': '/bin/bash', 03:18:23 INFO - 'SHLVL': '1', 03:18:23 INFO - 'TERM': 'linux', 03:18:23 INFO - 'TMOUT': '86400', 03:18:23 INFO - 'USER': 'cltbld', 03:18:23 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1468404999.960070-124126227', 03:18:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:23 INFO - '_': '/tools/buildbot/bin/python'} 03:18:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:18:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:18:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:18:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:18:25 INFO - Installing collected packages: mozsystemmonitor 03:18:25 INFO - Running setup.py install for mozsystemmonitor 03:18:25 INFO - Successfully installed mozsystemmonitor 03:18:25 INFO - Cleaning up... 03:18:25 INFO - Return code: 0 03:18:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:18:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:25 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 0x7fcf328ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24471c0>, '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 0x24480c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2448550>, '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-1468404999.960070-124126227', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:18:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:18:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:18:25 INFO - Using env: {'DISPLAY': ':0', 03:18:25 INFO - 'HOME': '/home/cltbld', 03:18:25 INFO - 'LANG': 'en_US.UTF-8', 03:18:25 INFO - 'LANGUAGE': 'en_US:en', 03:18:25 INFO - 'LOGNAME': 'cltbld', 03:18:25 INFO - 'MAIL': '/var/mail/cltbld', 03:18:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:25 INFO - 'MOZ_NO_REMOTE': '1', 03:18:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:25 INFO - 'NO_EM_RESTART': '1', 03:18:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:25 INFO - 'PWD': '/builds/slave/test', 03:18:25 INFO - 'SHELL': '/bin/bash', 03:18:25 INFO - 'SHLVL': '1', 03:18:25 INFO - 'TERM': 'linux', 03:18:25 INFO - 'TMOUT': '86400', 03:18:25 INFO - 'USER': 'cltbld', 03:18:25 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1468404999.960070-124126227', 03:18:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:25 INFO - '_': '/tools/buildbot/bin/python'} 03:18:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:25 INFO - Downloading/unpacking jsonschema==2.5.1 03:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:18:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:28 INFO - Downloading functools32-3.2.3-2.tar.gz 03:18:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:18:28 INFO - warning: no files found matching '*.txt' 03:18:28 INFO - no previously-included directories found matching 'build' 03:18:28 INFO - no previously-included directories found matching 'dist' 03:18:28 INFO - no previously-included directories found matching '.git*' 03:18:28 INFO - Installing collected packages: jsonschema, functools32 03:18:28 INFO - Running setup.py install for functools32 03:18:28 INFO - warning: no files found matching '*.txt' 03:18:28 INFO - no previously-included directories found matching 'build' 03:18:28 INFO - no previously-included directories found matching 'dist' 03:18:28 INFO - no previously-included directories found matching '.git*' 03:18:28 INFO - Successfully installed jsonschema functools32 03:18:28 INFO - Cleaning up... 03:18:28 INFO - Return code: 0 03:18:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:18:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:28 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 0x7fcf328ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24471c0>, '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 0x24480c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2448550>, '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-1468404999.960070-124126227', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:18:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:18:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:18:28 INFO - Using env: {'DISPLAY': ':0', 03:18:28 INFO - 'HOME': '/home/cltbld', 03:18:28 INFO - 'LANG': 'en_US.UTF-8', 03:18:28 INFO - 'LANGUAGE': 'en_US:en', 03:18:28 INFO - 'LOGNAME': 'cltbld', 03:18:28 INFO - 'MAIL': '/var/mail/cltbld', 03:18:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:28 INFO - 'MOZ_NO_REMOTE': '1', 03:18:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:28 INFO - 'NO_EM_RESTART': '1', 03:18:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:28 INFO - 'PWD': '/builds/slave/test', 03:18:28 INFO - 'SHELL': '/bin/bash', 03:18:28 INFO - 'SHLVL': '1', 03:18:28 INFO - 'TERM': 'linux', 03:18:28 INFO - 'TMOUT': '86400', 03:18:28 INFO - 'USER': 'cltbld', 03:18:28 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1468404999.960070-124126227', 03:18:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:28 INFO - '_': '/tools/buildbot/bin/python'} 03:18:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:28 INFO - Downloading/unpacking blobuploader==1.2.4 03:18:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:30 INFO - Downloading blobuploader-1.2.4.tar.gz 03:18:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:18:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:18:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:31 INFO - Downloading docopt-0.6.1.tar.gz 03:18:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:18:31 INFO - Installing collected packages: blobuploader, requests, docopt 03:18:31 INFO - Running setup.py install for blobuploader 03:18:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:18:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:18:31 INFO - Running setup.py install for requests 03:18:31 INFO - Running setup.py install for docopt 03:18:31 INFO - Successfully installed blobuploader requests docopt 03:18:31 INFO - Cleaning up... 03:18:31 INFO - Return code: 0 03:18:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:18:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:31 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 0x7fcf328ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24471c0>, '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 0x24480c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2448550>, '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-1468404999.960070-124126227', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:18:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:18:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:18:31 INFO - Using env: {'DISPLAY': ':0', 03:18:31 INFO - 'HOME': '/home/cltbld', 03:18:31 INFO - 'LANG': 'en_US.UTF-8', 03:18:31 INFO - 'LANGUAGE': 'en_US:en', 03:18:31 INFO - 'LOGNAME': 'cltbld', 03:18:31 INFO - 'MAIL': '/var/mail/cltbld', 03:18:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:31 INFO - 'MOZ_NO_REMOTE': '1', 03:18:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:31 INFO - 'NO_EM_RESTART': '1', 03:18:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:31 INFO - 'PWD': '/builds/slave/test', 03:18:31 INFO - 'SHELL': '/bin/bash', 03:18:31 INFO - 'SHLVL': '1', 03:18:31 INFO - 'TERM': 'linux', 03:18:31 INFO - 'TMOUT': '86400', 03:18:31 INFO - 'USER': 'cltbld', 03:18:31 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1468404999.960070-124126227', 03:18:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:31 INFO - '_': '/tools/buildbot/bin/python'} 03:18:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:18:32 INFO - Running setup.py (path:/tmp/pip-q2X3ug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:18:32 INFO - Running setup.py (path:/tmp/pip-djgkbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:18:32 INFO - Running setup.py (path:/tmp/pip-fY3PXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:18:32 INFO - Running setup.py (path:/tmp/pip-FB_m4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:18:32 INFO - Running setup.py (path:/tmp/pip-t89_jA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:18:32 INFO - Running setup.py (path:/tmp/pip-UHypKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:18:32 INFO - Running setup.py (path:/tmp/pip-prtkCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:18:32 INFO - Running setup.py (path:/tmp/pip-hqdJi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:18:32 INFO - Running setup.py (path:/tmp/pip-DdwUfG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:18:32 INFO - Running setup.py (path:/tmp/pip-mR9tpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:18:32 INFO - Running setup.py (path:/tmp/pip-L_3ahZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:18:32 INFO - Running setup.py (path:/tmp/pip-cYrKwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:18:32 INFO - Running setup.py (path:/tmp/pip-JvYeyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:18:33 INFO - Running setup.py (path:/tmp/pip-l2JPHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:18:33 INFO - Running setup.py (path:/tmp/pip-XB4uUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:18:33 INFO - Running setup.py (path:/tmp/pip-JotNg1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:18:33 INFO - Running setup.py (path:/tmp/pip-yhyQ7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:18:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:18:33 INFO - Running setup.py install for manifestparser 03:18:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:18:33 INFO - Running setup.py install for mozcrash 03:18:33 INFO - Running setup.py install for mozdebug 03:18:33 INFO - Running setup.py install for mozdevice 03:18:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:18:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:18:33 INFO - Running setup.py install for mozfile 03:18:33 INFO - Running setup.py install for mozhttpd 03:18:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:18:33 INFO - Running setup.py install for mozinfo 03:18:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:18:34 INFO - Running setup.py install for mozInstall 03:18:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:18:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:18:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:18:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:18:34 INFO - Running setup.py install for mozleak 03:18:34 INFO - Running setup.py install for mozlog 03:18:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:18:34 INFO - Running setup.py install for moznetwork 03:18:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:18:34 INFO - Running setup.py install for mozprocess 03:18:34 INFO - Running setup.py install for mozprofile 03:18:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:18:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:18:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:18:34 INFO - Running setup.py install for mozrunner 03:18:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:18:34 INFO - Running setup.py install for mozscreenshot 03:18:34 INFO - Running setup.py install for moztest 03:18:35 INFO - Running setup.py install for mozversion 03:18:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:18:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:18:35 INFO - Cleaning up... 03:18:35 INFO - Return code: 0 03:18:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:18:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:35 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 0x7fcf328ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24471c0>, '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 0x24480c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2448550>, '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-1468404999.960070-124126227', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:18:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:18:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:18:35 INFO - Using env: {'DISPLAY': ':0', 03:18:35 INFO - 'HOME': '/home/cltbld', 03:18:35 INFO - 'LANG': 'en_US.UTF-8', 03:18:35 INFO - 'LANGUAGE': 'en_US:en', 03:18:35 INFO - 'LOGNAME': 'cltbld', 03:18:35 INFO - 'MAIL': '/var/mail/cltbld', 03:18:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:35 INFO - 'MOZ_NO_REMOTE': '1', 03:18:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:35 INFO - 'NO_EM_RESTART': '1', 03:18:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:35 INFO - 'PWD': '/builds/slave/test', 03:18:35 INFO - 'SHELL': '/bin/bash', 03:18:35 INFO - 'SHLVL': '1', 03:18:35 INFO - 'TERM': 'linux', 03:18:35 INFO - 'TMOUT': '86400', 03:18:35 INFO - 'USER': 'cltbld', 03:18:35 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1468404999.960070-124126227', 03:18:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:35 INFO - '_': '/tools/buildbot/bin/python'} 03:18:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:18:35 INFO - Running setup.py (path:/tmp/pip-tujDf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:18:35 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:18:35 INFO - Running setup.py (path:/tmp/pip-UeNwP8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:18:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:18:35 INFO - Running setup.py (path:/tmp/pip-tPefU0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:18:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:18:35 INFO - Running setup.py (path:/tmp/pip-2ELZwI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:18:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:18:35 INFO - Running setup.py (path:/tmp/pip-I93iQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:18:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:18:35 INFO - Running setup.py (path:/tmp/pip-hZNPRy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:18:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:18:35 INFO - Running setup.py (path:/tmp/pip-c2yGyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:18:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:18:35 INFO - Running setup.py (path:/tmp/pip-ItarH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:18:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:18:35 INFO - Running setup.py (path:/tmp/pip-SdW0Q1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:18:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:18:36 INFO - Running setup.py (path:/tmp/pip-6et5al-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:18:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:18:36 INFO - Running setup.py (path:/tmp/pip-muqcpQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:18:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:18:36 INFO - Running setup.py (path:/tmp/pip-NSXj_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:18:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:18:36 INFO - Running setup.py (path:/tmp/pip-Z0Ewaq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:18:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:18:36 INFO - Running setup.py (path:/tmp/pip-3fZO0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:18:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:18:36 INFO - Running setup.py (path:/tmp/pip-FbzxaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:18:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:18:36 INFO - Running setup.py (path:/tmp/pip-SuW2fE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:18:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:18:36 INFO - Running setup.py (path:/tmp/pip-lRuUgS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:18:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:18:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:18:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:18:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:18:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:18:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:18:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:18:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:38 INFO - Downloading blessings-1.6.tar.gz 03:18:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:18:38 INFO - Installing collected packages: blessings 03:18:38 INFO - Running setup.py install for blessings 03:18:38 INFO - Successfully installed blessings 03:18:38 INFO - Cleaning up... 03:18:38 INFO - Return code: 0 03:18:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:18:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:18:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:18:38 INFO - Reading from file tmpfile_stdout 03:18:38 INFO - Current package versions: 03:18:38 INFO - argparse == 1.2.1 03:18:38 INFO - blessings == 1.6 03:18:38 INFO - blobuploader == 1.2.4 03:18:38 INFO - docopt == 0.6.1 03:18:38 INFO - functools32 == 3.2.3-2 03:18:38 INFO - jsonschema == 2.5.1 03:18:38 INFO - manifestparser == 1.1 03:18:38 INFO - mozInstall == 1.12 03:18:38 INFO - mozcrash == 0.17 03:18:38 INFO - mozdebug == 0.1 03:18:38 INFO - mozdevice == 0.48 03:18:38 INFO - mozfile == 1.2 03:18:38 INFO - mozhttpd == 0.7 03:18:38 INFO - mozinfo == 0.9 03:18:38 INFO - mozleak == 0.1 03:18:38 INFO - mozlog == 3.2 03:18:38 INFO - moznetwork == 0.27 03:18:38 INFO - mozprocess == 0.23 03:18:38 INFO - mozprofile == 0.28 03:18:38 INFO - mozrunner == 6.12 03:18:38 INFO - mozscreenshot == 0.1 03:18:38 INFO - mozsystemmonitor == 0.3 03:18:38 INFO - moztest == 0.7 03:18:38 INFO - mozversion == 1.4 03:18:38 INFO - psutil == 3.1.1 03:18:38 INFO - requests == 1.2.3 03:18:38 INFO - wsgiref == 0.1.2 03:18:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:18:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:38 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 0x7fcf328ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24471c0>, '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 0x24480c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2448550>, '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-1468404999.960070-124126227', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:18:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:18:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:18:38 INFO - Using env: {'DISPLAY': ':0', 03:18:38 INFO - 'HOME': '/home/cltbld', 03:18:38 INFO - 'LANG': 'en_US.UTF-8', 03:18:38 INFO - 'LANGUAGE': 'en_US:en', 03:18:38 INFO - 'LOGNAME': 'cltbld', 03:18:38 INFO - 'MAIL': '/var/mail/cltbld', 03:18:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:38 INFO - 'MOZ_NO_REMOTE': '1', 03:18:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:38 INFO - 'NO_EM_RESTART': '1', 03:18:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:38 INFO - 'PWD': '/builds/slave/test', 03:18:38 INFO - 'SHELL': '/bin/bash', 03:18:38 INFO - 'SHLVL': '1', 03:18:38 INFO - 'TERM': 'linux', 03:18:38 INFO - 'TMOUT': '86400', 03:18:38 INFO - 'USER': 'cltbld', 03:18:38 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1468404999.960070-124126227', 03:18:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:38 INFO - '_': '/tools/buildbot/bin/python'} 03:18:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:18:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:18:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:18:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:18:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:18:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:18:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:18:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:18:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:18:39 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:18:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:18:39 INFO - Cleaning up... 03:18:39 INFO - Return code: 0 03:18:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:18:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf328ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24471c0>, '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 0x24480c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2448550>, '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-1468404999.960070-124126227', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:18:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:18:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:18:39 INFO - Using env: {'DISPLAY': ':0', 03:18:39 INFO - 'HOME': '/home/cltbld', 03:18:39 INFO - 'LANG': 'en_US.UTF-8', 03:18:39 INFO - 'LANGUAGE': 'en_US:en', 03:18:39 INFO - 'LOGNAME': 'cltbld', 03:18:39 INFO - 'MAIL': '/var/mail/cltbld', 03:18:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:39 INFO - 'MOZ_NO_REMOTE': '1', 03:18:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:39 INFO - 'NO_EM_RESTART': '1', 03:18:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:39 INFO - 'PWD': '/builds/slave/test', 03:18:39 INFO - 'SHELL': '/bin/bash', 03:18:39 INFO - 'SHLVL': '1', 03:18:39 INFO - 'TERM': 'linux', 03:18:39 INFO - 'TMOUT': '86400', 03:18:39 INFO - 'USER': 'cltbld', 03:18:39 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1468404999.960070-124126227', 03:18:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:39 INFO - '_': '/tools/buildbot/bin/python'} 03:18:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:18:39 INFO - Cleaning up... 03:18:39 INFO - Return code: 0 03:18:39 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:18:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf328ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24471c0>, '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 0x24480c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2448550>, '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-1468404999.960070-124126227', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:18:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:18:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:18:39 INFO - Using env: {'DISPLAY': ':0', 03:18:39 INFO - 'HOME': '/home/cltbld', 03:18:39 INFO - 'LANG': 'en_US.UTF-8', 03:18:39 INFO - 'LANGUAGE': 'en_US:en', 03:18:39 INFO - 'LOGNAME': 'cltbld', 03:18:39 INFO - 'MAIL': '/var/mail/cltbld', 03:18:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:39 INFO - 'MOZ_NO_REMOTE': '1', 03:18:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:39 INFO - 'NO_EM_RESTART': '1', 03:18:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:39 INFO - 'PWD': '/builds/slave/test', 03:18:39 INFO - 'SHELL': '/bin/bash', 03:18:39 INFO - 'SHLVL': '1', 03:18:39 INFO - 'TERM': 'linux', 03:18:39 INFO - 'TMOUT': '86400', 03:18:39 INFO - 'USER': 'cltbld', 03:18:39 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1468404999.960070-124126227', 03:18:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:39 INFO - '_': '/tools/buildbot/bin/python'} 03:18:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:39 INFO - Downloading/unpacking flake8 03:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:41 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:18:41 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:18:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:18:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:18:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:18:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:18:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:18:42 INFO - no previously-included directories found matching 'docs/_build' 03:18:42 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:18:42 INFO - Running setup.py install for pep8 03:18:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:18:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:18:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:18:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:18:42 INFO - no previously-included directories found matching 'docs/_build' 03:18:42 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:18:42 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:18:42 INFO - Cleaning up... 03:18:42 INFO - Return code: 0 03:18:42 INFO - Running post-action listener: _resource_record_post_action 03:18:42 INFO - Running post-action listener: _start_resource_monitoring 03:18:42 INFO - Starting resource monitoring. 03:18:42 INFO - ##### 03:18:42 INFO - ##### Finished create-virtualenv step (success) 03:18:42 INFO - ##### 03:18:42 INFO - ##### 03:18:42 INFO - ##### Running install step. 03:18:42 INFO - ##### 03:18:42 INFO - Running pre-action listener: _resource_record_pre_action 03:18:42 INFO - Running main action method: install 03:18:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:18:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:18:42 INFO - Reading from file tmpfile_stdout 03:18:42 INFO - Detecting whether we're running mozinstall >=1.0... 03:18:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:18:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:18:42 INFO - Reading from file tmpfile_stdout 03:18:42 INFO - Output received: 03:18:42 INFO - Usage: mozinstall [options] installer 03:18:42 INFO - Options: 03:18:42 INFO - -h, --help show this help message and exit 03:18:42 INFO - -d DEST, --destination=DEST 03:18:42 INFO - Directory to install application into. [default: 03:18:42 INFO - "/builds/slave/test"] 03:18:42 INFO - --app=APP Application being installed. [default: firefox] 03:18:42 INFO - mkdir: /builds/slave/test/build/application 03:18:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:18:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:18:58 INFO - Reading from file tmpfile_stdout 03:18:58 INFO - Output received: 03:18:58 INFO - /builds/slave/test/build/application/firefox/firefox 03:18:58 INFO - Running post-action listener: _resource_record_post_action 03:18:58 INFO - ##### 03:18:58 INFO - ##### Finished install step (success) 03:18:58 INFO - ##### 03:18:58 INFO - ##### 03:18:58 INFO - ##### Running run-tests step. 03:18:58 INFO - ##### 03:18:58 INFO - Running pre-action listener: _resource_record_pre_action 03:18:58 INFO - Running main action method: run_tests 03:18:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:18:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:18:58 INFO - Python 2.7.3 03:18:58 INFO - Return code: 0 03:18:58 INFO - grabbing minidump binary from tooltool 03:18: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')]} 03:18:58 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 0x24471c0>, '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 0x24480c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2448550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:18:58 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:18:58 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:18:58 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:18:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:18:58 INFO - Return code: 0 03:18:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:18:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:18:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:18:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:18:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:18:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:18:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:18:59 INFO - Return code: 0 03:18:59 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SRIHvpyuS0Grvc32KuQmsA/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_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:18:59 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SRIHvpyuS0Grvc32KuQmsA/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_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:18:59 INFO - Using env: {'DISPLAY': ':0', 03:18:59 INFO - 'HOME': '/home/cltbld', 03:18:59 INFO - 'LANG': 'en_US.UTF-8', 03:18:59 INFO - 'LANGUAGE': 'en_US:en', 03:18:59 INFO - 'LOGNAME': 'cltbld', 03:18:59 INFO - 'MAIL': '/var/mail/cltbld', 03:18:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:18:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:18:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:59 INFO - 'MOZ_NO_REMOTE': '1', 03:18:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:18:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:59 INFO - 'NO_EM_RESTART': '1', 03:18:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:59 INFO - 'PWD': '/builds/slave/test', 03:18:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:18:59 INFO - 'SHELL': '/bin/bash', 03:18:59 INFO - 'SHLVL': '1', 03:18:59 INFO - 'TERM': 'linux', 03:18:59 INFO - 'TMOUT': '86400', 03:18:59 INFO - 'USER': 'cltbld', 03:18:59 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1468404999.960070-124126227', 03:18:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:59 INFO - '_': '/tools/buildbot/bin/python'} 03:18:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SRIHvpyuS0Grvc32KuQmsA/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_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:18:59 INFO - mozversion application_buildid: 20160713004015 03:18:59 INFO - mozversion application_changeset: bd3207c8ef3811b55e2073248c6ca39576fcf3a6 03:18:59 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:18:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:18:59 INFO - mozversion application_name: Firefox 03:18:59 INFO - mozversion application_remotingname: firefox-dev 03:18:59 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:18:59 INFO - mozversion application_vendor: Mozilla 03:18:59 INFO - mozversion application_version: 49.0a2 03:18:59 INFO - mozversion platform_buildid: 20160713004015 03:18:59 INFO - mozversion platform_changeset: bd3207c8ef3811b55e2073248c6ca39576fcf3a6 03:18:59 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:18:59 INFO - mozversion platform_version: 49.0a2 03:18:59 INFO - using testdate: 1468405139 03:18:59 INFO - actual date: 1468405139 03:18:59 INFO - starting webserver on 'localhost:36067' 03:18:59 INFO - SUITE-START | Running 2 tests 03:18:59 INFO - TEST-START | dromaeo_css 03:18:59 INFO - operating with platform_type : linux_ 03:18:59 INFO - Initialising browser for dromaeo_css test... 03:18:59 INFO - TEST-INFO | started process 4892 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVeYGRk/profile http://localhost:36067/getInfo.html) 03:19:03 INFO - PROCESS | 4892 | __metrics Screen width/height:1600/1200 03:19:03 INFO - PROCESS | 4892 | colorDepth:24 03:19:03 INFO - PROCESS | 4892 | Browser inner width/height: 1024/697 03:19:03 INFO - PROCESS | 4892 | __metrics 03:19:04 ERROR - PROCESS | 4892 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:19:05 INFO - TEST-INFO | 4892: exit 0 03:19:05 INFO - Browser initialized. 03:19:05 INFO - Running cycle 1/1 for dromaeo_css test... 03:19:05 INFO - TEST-INFO | started process 4982 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVeYGRk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:19:17 INFO - PROCESS | 4982 | RSS: Main: 144539648 03:19:17 INFO - PROCESS | 4982 | 03:20:08 INFO - PROCESS | 4982 | 1468405208820 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:22:16 INFO - PROCESS | 4982 | Cycle 1(1): loaded http://localhost:36067/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36067/tests/dromaeo/cssquery-ext.html) 03:22:17 INFO - PROCESS | 4982 | RSS: Main: 252080128 03:22:17 INFO - PROCESS | 4982 | 03:25:20 INFO - PROCESS | 4982 | Cycle 1(1): loaded http://localhost:36067/tests/dromaeo/cssquery-ext.html (next: http://localhost:36067/tests/dromaeo/cssquery-jquery.html) 03:25:20 INFO - PROCESS | 4982 | RSS: Main: 228925440 03:25:20 INFO - PROCESS | 4982 | 03:28:22 INFO - PROCESS | 4982 | Cycle 1(1): loaded http://localhost:36067/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36067/tests/dromaeo/cssquery-mootools.html) 03:28:23 INFO - PROCESS | 4982 | RSS: Main: 227205120 03:28:23 INFO - PROCESS | 4982 | 03:31:25 INFO - PROCESS | 4982 | Cycle 1(1): loaded http://localhost:36067/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36067/tests/dromaeo/cssquery-prototype.html) 03:31:25 INFO - PROCESS | 4982 | RSS: Main: 224346112 03:31:25 INFO - PROCESS | 4982 | 03:34:28 INFO - PROCESS | 4982 | Cycle 1(1): loaded http://localhost:36067/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36067/tests/dromaeo/cssquery-yui.html) 03:34:29 INFO - PROCESS | 4982 | RSS: Main: 206491648 03:34:29 INFO - PROCESS | 4982 | 03:37:31 INFO - PROCESS | 4982 | Cycle 1(1): loaded http://localhost:36067/tests/dromaeo/cssquery-yui.html (next: http://localhost:36067/tests/dromaeo/cssquery-dojo.html) 03:37:32 INFO - PROCESS | 4982 | RSS: Main: 259616768 03:37:32 INFO - PROCESS | 4982 | 03:37:32 INFO - PROCESS | 4982 | __start_tp_report 03:37:32 INFO - PROCESS | 4982 | _x_x_mozilla_page_load 03:37:32 INFO - PROCESS | 4982 | _x_x_mozilla_page_load_details 03:37:32 INFO - PROCESS | 4982 | |i|pagename|runs| 03:37:32 INFO - PROCESS | 4982 | |0;dojo.html;3274.6725327467257;3314.337132573485;3316.137804170915;3321.4851697986805;3366.309906469174;5386.919196212055;5450.754716037778;5475.9726201368985;5499.670019798815;5503.697296648687;5342.305500284958;5446.2375267462485;5448.128299472085;5460.208269800876;5487.478689524499;4814.2056560667625;4817.78319975602;4841.419029716439;4843;4878.536539028786;4838.927416088762;4916.877078073041;4924.138275801721;4924.507549245082;4927.236278376839;4847.975760121194;4859.805607775685;4895.6083513318845;4899.191633380488;4901;4946.0602485528;4969.7515124244;4969.975150124263;4971.850844474671;4989.3513843200335;4719.10337035962;4736.005438857844;4800.015996720664;4878.121938051149;4905.264210368473;5228.947710522884;5243.501867322599;5244.475552444725;5283.55089817366;5293.444188360244;5704.657720536739;5802;5803.158542011384;5809.331926828427;5813.941860581424;5754.3094828620415;5795.159701843209;5801.651900885918;5820.44705752957;5876.353601103875;5420.268263784417;5492.231087647732;5504.944950550484;5508.118701007819;5515.531179849758;5701;5972.163897054415;5979.133025711334;5983.940160598426;5990.400959903975;5536.944630553723;5540.584456165804;5592.748326325325;5632.211490391349;5632.493075623213;5679.261695979496;5693.231413759172;5706.887157004344;5710.971445142748;5714.914276285859;5518.896220755784;5587.022271102622;5646.20953066571;5652.0391533439415;5654.264945557134;5615.606907516516;5678.318601767732;5679.375268720438;5681.886362272814;5710.172025056427;4406.9779651101535;4409.911801763947;4410.007748256617;4424.380586717862;4437.29003359461;3956.4658771065538;3963.128111815396;3963.4451176835264;3988.0827409695353;4029.6977726670616;5519.089350257163;5535.7785688572;5538.280023596987;5543.113101903676;5572.4706152915405;5742.397048309867;5743.569232307594;5795.217645617872;5801.796937107181;5833.4749872511675;5372.516473517402;5408.945910540844;5438.320209973754;5510.752016159283;5511.173324001432;4989.600831933437;4990.8752281193265;4992.400911890596;4994.051130285234;5013.924791128136;5970.76116955317;6018.15745795589;6028.022481763488;6032.215811944419;6067.302260240129;5650.067738823048;5714.628549144292;5744.224529688438;5744.511716504144;5763.049096898964;6040.607360521552;6075.210222671025;6079.939200607937;6088.573799833969;6090.786822461193;5696.11710184922;5706.885862282814;5710.543156547549;5712.34308054579;5713.628614140068;5613.522850557748;5624.212610234488;5645.774169033357;5668.744906479136;5704.458076482728;5558.138488534122;5562;5569.387367389665;5573.136163894603;5580.804671836466;5360.16917377807;5476.151196564539;5484.478974497416;5486.725663716718;5516.889662206653;5464.535514481314;5511.917321240105;5517.586181036358;5551.417101204315;5556.249906262603;5653.812699333022;5668.489835914787;5711.286089238845;5733.942660573341;5771.59598828078;5360.597955153301;5445.7821687133655;5626.240457538343;5628.802991895264;5655.066913959151 03:37:32 INFO - PROCESS | 4982 | |1;ext.html;598.8712426828233;636.4272155060446;649.7823229218209;661.735305877649;673.8955461903407;33419.16452088699;47137.292940605876;47476.52523474764;47882;47891;49720;50062.49937500624;50161;50237.246441303316;50288.74855625717;8269.214424629681;9086.182243598058;9229.907700923006;9235.584398702074;10653.733656658567;10588.52351644174;11023.283486573388;11025.393603351813;11030.448477576128;11033.83449248262;11094.944525277362;11129.443527823616;11145.331280123219;11147.72130696735;11150.442477876115;8381.748547543584;8547.230749232598;11009.119270458345;11051.944740276287;11293.887061129366;10654;11023.228374013823;11024.614138505114;11030.558777648885;11039.779204415867;45298.54701453009;45532;45662.77168614136;45712.54287457116;45742;3544.2025544252597;3760.849566017356;3820.4842346283453;3864.9806750966345;4057.898552536181;34886.651133488594;35328.47007294893;35385;35465.82267088648;35579.822100889585;4815.398075240595;4830.420349558076;4833.564979151894;4838.685485443435;4849.248366503198;372332;372990;374034;376329;379678;70006;70683.64658176676;70852.2914770856;71070;71486;40017.59982400139;41128;41147.7942610285;75837.24162758412;76142.3350182752;13387.732245355233;13389.263590502422;13394.93302533481;13409.932950335186;13498.662533436742;10983.835242471368;11486.368249746178;11607.477663505162;11623.418829058513;11972.521099155936;22600.773992259867;22659.773402265768;22689.773102269097;22736.09055637756;22844.771552284597;8108.108108108104;8161.510309381456;8163.918360816316;8243.546604936786;8412.453190542717;1077.4074259157433;1143.4454289669504;1150.4592841364545;1186.424584076722;1240.6712221261373;34917;35341.82329088338;35383.29233415317;35391.82304088463;35508.82245588807;1157.3518829455531;1170.5551890281638;1190.749712801555;1205.457544105156;1220.4812954494305;17692.203850826743;18096.18567164481;18455.16951737175;18502.44492665222;18543;608628;611263;615348;617883;618137;65925.34074659288;66500.33499665039;66506.33493665098;66506.66746666236;66717.33282667112;1333.6799168199757;1402.8667276608705;1439.9208043557496;1443.1196969848595;1471.830739464954;34574.82712586421;35797.46303805393;36222.4566631506;36908.81545592362;36952.63047369492;55312.44687553073;62054.37945620486;63782;63892.68053659702;69427.65286173536;560989;561606;563598;566720;567291;43176;47911.41725435224;48282.275765864244;49329;49622.50377496179;52779.20831187612;52944.470555293956;53751.73124134354;54410.18384724311;54994.450055498935;44686.3297050551;45079.32381014222;45615.57883158843;45904.31143532783;46967.29549056835;36624.81687591545;36983.815080924425;37242.441363380116;38037.80981095077;38455;45208;46053.53946460626;46097;46268.768656156506;46589.76705116453;38914.610853892234;40199;40413.191736164525;40844.59155408408;41242.1751564973;30371.544426833174;30708.539371909887;30723.692763072082;31123.821332506508;31212.687873121886 03:37:32 INFO - PROCESS | 4982 | |2;jquery.html;412.12012353625;413.41295360587964;416.8162418730804;423.8834320561846;426.8932766808298;19115;20575.897120514375;20585.07367168477;20764.27325043624;21236;18428.907855460704;18848.905755471238;18910.62178756424;18942.24231030757;19083.332083377085;5661.943380566204;5851.76592936282;5857.589968702193;5892.469677729004;5912.88174236515;4252.87241382759;5204.219367094928;5747.798827041054;5801.970990145043;6564.835879103013;6518.120053792748;6520.967395163041;6639.203295604534;6668.566543174702;6670.199576050856;6339.049142628596;6587.110740050104;6650.3682150195655;6667.033280174348;6672.46620270382;3912.784796836173;5488.506034456878;5804.361520232771;5909.734061967221;5917.733701983421;24878.626820597707;24913.87543062273;25548.872255638787;26635.600465993026;27146;2384.6542251373626;2580.8967641294325;2581.8450892946485;2649.2582077018465;2667.7065522792477;15273.38906443741;16281.348746050144;16732.330706771714;17196;17444.738328925076;2061.6186005589016;2074.875507469557;2125.6598944169014;2131.7335333083365;2144.8069673729283;56863.715681421745;69301.65349173221;83484;99313.50343248309;105173.47413263038;18382.540436488925;18714.1578628962;18863.62272754537;19131.61736765257;20814.167433302802;35135.47296790499;35326.64673353285;35589;35960.46059309113;36009.0997725059;9185.816283674289;10011.349262298074;10143.08712215904;10232;10341.9482902585;7946.245106714853;8034.076081250731;8184.590770461453;8317.542535160503;8357.540335281496;9202.953985230031;9300.441973481613;9480.431174129575;9595.12894985485;9794.65718699842;3628.76413033152;3750.774953502799;3773.226583505803;3823.445600387928;3823.7323387362617;992.8907820139779;1022.3967858963248;1033.8914413986574;1037.8495118207968;1095.5921640691672;18802.81197188038;19522.511937201685;20267.797322026592;20306.18775249003;20425.69361459579;1005.4168582222294;1018.6231094495084;1052.55792567122;1054.7679510507676;1097.3964319624174;10791.136709063256;11328.433578321052;11379.089672826154;11437.313761174357;11551.133664975161;396033;540830;571019;571611;573472;81380.59309703532;104297.47851260695;104696.47651761693;108452;108653;1042.921780866438;1070.753726642861;1092.7705181911729;1094.7865166292497;1100.6918062942389;18278.908605456887;18543.35098271554;18544.629107417506;18677.252909883453;18933.715994260372;32270.515942260416;36861.631383686894;42145.78927105345;42554.361684574134;43535;56956.715216423654;62813.37186628258;64047;64892;65645;9279.164875161268;9294.25645948336;9317.627294908129;9471.715848524555;9527.571259293487;13254.668633284246;13622.86377136216;13734.381952811947;13866.930665346608;13880.514182003986;12355.69110772238;12363.661811311076;12377.504899804268;12594.622161335175;12804.807927880904;12207.69480762988;12272.938635306766;12321.336619556603;12401.379931003234;12472.269167302207;12316.568920087753;12346.938265308616;12588.496460141858;12730.618081457571;12736.554220602235;9135.497547634945;9166.404183728037;9221.49281789508;9249.491277979776;9288.489133097744;9546.761330966781;12408.875911240772;12708.110432269652;12788.104832661624;12802.679933001376 03:37:32 INFO - PROCESS | 4982 | |3;mootools.html;1417.461364681421;1569.8116226052875;1602.8236893941664;1842.9447116586507;1962.0876292523983;9381.953090234549;9842.852357214639;9861.60553577857;10089.344192627474;10100.494975251226;9765.658201962933;10027.047430494109;10029.498525073754;10038.799224015514;10053.698389048322;2198.714167158267;2265.682804407384;2401.2196036288187;2505.1357281737774;2541.644169816218;2474.344298760821;2494.6008638617823;2495.4510007798253;2498.025769949721;2499.5750722377147;2413.2036427978815;2416.214730212679;2417.7340492545804;2423.2851308863837;2432.6959130108735;2094.2251366994233;2340.899777104758;2417.9758202418016;2423.75762423758;2450.779429851313;2452.6198439241766;2456.1894574790276;2463.1502131764514;2479.2066538707622;2481.677381940336;9858.359206651545;9876.061774131445;9903.45530995795;9953.701388958343;9978.9501052495;5385;5469.972650136764;5471.699056551888;5473.124300112003;5481.835544933659;3497.318022985519;3555.253396786678;3587.982060089683;3595.49663047171;3618.149734812317;1196.0312147160741;1210.2133613151434;1218.4029825385585;1227.9447424865903;1244.2596654990266;13067.999999999905;13070.54253101137;13075.28085955272;13080.345982700826;13093.345332733325;4679.695819771704;4683.648726345537;4721.881952951204;4755.239161734106;4799.280107983761;11086.22396432242;11093.667189984313;11109.55561777536;11122.443877806078;11135.164862635334;5429.945700543023;5462.289902312674;5464.644798088191;5480.725963701879;5502.284702988586;4578.404807375086;5000.924986125211;5040;5200.8959820803375;5202.7918883245;4396.428464299621;4414.139242847614;4457.710248833815;4486.528914463999;4497.190505708938;1340.546799357174;1387.6045327081936;1411.541249094028;1418.6453386653336;1425.4084554909803;976.9755756106155;1071.6731396923858;1074.6507385099874;1090.6019302954364;1099.8845121262311;6459.870802584016;6758.155230596176;6823.931760682429;6891.793246202622;6986;491.4913064977802;500.7796569509404;501.4985014985015;506.4808571214535;509.5694138453001;4429.468463784302;4462.977685111554;4493.258612328995;4543.727376357429;4598.103369842848;12076.698082547831;12440.75118497643;12448.937755311166;12465.314407707481;12491.375431228402;10820.404877731642;11216.831747523795;11230.438478076063;12271.263724176399;12353.073519485895;8916.15296546827;9221.81556368869;9223.077692230858;9296.674616388394;9322.114399132071;6469.644169570719;6476.798161092748;6714.261431242657;6826.385625293748;6855.485838562028;10993.450327483433;11256;11342.319460832376;11362.204645674723;11377.772444550897;11470.483828227583;11670.358130302915;11677;11679.124065694938;11791.35147566892;8425.70510032146;8638.438501497383;8638.654453821777;9343.859842102238;9530.857037144588;8784.429012114193;8909.643614255358;9008.684696035607;9035.548222588975;9240.168384845396;8276.834463310579;8298.958505207434;8439.451435656663;8456.619452124545;8484.830303393774;8358.665653373797;8431.241188293083;8499.95750021246;8531.712420905884;8561.700340488052;7760.456768026184;7794.883076753967;7842.529448233125;7846.17615150401;7849.215078492105;5517.834464966058;5791.391903850204;5840;5852.824415267549;5881.147233651182;5681.17622944679;5693.946619875336;5791.449812267828;5851.473367396955;5908.793192238251 03:37:32 INFO - PROCESS | 4982 | |4;prototype.html;328.1566374417746;335.0651681807756;337.9273456206915;338.59030573006663;341.5713279833809;5341.332333458317;5360.490753378428;5377.462253774621;5429.67421954683;5432.592555558339;5295.258663787064;5317.787288508455;5332.680039197641;5375.354957405117;5384.91922621161;3918.921621567574;3969.7816620085882;4093.4269202311552;4125.2780763366445;4127.834886604533;4065.3292206785845;4077.734947228421;4078.796060196993;4080.7551546907134;4101.610347017044;3910.648041676249;4065.3698676705158;4076.1236334188143;4079.1433798902267;4117.279476091672;3968.7817170055637;4063.674906007512;4080.7347522411246;4080.8979775505554;4098.385242213677;3597.2805438912324;3605.7656252343513;3612.801295928723;3617.5116359291424;3618.3667858124986;5069.03688299222;5080.74596270185;5082.263071854597;5086.135356989321;5107;4583.931241031387;4717.716936983792;4755.310479980418;4769.928451073237;4802.015586804731;5456.290682211326;5462.453754624546;5484.890302193974;5508.283923089973;5520.530754885839;4046.2312160689376;4058.79706014701;4064.4919385076864;4071.42999980003;4093.406456063884;5651.378348381675;5695.373508914057;5703.230063941356;5707.71461426927;5710.2576665033275;4092.8362865485046;4100.65144462724;4124.340105583153;4126.463559737215;4127.7936103194725;4166.500019997619;4178.185253875526;4195.160967806451;4209.768462734579;4217.768022758716;4656.996237426841;4665.307323006918;4736;4754.144254034238;4789.928151077736;5529.834104976777;5540.63985840919;5554.638948468418;5571.832845014656;5573.7770489179975;1422.9683479477296;1440.3734375546671;1451.267110109388;1451.3396404635864;1451.8965586154598;935.4060171790826;955.2405837359316;976.2043934193609;990.881094268678;996.785691076422;5361.758720857571;5373.543248823816;5419.756110975016;5421.2681288025615;5433;5614.63504872182;5635.436456354331;5636.408177141423;5660;5688.488036076773;5227.555657769132;5419.241306217133;5483.4516548344845;5494.340679118532;5494.945050549523;3007.518796992471;3017.5775391445213;3061.494853349217;3065.049834551296;3067.6165479315086;5829.387914269026;6041.78853740117;6042.667653279024;6050.818475445743;6122.969385153046;5799.130130480377;5899.613590806157;5905.291365036223;5919.467247947706;5930.1994230779155;6023.759049637965;6100.755969761249;6116.8776624468155;6146.631202127886;6159.384061593805;5648.774049037993;5762.366139724543;5771;5795.652260864362;5799.391063938226;5699.316082070178;5702.429757024264;5705.857353566194;5742.655440673573;5779.450952159538;5675.269042941943;6006.969965150146;6074.969625151846;6094.811511755165;6112.572119951561;4129.421880936731;4150.526563070067;4154.231467178582;4154.771487568213;4160.625543701081;5742.741576628978;5747.712614369181;5765.221695071112;5775.104858746901;5796.42035796417;5385.461453854583;5656.547476201977;5679.432056794452;5680;5691.857703557444;5643.238162847963;5647.830565083054;5665.546756259571;5675.517581005661;5675.914861277167;5298.761555730079;5438.700871452108;5471.781128754965;5632.971835140798;5633.126865335879;5175.404828444626;5654.547636189177;5662.943370566241;5667.659940403424;5684.886302273849;5574;5574.498295153294;5584.888302234014;5589.944100558942;5590.916136258041 03:37:32 INFO - PROCESS | 4982 | |5;yui.html;793.3890904003918;794.2534018023061;848.7326492154967;887.618324120628;929.4144688846026;16065.598360041005;17238.482845514623;17264.74102888458;17307.567310817234;17310.826891731078;15604.375824966988;15750.369985200578;15750.84249157508;15814.76277855833;15826.604334891634;732.3628443254363;858.8110615664543;866.2377108144824;872.3413822563955;905.0090151284334;874.8031692869117;886.6586364249746;887.8313120507115;888.8044630181349;890.888638920135;920.894097178823;928.4568527411473;930.4091901642472;930.6975233049252;930.7486978515797;762.5119923249125;899.5142622983581;903.9141281578272;907.4328544659588;932.379967321737;686.6326515314283;690.4165979747106;690.8031211104811;691.1533371619776;691.3190507350256;13517.459301628021;13633.113847599974;13680;13695.246761428118;13799.586012419644;14931.92534037323;15162.090274583561;15390.769138462932;15411.61470963235;15555.844441555666;12393.814092788616;12406.689832754164;12471.688207794878;13582.59252222435;14092.647683807987;4816.301636262722;4880.219164933594;4885.071836351082;4922.286268491084;5020.3724534433195;78144.21855781427;78566;78636.60681696612;79015;79294.603526982;11765.11761617865;12033.699157521132;12221.816672749916;12363.75272494563;12641.178323408949;22099.779002210093;22382;22427.43931401728;22445.663315050286;22466;8999.865002024844;9157.404768690014;9161.450312981242;9340.439573625605;9415.952920235355;4931.112399768004;4976.402831660224;5018.247262910592;5044.344235249468;5143.434222235551;3734.141147536028;3871.8838434847;3878.7781848717564;3879.9224015520094;3880.262750077476;652.8204743695427;671.8421171024805;675.3078094952713;684.7021545627667;685.9691313890887;606.9620948178664;734.977950661481;745.9291367320096;755.5089192025227;774.2103054883987;10126.898731012596;10163.644272450429;10418.68743937683;10421.739456513647;10472.581096756045;593.551868339401;689.4174422612984;709.8970649255829;739.6449704141935;761.7143571160815;4656.301554766812;4761.76191190446;4780.633586374766;5026.411562339759;5178;115529;119388.40305798415;120279;123536.38231808784;125485;101341;101846.67761802899;102047;102836.48581757043;103244.48377758064;86220;87388.5630571843;88638.55680721684;89331;91163.54418227999;9106.453612783254;10667.519961601902;10885.401302928098;11338.376389298668;11354.489047992694;42112;45955.770221150015;47108.05783884371;48333;48377.274340884214;72769.63615181891;73190;73560;83388;84845;13978.231197284247;14680;14775.778363324775;14957.850421496081;15139.318730656927;12402.627921162379;12576.74846503083;15939.601509962344;16413.917930410273;17381.304747809947;12834.16577922432;14504.202268875313;14680.55958321252;14824.03643763152;15325.923370383076;14629;14796.48212312564;14983.475578354706;15184.924075379553;15440.536783896501;14846.257687115816;15015.474458393905;15263.618409539851;15343.309551070006;15606.687866242839;12349.876501234872;12631.11582189238;12731.490740370282;13110.672233194246;13390.397432115773;12688.429020694275;12783.552575659807;12850.935745321214;13007.089503735026;13246.933765331112 03:37:32 INFO - PROCESS | 4982 | __end_tp_report 03:37:32 INFO - PROCESS | 4982 | __start_cc_report 03:37:32 INFO - PROCESS | 4982 | _x_x_mozilla_cycle_collect,861 03:37:32 INFO - PROCESS | 4982 | __end_cc_report 03:37:32 INFO - PROCESS | 4982 | __startTimestamp1468406252138__endTimestamp 03:37:32 INFO - PROCESS | 4982 | 03:37:32 INFO - PROCESS | 4982 | ------- Summary: start ------- 03:37:32 INFO - PROCESS | 4982 | Number of tests: 6 03:37:32 INFO - PROCESS | 4982 | 03:37:32 INFO - PROCESS | 4982 | [#0] dojo.html Cycles:165 Average:5352.02 Median:5535.78 stddev:582.78 (10.5%) stddev-sans-first:561.32 03:37:32 INFO - PROCESS | 4982 | Values: 3274.7 3314.3 3316.1 3321.5 3366.3 5386.9 5450.8 5476.0 5499.7 5503.7 5342.3 5446.2 5448.1 5460.2 5487.5 4814.2 4817.8 4841.4 4843.0 4878.5 4838.9 4916.9 4924.1 4924.5 4927.2 4848.0 4859.8 4895.6 4899.2 4901.0 4946.1 4969.8 4970.0 4971.9 4989.4 4719.1 4736.0 4800.0 4878.1 4905.3 5228.9 5243.5 5244.5 5283.6 5293.4 5704.7 5802.0 5803.2 5809.3 5813.9 5754.3 5795.2 5801.7 5820.4 5876.4 5420.3 5492.2 5504.9 5508.1 5515.5 5701.0 5972.2 5979.1 5983.9 5990.4 5536.9 5540.6 5592.7 5632.2 5632.5 5679.3 5693.2 5706.9 5711.0 5714.9 5518.9 5587.0 5646.2 5652.0 5654.3 5615.6 5678.3 5679.4 5681.9 5710.2 4407.0 4409.9 4410.0 4424.4 4437.3 3956.5 3963.1 3963.4 3988.1 4029.7 5519.1 5535.8 5538.3 5543.1 5572.5 5742.4 5743.6 5795.2 5801.8 5833.5 5372.5 5408.9 5438.3 5510.8 5511.2 4989.6 4990.9 4992.4 4994.1 5013.9 5970.8 6018.2 6028.0 6032.2 6067.3 5650.1 5714.6 5744.2 5744.5 5763.0 6040.6 6075.2 6079.9 6088.6 6090.8 5696.1 5706.9 5710.5 5712.3 5713.6 5613.5 5624.2 5645.8 5668.7 5704.5 5558.1 5562.0 5569.4 5573.1 5580.8 5360.2 5476.2 5484.5 5486.7 5516.9 5464.5 5511.9 5517.6 5551.4 5556.2 5653.8 5668.5 5711.3 5733.9 5771.6 5360.6 5445.8 5626.2 5628.8 5655.1 03:37:32 INFO - PROCESS | 4982 | 03:37:32 INFO - PROCESS | 4982 | [#1] ext.html Cycles:180 Average:69357.19 Median:40108.30 stddev:140360.25 (350.0%) stddev-sans-first:140659.06 03:37:32 INFO - PROCESS | 4982 | Values: 598.9 636.4 649.8 661.7 673.9 33419.2 47137.3 47476.5 47882.0 47891.0 49720.0 50062.5 50161.0 50237.2 50288.7 8269.2 9086.2 9229.9 9235.6 10653.7 10588.5 11023.3 11025.4 11030.4 11033.8 11094.9 11129.4 11145.3 11147.7 11150.4 8381.7 8547.2 11009.1 11051.9 11293.9 10654.0 11023.2 11024.6 11030.6 11039.8 45298.5 45532.0 45662.8 45712.5 45742.0 3544.2 3760.8 3820.5 3865.0 4057.9 34886.7 35328.5 35385.0 35465.8 35579.8 4815.4 4830.4 4833.6 4838.7 4849.2 372332.0 372990.0 374034.0 376329.0 379678.0 70006.0 70683.6 70852.3 71070.0 71486.0 40017.6 41128.0 41147.8 75837.2 76142.3 13387.7 13389.3 13394.9 13409.9 13498.7 10983.8 11486.4 11607.5 11623.4 11972.5 22600.8 22659.8 22689.8 22736.1 22844.8 8108.1 8161.5 8163.9 8243.5 8412.5 1077.4 1143.4 1150.5 1186.4 1240.7 34917.0 35341.8 35383.3 35391.8 35508.8 1157.4 1170.6 1190.7 1205.5 1220.5 17692.2 18096.2 18455.2 18502.4 18543.0 608628.0 611263.0 615348.0 617883.0 618137.0 65925.3 66500.3 66506.3 66506.7 66717.3 1333.7 1402.9 1439.9 1443.1 1471.8 34574.8 35797.5 36222.5 36908.8 36952.6 55312.4 62054.4 63782.0 63892.7 69427.7 560989.0 561606.0 563598.0 566720.0 567291.0 43176.0 47911.4 48282.3 49329.0 49622.5 52779.2 52944.5 53751.7 54410.2 54994.5 44686.3 45079.3 45615.6 45904.3 46967.3 36624.8 36983.8 37242.4 38037.8 38455.0 45208.0 46053.5 46097.0 46268.8 46589.8 38914.6 40199.0 40413.2 40844.6 41242.2 30371.5 30708.5 30723.7 31123.8 31212.7 03:37:32 INFO - PROCESS | 4982 | 03:37:32 INFO - PROCESS | 4982 | [#2] jquery.html Cycles:180 Average:32077.60 Median:14064.88 stddev:88113.67 (626.5%) stddev-sans-first:88328.77 03:37:32 INFO - PROCESS | 4982 | Values: 412.1 413.4 416.8 423.9 426.9 19115.0 20575.9 20585.1 20764.3 21236.0 18428.9 18848.9 18910.6 18942.2 19083.3 5661.9 5851.8 5857.6 5892.5 5912.9 4252.9 5204.2 5747.8 5802.0 6564.8 6518.1 6521.0 6639.2 6668.6 6670.2 6339.0 6587.1 6650.4 6667.0 6672.5 3912.8 5488.5 5804.4 5909.7 5917.7 24878.6 24913.9 25548.9 26635.6 27146.0 2384.7 2580.9 2581.8 2649.3 2667.7 15273.4 16281.3 16732.3 17196.0 17444.7 2061.6 2074.9 2125.7 2131.7 2144.8 56863.7 69301.7 83484.0 99313.5 105173.5 18382.5 18714.2 18863.6 19131.6 20814.2 35135.5 35326.6 35589.0 35960.5 36009.1 9185.8 10011.3 10143.1 10232.0 10341.9 7946.2 8034.1 8184.6 8317.5 8357.5 9203.0 9300.4 9480.4 9595.1 9794.7 3628.8 3750.8 3773.2 3823.4 3823.7 992.9 1022.4 1033.9 1037.8 1095.6 18802.8 19522.5 20267.8 20306.2 20425.7 1005.4 1018.6 1052.6 1054.8 1097.4 10791.1 11328.4 11379.1 11437.3 11551.1 396033.0 540830.0 571019.0 571611.0 573472.0 81380.6 104297.5 104696.5 108452.0 108653.0 1042.9 1070.8 1092.8 1094.8 1100.7 18278.9 18543.4 18544.6 18677.3 18933.7 32270.5 36861.6 42145.8 42554.4 43535.0 56956.7 62813.4 64047.0 64892.0 65645.0 9279.2 9294.3 9317.6 9471.7 9527.6 13254.7 13622.9 13734.4 13866.9 13880.5 12355.7 12363.7 12377.5 12594.6 12804.8 12207.7 12272.9 12321.3 12401.4 12472.3 12316.6 12346.9 12588.5 12730.6 12736.6 9135.5 9166.4 9221.5 9249.5 9288.5 9546.8 12408.9 12708.1 12788.1 12802.7 03:37:32 INFO - PROCESS | 4982 | 03:37:32 INFO - PROCESS | 4982 | [#3] mootools.html Cycles:180 Average:6355.16 Median:4489.89 stddev:3697.39 (82.3%) stddev-sans-first:3689.14 03:37:32 INFO - PROCESS | 4982 | Values: 1417.5 1569.8 1602.8 1842.9 1962.1 9382.0 9842.9 9861.6 10089.3 10100.5 9765.7 10027.0 10029.5 10038.8 10053.7 2198.7 2265.7 2401.2 2505.1 2541.6 2474.3 2494.6 2495.5 2498.0 2499.6 2413.2 2416.2 2417.7 2423.3 2432.7 2094.2 2340.9 2418.0 2423.8 2450.8 2452.6 2456.2 2463.2 2479.2 2481.7 9858.4 9876.1 9903.5 9953.7 9979.0 5385.0 5470.0 5471.7 5473.1 5481.8 3497.3 3555.3 3588.0 3595.5 3618.1 1196.0 1210.2 1218.4 1227.9 1244.3 13068.0 13070.5 13075.3 13080.3 13093.3 4679.7 4683.6 4721.9 4755.2 4799.3 11086.2 11093.7 11109.6 11122.4 11135.2 5429.9 5462.3 5464.6 5480.7 5502.3 4578.4 5000.9 5040.0 5200.9 5202.8 4396.4 4414.1 4457.7 4486.5 4497.2 1340.5 1387.6 1411.5 1418.6 1425.4 977.0 1071.7 1074.7 1090.6 1099.9 6459.9 6758.2 6823.9 6891.8 6986.0 491.5 500.8 501.5 506.5 509.6 4429.5 4463.0 4493.3 4543.7 4598.1 12076.7 12440.8 12448.9 12465.3 12491.4 10820.4 11216.8 11230.4 12271.3 12353.1 8916.2 9221.8 9223.1 9296.7 9322.1 6469.6 6476.8 6714.3 6826.4 6855.5 10993.5 11256.0 11342.3 11362.2 11377.8 11470.5 11670.4 11677.0 11679.1 11791.4 8425.7 8638.4 8638.7 9343.9 9530.9 8784.4 8909.6 9008.7 9035.5 9240.2 8276.8 8299.0 8439.5 8456.6 8484.8 8358.7 8431.2 8500.0 8531.7 8561.7 7760.5 7794.9 7842.5 7846.2 7849.2 5517.8 5791.4 5840.0 5852.8 5881.1 5681.2 5693.9 5791.4 5851.5 5908.8 03:37:32 INFO - PROCESS | 4982 | 03:37:32 INFO - PROCESS | 4982 | [#4] prototype.html Cycles:180 Average:4717.17 Median:5420.51 stddev:1397.39 (25.8%) stddev-sans-first:1361.93 03:37:32 INFO - PROCESS | 4982 | Values: 328.2 335.1 337.9 338.6 341.6 5341.3 5360.5 5377.5 5429.7 5432.6 5295.3 5317.8 5332.7 5375.4 5384.9 3918.9 3969.8 4093.4 4125.3 4127.8 4065.3 4077.7 4078.8 4080.8 4101.6 3910.6 4065.4 4076.1 4079.1 4117.3 3968.8 4063.7 4080.7 4080.9 4098.4 3597.3 3605.8 3612.8 3617.5 3618.4 5069.0 5080.7 5082.3 5086.1 5107.0 4583.9 4717.7 4755.3 4769.9 4802.0 5456.3 5462.5 5484.9 5508.3 5520.5 4046.2 4058.8 4064.5 4071.4 4093.4 5651.4 5695.4 5703.2 5707.7 5710.3 4092.8 4100.7 4124.3 4126.5 4127.8 4166.5 4178.2 4195.2 4209.8 4217.8 4657.0 4665.3 4736.0 4754.1 4789.9 5529.8 5540.6 5554.6 5571.8 5573.8 1423.0 1440.4 1451.3 1451.3 1451.9 935.4 955.2 976.2 990.9 996.8 5361.8 5373.5 5419.8 5421.3 5433.0 5614.6 5635.4 5636.4 5660.0 5688.5 5227.6 5419.2 5483.5 5494.3 5494.9 3007.5 3017.6 3061.5 3065.0 3067.6 5829.4 6041.8 6042.7 6050.8 6123.0 5799.1 5899.6 5905.3 5919.5 5930.2 6023.8 6100.8 6116.9 6146.6 6159.4 5648.8 5762.4 5771.0 5795.7 5799.4 5699.3 5702.4 5705.9 5742.7 5779.5 5675.3 6007.0 6075.0 6094.8 6112.6 4129.4 4150.5 4154.2 4154.8 4160.6 5742.7 5747.7 5765.2 5775.1 5796.4 5385.5 5656.5 5679.4 5680.0 5691.9 5643.2 5647.8 5665.5 5675.5 5675.9 5298.8 5438.7 5471.8 5633.0 5633.1 5175.4 5654.5 5662.9 5667.7 5684.9 5574.0 5574.5 5584.9 5589.9 5590.9 03:37:32 INFO - PROCESS | 4982 | 03:37:32 INFO - PROCESS | 4982 | [#5] yui.html Cycles:180 Average:21658.91 Median:3875.33 stddev:30838.51 (795.8%) stddev-sans-first:30885.22 03:37:32 INFO - PROCESS | 4982 | Values: 793.4 794.3 848.7 887.6 929.4 16065.6 17238.5 17264.7 17307.6 17310.8 15604.4 15750.4 15750.8 15814.8 15826.6 732.4 858.8 866.2 872.3 905.0 874.8 886.7 887.8 888.8 890.9 920.9 928.5 930.4 930.7 930.7 762.5 899.5 903.9 907.4 932.4 686.6 690.4 690.8 691.2 691.3 13517.5 13633.1 13680.0 13695.2 13799.6 14931.9 15162.1 15390.8 15411.6 15555.8 12393.8 12406.7 12471.7 13582.6 14092.6 4816.3 4880.2 4885.1 4922.3 5020.4 78144.2 78566.0 78636.6 79015.0 79294.6 11765.1 12033.7 12221.8 12363.8 12641.2 22099.8 22382.0 22427.4 22445.7 22466.0 8999.9 9157.4 9161.5 9340.4 9416.0 4931.1 4976.4 5018.2 5044.3 5143.4 3734.1 3871.9 3878.8 3879.9 3880.3 652.8 671.8 675.3 684.7 686.0 607.0 735.0 745.9 755.5 774.2 10126.9 10163.6 10418.7 10421.7 10472.6 593.6 689.4 709.9 739.6 761.7 4656.3 4761.8 4780.6 5026.4 5178.0 115529.0 119388.4 120279.0 123536.4 125485.0 101341.0 101846.7 102047.0 102836.5 103244.5 86220.0 87388.6 88638.6 89331.0 91163.5 9106.5 10667.5 10885.4 11338.4 11354.5 42112.0 45955.8 47108.1 48333.0 48377.3 72769.6 73190.0 73560.0 83388.0 84845.0 13978.2 14680.0 14775.8 14957.9 15139.3 12402.6 12576.7 15939.6 16413.9 17381.3 12834.2 14504.2 14680.6 14824.0 15325.9 14629.0 14796.5 14983.5 15184.9 15440.5 14846.3 15015.5 15263.6 15343.3 15606.7 12349.9 12631.1 12731.5 13110.7 13390.4 12688.4 12783.6 12850.9 13007.1 13246.9 03:37:32 INFO - PROCESS | 4982 | -------- Summary: end -------- 03:37:32 INFO - PROCESS | 4982 | 03:37:32 INFO - TEST-INFO | 4982: exit 0 03:37:32 INFO - TEST-OK | dromaeo_css | took 1112948ms 03:37:32 INFO - TEST-START | kraken 03:37:32 INFO - operating with platform_type : linux_ 03:37:32 INFO - Initialising browser for kraken test... 03:37:32 INFO - TEST-INFO | started process 5176 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplslKSt/profile http://localhost:36067/getInfo.html) 03:37:36 INFO - PROCESS | 5176 | __metrics Screen width/height:1600/1200 03:37:36 INFO - PROCESS | 5176 | colorDepth:24 03:37:36 INFO - PROCESS | 5176 | Browser inner width/height: 1024/697 03:37:36 INFO - PROCESS | 5176 | __metrics 03:37:37 ERROR - PROCESS | 5176 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:37:38 INFO - TEST-INFO | 5176: exit 0 03:37:38 INFO - Browser initialized. 03:37:38 INFO - Running cycle 1/1 for kraken test... 03:37:38 INFO - TEST-INFO | started process 5265 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplslKSt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:37:50 INFO - PROCESS | 5265 | RSS: Main: 145444864 03:37:50 INFO - PROCESS | 5265 | 03:37:52 INFO - PROCESS | 5265 | Cycle 1(1): loaded http://localhost:36067/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36067/tests/kraken/driver.html?testName=audio-beat-detection) 03:37:53 INFO - PROCESS | 5265 | RSS: Main: 194854912 03:37:53 INFO - PROCESS | 5265 | 03:37:56 INFO - PROCESS | 5265 | Cycle 1(1): loaded http://localhost:36067/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36067/tests/kraken/driver.html?testName=audio-dft) 03:37:57 INFO - PROCESS | 5265 | RSS: Main: 189513728 03:37:57 INFO - PROCESS | 5265 | 03:37:59 INFO - PROCESS | 5265 | Cycle 1(1): loaded http://localhost:36067/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36067/tests/kraken/driver.html?testName=audio-fft) 03:38:00 INFO - PROCESS | 5265 | RSS: Main: 279670784 03:38:00 INFO - PROCESS | 5265 | 03:38:02 INFO - PROCESS | 5265 | Cycle 1(1): loaded http://localhost:36067/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36067/tests/kraken/driver.html?testName=audio-oscillator) 03:38:03 INFO - PROCESS | 5265 | RSS: Main: 188235776 03:38:03 INFO - PROCESS | 5265 | 03:38:05 INFO - PROCESS | 5265 | Cycle 1(1): loaded http://localhost:36067/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36067/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:38:05 INFO - PROCESS | 5265 | RSS: Main: 188911616 03:38:05 INFO - PROCESS | 5265 | 03:38:08 INFO - PROCESS | 5265 | Cycle 1(1): loaded http://localhost:36067/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36067/tests/kraken/driver.html?testName=imaging-darkroom) 03:38:09 INFO - PROCESS | 5265 | RSS: Main: 223670272 03:38:09 INFO - PROCESS | 5265 | 03:38:12 INFO - PROCESS | 5265 | Cycle 1(1): loaded http://localhost:36067/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36067/tests/kraken/driver.html?testName=imaging-desaturate) 03:38:13 INFO - PROCESS | 5265 | RSS: Main: 224546816 03:38:13 INFO - PROCESS | 5265 | 03:38:16 INFO - PROCESS | 5265 | Cycle 1(1): loaded http://localhost:36067/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36067/tests/kraken/driver.html?testName=json-parse-financial) 03:38:16 INFO - PROCESS | 5265 | RSS: Main: 222978048 03:38:16 INFO - PROCESS | 5265 | 03:38:18 INFO - PROCESS | 5265 | Cycle 1(1): loaded http://localhost:36067/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36067/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:38:18 INFO - PROCESS | 5265 | RSS: Main: 200409088 03:38:18 INFO - PROCESS | 5265 | 03:38:20 INFO - PROCESS | 5265 | Cycle 1(1): loaded http://localhost:36067/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36067/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:38:21 INFO - PROCESS | 5265 | RSS: Main: 202199040 03:38:21 INFO - PROCESS | 5265 | 03:38:23 INFO - PROCESS | 5265 | Cycle 1(1): loaded http://localhost:36067/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36067/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:38:23 INFO - PROCESS | 5265 | RSS: Main: 209555456 03:38:23 INFO - PROCESS | 5265 | 03:38:26 INFO - PROCESS | 5265 | Cycle 1(1): loaded http://localhost:36067/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36067/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:38:26 INFO - PROCESS | 5265 | RSS: Main: 214511616 03:38:26 INFO - PROCESS | 5265 | 03:38:29 INFO - PROCESS | 5265 | Cycle 1(1): loaded http://localhost:36067/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36067/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:38:30 INFO - PROCESS | 5265 | RSS: Main: 213143552 03:38:30 INFO - PROCESS | 5265 | 03:38:31 INFO - PROCESS | 5265 | Cycle 1(1): loaded http://localhost:36067/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36067/tests/kraken/driver.html?testName=ai-astar) 03:38:32 INFO - PROCESS | 5265 | RSS: Main: 255934464 03:38:32 INFO - PROCESS | 5265 | 03:38:32 INFO - PROCESS | 5265 | __start_tp_report 03:38:32 INFO - PROCESS | 5265 | _x_x_mozilla_page_load 03:38:32 INFO - PROCESS | 5265 | _x_x_mozilla_page_load_details 03:38:32 INFO - PROCESS | 5265 | |i|pagename|runs| 03:38:32 INFO - PROCESS | 5265 | |0;ai-astar;111;105;109;108;108;109;108;110;110;110 03:38:32 INFO - PROCESS | 5265 | |1;audio-beat-detection;159;129;125;182;128;132;158;123;198;127 03:38:32 INFO - PROCESS | 5265 | |2;audio-dft;161;162;163;161;162;163;161;161;161;161 03:38:32 INFO - PROCESS | 5265 | |3;audio-fft;75;74;75;121;75;87;75;73;96;76 03:38:32 INFO - PROCESS | 5265 | |4;audio-oscillator;83;83;111;86;84;85;118;83;84;127 03:38:32 INFO - PROCESS | 5265 | |5;imaging-gaussian-blur;116;117;116;117;116;117;116;117;116;117 03:38:32 INFO - PROCESS | 5265 | |6;imaging-darkroom;149;146;146;146;146;145;145;146;145;146 03:38:32 INFO - PROCESS | 5265 | |7;imaging-desaturate;96;95;95;95;95;94;95;95;95;95 03:38:32 INFO - PROCESS | 5265 | |8;json-parse-financial;50;50;51;52;53;55;53;51;50;51 03:38:32 INFO - PROCESS | 5265 | |9;json-stringify-tinderbox;59;59;59;65;59;59;59;60;60;59 03:38:32 INFO - PROCESS | 5265 | |10;stanford-crypto-aes;76;77;81;79;81;79;77;82;105;84 03:38:32 INFO - PROCESS | 5265 | |11;stanford-crypto-ccm;129;130;118;114;114;124;121;119;125;123 03:38:32 INFO - PROCESS | 5265 | |12;stanford-crypto-pbkdf2;156;158;156;152;152;153;152;153;156;159 03:38:32 INFO - PROCESS | 5265 | |13;stanford-crypto-sha256-iterative;66;61;62;61;61;65;60;59;69;60 03:38:32 INFO - PROCESS | 5265 | __end_tp_report 03:38:32 INFO - PROCESS | 5265 | __start_cc_report 03:38:32 INFO - PROCESS | 5265 | _x_x_mozilla_cycle_collect,1561 03:38:32 INFO - PROCESS | 5265 | __end_cc_report 03:38:32 INFO - PROCESS | 5265 | __startTimestamp1468406312052__endTimestamp 03:38:32 INFO - PROCESS | 5265 | 03:38:32 INFO - PROCESS | 5265 | ------- Summary: start ------- 03:38:32 INFO - PROCESS | 5265 | Number of tests: 14 03:38:32 INFO - PROCESS | 5265 | 03:38:32 INFO - PROCESS | 5265 | [#0] ai-astar Cycles:10 Average:108.80 Median:109.50 stddev:1.69 (1.5%) stddev-sans-first:1.59 03:38:32 INFO - PROCESS | 5265 | Values: 111.0 105.0 109.0 108.0 108.0 109.0 108.0 110.0 110.0 110.0 03:38:32 INFO - PROCESS | 5265 | 03:38:32 INFO - PROCESS | 5265 | [#1] audio-beat-detection Cycles:10 Average:146.10 Median:145.00 stddev:26.78 (18.5%) stddev-sans-first:27.99 03:38:32 INFO - PROCESS | 5265 | Values: 159.0 129.0 125.0 182.0 128.0 132.0 158.0 123.0 198.0 127.0 03:38:32 INFO - PROCESS | 5265 | 03:38:32 INFO - PROCESS | 5265 | [#2] audio-dft Cycles:10 Average:161.60 Median:161.50 stddev:0.84 (0.5%) stddev-sans-first:0.87 03:38:32 INFO - PROCESS | 5265 | Values: 161.0 162.0 163.0 161.0 162.0 163.0 161.0 161.0 161.0 161.0 03:38:32 INFO - PROCESS | 5265 | 03:38:32 INFO - PROCESS | 5265 | [#3] audio-fft Cycles:10 Average:82.70 Median:75.00 stddev:15.33 (20.4%) stddev-sans-first:16.00 03:38:32 INFO - PROCESS | 5265 | Values: 75.0 74.0 75.0 121.0 75.0 87.0 75.0 73.0 96.0 76.0 03:38:32 INFO - PROCESS | 5265 | 03:38:32 INFO - PROCESS | 5265 | [#4] audio-oscillator Cycles:10 Average:94.40 Median:83.50 stddev:17.19 (20.6%) stddev-sans-first:17.73 03:38:32 INFO - PROCESS | 5265 | Values: 83.0 83.0 111.0 86.0 84.0 85.0 118.0 83.0 84.0 127.0 03:38:32 INFO - PROCESS | 5265 | 03:38:32 INFO - PROCESS | 5265 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 03:38:32 INFO - PROCESS | 5265 | Values: 116.0 117.0 116.0 117.0 116.0 117.0 116.0 117.0 116.0 117.0 03:38:32 INFO - PROCESS | 5265 | 03:38:32 INFO - PROCESS | 5265 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:1.15 (0.8%) stddev-sans-first:0.50 03:38:32 INFO - PROCESS | 5265 | Values: 149.0 146.0 146.0 146.0 146.0 145.0 145.0 146.0 145.0 146.0 03:38:32 INFO - PROCESS | 5265 | 03:38:32 INFO - PROCESS | 5265 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 03:38:32 INFO - PROCESS | 5265 | Values: 96.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 03:38:32 INFO - PROCESS | 5265 | 03:38:32 INFO - PROCESS | 5265 | [#8] json-parse-financial Cycles:10 Average:51.60 Median:51.50 stddev:1.65 (3.2%) stddev-sans-first:1.64 03:38:32 INFO - PROCESS | 5265 | Values: 50.0 50.0 51.0 52.0 53.0 55.0 53.0 51.0 50.0 51.0 03:38:32 INFO - PROCESS | 5265 | 03:38:32 INFO - PROCESS | 5265 | [#9] json-stringify-tinderbox Cycles:10 Average:59.80 Median:59.00 stddev:1.87 (3.2%) stddev-sans-first:1.96 03:38:32 INFO - PROCESS | 5265 | Values: 59.0 59.0 59.0 65.0 59.0 59.0 59.0 60.0 60.0 59.0 03:38:32 INFO - PROCESS | 5265 | 03:38:32 INFO - PROCESS | 5265 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:80.00 stddev:8.43 (10.5%) stddev-sans-first:8.64 03:38:32 INFO - PROCESS | 5265 | Values: 76.0 77.0 81.0 79.0 81.0 79.0 77.0 82.0 105.0 84.0 03:38:32 INFO - PROCESS | 5265 | 03:38:32 INFO - PROCESS | 5265 | [#11] stanford-crypto-ccm Cycles:10 Average:121.70 Median:123.50 stddev:5.58 (4.5%) stddev-sans-first:5.25 03:38:32 INFO - PROCESS | 5265 | Values: 129.0 130.0 118.0 114.0 114.0 124.0 121.0 119.0 125.0 123.0 03:38:32 INFO - PROCESS | 5265 | 03:38:32 INFO - PROCESS | 5265 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.70 Median:156.00 stddev:2.63 (1.7%) stddev-sans-first:2.74 03:38:32 INFO - PROCESS | 5265 | Values: 156.0 158.0 156.0 152.0 152.0 153.0 152.0 153.0 156.0 159.0 03:38:32 INFO - PROCESS | 5265 | 03:38:32 INFO - PROCESS | 5265 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.40 Median:61.50 stddev:3.20 (5.2%) stddev-sans-first:3.12 03:38:32 INFO - PROCESS | 5265 | Values: 66.0 61.0 62.0 61.0 61.0 65.0 60.0 59.0 69.0 60.0 03:38:32 INFO - PROCESS | 5265 | -------- Summary: end -------- 03:38:32 INFO - PROCESS | 5265 | 03:38:32 INFO - TEST-INFO | 5265: exit 0 03:38:33 INFO - TEST-OK | kraken | took 60203ms 03:38:33 INFO - SUITE-END | took 1173s 03:38:33 INFO - Completed test suite (00:19:33) 03:38:33 INFO - javascript benchmark 03:38:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3274.6725327467257, 3314.337132573485, 3316.137804170915, 3321.4851697986805, 3366.309906469174, 5386.919196212055, 5450.754716037778, 5475.9726201368985, 5499.670019798815, 5503.697296648687, 5342.305500284958, 5446.2375267462485, 5448.128299472085, 5460.208269800876, 5487.478689524499, 4814.2056560667625, 4817.78319975602, 4841.419029716439, 4843.0, 4878.536539028786, 4838.927416088762, 4916.877078073041, 4924.138275801721, 4924.507549245082, 4927.236278376839, 4847.975760121194, 4859.805607775685, 4895.6083513318845, 4899.191633380488, 4901.0, 4946.0602485528, 4969.7515124244, 4969.975150124263, 4971.850844474671, 4989.3513843200335, 4719.10337035962, 4736.005438857844, 4800.015996720664, 4878.121938051149, 4905.264210368473, 5228.947710522884, 5243.501867322599, 5244.475552444725, 5283.55089817366, 5293.444188360244, 5704.657720536739, 5802.0, 5803.158542011384, 5809.331926828427, 5813.941860581424, 5754.3094828620415, 5795.159701843209, 5801.651900885918, 5820.44705752957, 5876.353601103875, 5420.268263784417, 5492.231087647732, 5504.944950550484, 5508.118701007819, 5515.531179849758, 5701.0, 5972.163897054415, 5979.133025711334, 5983.940160598426, 5990.400959903975, 5536.944630553723, 5540.584456165804, 5592.748326325325, 5632.211490391349, 5632.493075623213, 5679.261695979496, 5693.231413759172, 5706.887157004344, 5710.971445142748, 5714.914276285859, 5518.896220755784, 5587.022271102622, 5646.20953066571, 5652.0391533439415, 5654.264945557134, 5615.606907516516, 5678.318601767732, 5679.375268720438, 5681.886362272814, 5710.172025056427, 4406.9779651101535, 4409.911801763947, 4410.007748256617, 4424.380586717862, 4437.29003359461, 3956.4658771065538, 3963.128111815396, 3963.4451176835264, 3988.0827409695353, 4029.6977726670616, 5519.089350257163, 5535.7785688572, 5538.280023596987, 5543.113101903676, 5572.4706152915405, 5742.397048309867, 5743.569232307594, 5795.217645617872, 5801.796937107181, 5833.4749872511675, 5372.516473517402, 5408.945910540844, 5438.320209973754, 5510.752016159283, 5511.173324001432, 4989.600831933437, 4990.8752281193265, 4992.400911890596, 4994.051130285234, 5013.924791128136, 5970.76116955317, 6018.15745795589, 6028.022481763488, 6032.215811944419, 6067.302260240129, 5650.067738823048, 5714.628549144292, 5744.224529688438, 5744.511716504144, 5763.049096898964, 6040.607360521552, 6075.210222671025, 6079.939200607937, 6088.573799833969, 6090.786822461193, 5696.11710184922, 5706.885862282814, 5710.543156547549, 5712.34308054579, 5713.628614140068, 5613.522850557748, 5624.212610234488, 5645.774169033357, 5668.744906479136, 5704.458076482728, 5558.138488534122, 5562.0, 5569.387367389665, 5573.136163894603, 5580.804671836466, 5360.16917377807, 5476.151196564539, 5484.478974497416, 5486.725663716718, 5516.889662206653, 5464.535514481314, 5511.917321240105, 5517.586181036358, 5551.417101204315, 5556.249906262603, 5653.812699333022, 5668.489835914787, 5711.286089238845, 5733.942660573341, 5771.59598828078, 5360.597955153301, 5445.7821687133655, 5626.240457538343, 5628.802991895264, 5655.066913959151], "value": 5315.399864617991, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.8712426828233, 636.4272155060446, 649.7823229218209, 661.735305877649, 673.8955461903407, 33419.16452088699, 47137.292940605876, 47476.52523474764, 47882.0, 47891.0, 49720.0, 50062.49937500624, 50161.0, 50237.246441303316, 50288.74855625717, 8269.214424629681, 9086.182243598058, 9229.907700923006, 9235.584398702074, 10653.733656658567, 10588.52351644174, 11023.283486573388, 11025.393603351813, 11030.448477576128, 11033.83449248262, 11094.944525277362, 11129.443527823616, 11145.331280123219, 11147.72130696735, 11150.442477876115, 8381.748547543584, 8547.230749232598, 11009.119270458345, 11051.944740276287, 11293.887061129366, 10654.0, 11023.228374013823, 11024.614138505114, 11030.558777648885, 11039.779204415867, 45298.54701453009, 45532.0, 45662.77168614136, 45712.54287457116, 45742.0, 3544.2025544252597, 3760.849566017356, 3820.4842346283453, 3864.9806750966345, 4057.898552536181, 34886.651133488594, 35328.47007294893, 35385.0, 35465.82267088648, 35579.822100889585, 4815.398075240595, 4830.420349558076, 4833.564979151894, 4838.685485443435, 4849.248366503198, 372332.0, 372990.0, 374034.0, 376329.0, 379678.0, 70006.0, 70683.64658176676, 70852.2914770856, 71070.0, 71486.0, 40017.59982400139, 41128.0, 41147.7942610285, 75837.24162758412, 76142.3350182752, 13387.732245355233, 13389.263590502422, 13394.93302533481, 13409.932950335186, 13498.662533436742, 10983.835242471368, 11486.368249746178, 11607.477663505162, 11623.418829058513, 11972.521099155936, 22600.773992259867, 22659.773402265768, 22689.773102269097, 22736.09055637756, 22844.771552284597, 8108.108108108104, 8161.510309381456, 8163.918360816316, 8243.546604936786, 8412.453190542717, 1077.4074259157433, 1143.4454289669504, 1150.4592841364545, 1186.424584076722, 1240.6712221261373, 34917.0, 35341.82329088338, 35383.29233415317, 35391.82304088463, 35508.82245588807, 1157.3518829455531, 1170.5551890281638, 1190.749712801555, 1205.457544105156, 1220.4812954494305, 17692.203850826743, 18096.18567164481, 18455.16951737175, 18502.44492665222, 18543.0, 608628.0, 611263.0, 615348.0, 617883.0, 618137.0, 65925.34074659288, 66500.33499665039, 66506.33493665098, 66506.66746666236, 66717.33282667112, 1333.6799168199757, 1402.8667276608705, 1439.9208043557496, 1443.1196969848595, 1471.830739464954, 34574.82712586421, 35797.46303805393, 36222.4566631506, 36908.81545592362, 36952.63047369492, 55312.44687553073, 62054.37945620486, 63782.0, 63892.68053659702, 69427.65286173536, 560989.0, 561606.0, 563598.0, 566720.0, 567291.0, 43176.0, 47911.41725435224, 48282.275765864244, 49329.0, 49622.50377496179, 52779.20831187612, 52944.470555293956, 53751.73124134354, 54410.18384724311, 54994.450055498935, 44686.3297050551, 45079.32381014222, 45615.57883158843, 45904.31143532783, 46967.29549056835, 36624.81687591545, 36983.815080924425, 37242.441363380116, 38037.80981095077, 38455.0, 45208.0, 46053.53946460626, 46097.0, 46268.768656156506, 46589.76705116453, 38914.610853892234, 40199.0, 40413.191736164525, 40844.59155408408, 41242.1751564973, 30371.544426833174, 30708.539371909887, 30723.692763072082, 31123.821332506508, 31212.687873121886], "value": 22346.78472537843, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [412.12012353625, 413.41295360587964, 416.8162418730804, 423.8834320561846, 426.8932766808298, 19115.0, 20575.897120514375, 20585.07367168477, 20764.27325043624, 21236.0, 18428.907855460704, 18848.905755471238, 18910.62178756424, 18942.24231030757, 19083.332083377085, 5661.943380566204, 5851.76592936282, 5857.589968702193, 5892.469677729004, 5912.88174236515, 4252.87241382759, 5204.219367094928, 5747.798827041054, 5801.970990145043, 6564.835879103013, 6518.120053792748, 6520.967395163041, 6639.203295604534, 6668.566543174702, 6670.199576050856, 6339.049142628596, 6587.110740050104, 6650.3682150195655, 6667.033280174348, 6672.46620270382, 3912.784796836173, 5488.506034456878, 5804.361520232771, 5909.734061967221, 5917.733701983421, 24878.626820597707, 24913.87543062273, 25548.872255638787, 26635.600465993026, 27146.0, 2384.6542251373626, 2580.8967641294325, 2581.8450892946485, 2649.2582077018465, 2667.7065522792477, 15273.38906443741, 16281.348746050144, 16732.330706771714, 17196.0, 17444.738328925076, 2061.6186005589016, 2074.875507469557, 2125.6598944169014, 2131.7335333083365, 2144.8069673729283, 56863.715681421745, 69301.65349173221, 83484.0, 99313.50343248309, 105173.47413263038, 18382.540436488925, 18714.1578628962, 18863.62272754537, 19131.61736765257, 20814.167433302802, 35135.47296790499, 35326.64673353285, 35589.0, 35960.46059309113, 36009.0997725059, 9185.816283674289, 10011.349262298074, 10143.08712215904, 10232.0, 10341.9482902585, 7946.245106714853, 8034.076081250731, 8184.590770461453, 8317.542535160503, 8357.540335281496, 9202.953985230031, 9300.441973481613, 9480.431174129575, 9595.12894985485, 9794.65718699842, 3628.76413033152, 3750.774953502799, 3773.226583505803, 3823.445600387928, 3823.7323387362617, 992.8907820139779, 1022.3967858963248, 1033.8914413986574, 1037.8495118207968, 1095.5921640691672, 18802.81197188038, 19522.511937201685, 20267.797322026592, 20306.18775249003, 20425.69361459579, 1005.4168582222294, 1018.6231094495084, 1052.55792567122, 1054.7679510507676, 1097.3964319624174, 10791.136709063256, 11328.433578321052, 11379.089672826154, 11437.313761174357, 11551.133664975161, 396033.0, 540830.0, 571019.0, 571611.0, 573472.0, 81380.59309703532, 104297.47851260695, 104696.47651761693, 108452.0, 108653.0, 1042.921780866438, 1070.753726642861, 1092.7705181911729, 1094.7865166292497, 1100.6918062942389, 18278.908605456887, 18543.35098271554, 18544.629107417506, 18677.252909883453, 18933.715994260372, 32270.515942260416, 36861.631383686894, 42145.78927105345, 42554.361684574134, 43535.0, 56956.715216423654, 62813.37186628258, 64047.0, 64892.0, 65645.0, 9279.164875161268, 9294.25645948336, 9317.627294908129, 9471.715848524555, 9527.571259293487, 13254.668633284246, 13622.86377136216, 13734.381952811947, 13866.930665346608, 13880.514182003986, 12355.69110772238, 12363.661811311076, 12377.504899804268, 12594.622161335175, 12804.807927880904, 12207.69480762988, 12272.938635306766, 12321.336619556603, 12401.379931003234, 12472.269167302207, 12316.568920087753, 12346.938265308616, 12588.496460141858, 12730.618081457571, 12736.554220602235, 9135.497547634945, 9166.404183728037, 9221.49281789508, 9249.491277979776, 9288.489133097744, 9546.761330966781, 12408.875911240772, 12708.110432269652, 12788.104832661624, 12802.679933001376], "value": 10609.657312729827, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1417.461364681421, 1569.8116226052875, 1602.8236893941664, 1842.9447116586507, 1962.0876292523983, 9381.953090234549, 9842.852357214639, 9861.60553577857, 10089.344192627474, 10100.494975251226, 9765.658201962933, 10027.047430494109, 10029.498525073754, 10038.799224015514, 10053.698389048322, 2198.714167158267, 2265.682804407384, 2401.2196036288187, 2505.1357281737774, 2541.644169816218, 2474.344298760821, 2494.6008638617823, 2495.4510007798253, 2498.025769949721, 2499.5750722377147, 2413.2036427978815, 2416.214730212679, 2417.7340492545804, 2423.2851308863837, 2432.6959130108735, 2094.2251366994233, 2340.899777104758, 2417.9758202418016, 2423.75762423758, 2450.779429851313, 2452.6198439241766, 2456.1894574790276, 2463.1502131764514, 2479.2066538707622, 2481.677381940336, 9858.359206651545, 9876.061774131445, 9903.45530995795, 9953.701388958343, 9978.9501052495, 5385.0, 5469.972650136764, 5471.699056551888, 5473.124300112003, 5481.835544933659, 3497.318022985519, 3555.253396786678, 3587.982060089683, 3595.49663047171, 3618.149734812317, 1196.0312147160741, 1210.2133613151434, 1218.4029825385585, 1227.9447424865903, 1244.2596654990266, 13067.999999999905, 13070.54253101137, 13075.28085955272, 13080.345982700826, 13093.345332733325, 4679.695819771704, 4683.648726345537, 4721.881952951204, 4755.239161734106, 4799.280107983761, 11086.22396432242, 11093.667189984313, 11109.55561777536, 11122.443877806078, 11135.164862635334, 5429.945700543023, 5462.289902312674, 5464.644798088191, 5480.725963701879, 5502.284702988586, 4578.404807375086, 5000.924986125211, 5040.0, 5200.8959820803375, 5202.7918883245, 4396.428464299621, 4414.139242847614, 4457.710248833815, 4486.528914463999, 4497.190505708938, 1340.546799357174, 1387.6045327081936, 1411.541249094028, 1418.6453386653336, 1425.4084554909803, 976.9755756106155, 1071.6731396923858, 1074.6507385099874, 1090.6019302954364, 1099.8845121262311, 6459.870802584016, 6758.155230596176, 6823.931760682429, 6891.793246202622, 6986.0, 491.4913064977802, 500.7796569509404, 501.4985014985015, 506.4808571214535, 509.5694138453001, 4429.468463784302, 4462.977685111554, 4493.258612328995, 4543.727376357429, 4598.103369842848, 12076.698082547831, 12440.75118497643, 12448.937755311166, 12465.314407707481, 12491.375431228402, 10820.404877731642, 11216.831747523795, 11230.438478076063, 12271.263724176399, 12353.073519485895, 8916.15296546827, 9221.81556368869, 9223.077692230858, 9296.674616388394, 9322.114399132071, 6469.644169570719, 6476.798161092748, 6714.261431242657, 6826.385625293748, 6855.485838562028, 10993.450327483433, 11256.0, 11342.319460832376, 11362.204645674723, 11377.772444550897, 11470.483828227583, 11670.358130302915, 11677.0, 11679.124065694938, 11791.35147566892, 8425.70510032146, 8638.438501497383, 8638.654453821777, 9343.859842102238, 9530.857037144588, 8784.429012114193, 8909.643614255358, 9008.684696035607, 9035.548222588975, 9240.168384845396, 8276.834463310579, 8298.958505207434, 8439.451435656663, 8456.619452124545, 8484.830303393774, 8358.665653373797, 8431.241188293083, 8499.95750021246, 8531.712420905884, 8561.700340488052, 7760.456768026184, 7794.883076753967, 7842.529448233125, 7846.17615150401, 7849.215078492105, 5517.834464966058, 5791.391903850204, 5840.0, 5852.824415267549, 5881.147233651182, 5681.17622944679, 5693.946619875336, 5791.449812267828, 5851.473367396955, 5908.793192238251], "value": 4956.829351561003, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.1566374417746, 335.0651681807756, 337.9273456206915, 338.59030573006663, 341.5713279833809, 5341.332333458317, 5360.490753378428, 5377.462253774621, 5429.67421954683, 5432.592555558339, 5295.258663787064, 5317.787288508455, 5332.680039197641, 5375.354957405117, 5384.91922621161, 3918.921621567574, 3969.7816620085882, 4093.4269202311552, 4125.2780763366445, 4127.834886604533, 4065.3292206785845, 4077.734947228421, 4078.796060196993, 4080.7551546907134, 4101.610347017044, 3910.648041676249, 4065.3698676705158, 4076.1236334188143, 4079.1433798902267, 4117.279476091672, 3968.7817170055637, 4063.674906007512, 4080.7347522411246, 4080.8979775505554, 4098.385242213677, 3597.2805438912324, 3605.7656252343513, 3612.801295928723, 3617.5116359291424, 3618.3667858124986, 5069.03688299222, 5080.74596270185, 5082.263071854597, 5086.135356989321, 5107.0, 4583.931241031387, 4717.716936983792, 4755.310479980418, 4769.928451073237, 4802.015586804731, 5456.290682211326, 5462.453754624546, 5484.890302193974, 5508.283923089973, 5520.530754885839, 4046.2312160689376, 4058.79706014701, 4064.4919385076864, 4071.42999980003, 4093.406456063884, 5651.378348381675, 5695.373508914057, 5703.230063941356, 5707.71461426927, 5710.2576665033275, 4092.8362865485046, 4100.65144462724, 4124.340105583153, 4126.463559737215, 4127.7936103194725, 4166.500019997619, 4178.185253875526, 4195.160967806451, 4209.768462734579, 4217.768022758716, 4656.996237426841, 4665.307323006918, 4736.0, 4754.144254034238, 4789.928151077736, 5529.834104976777, 5540.63985840919, 5554.638948468418, 5571.832845014656, 5573.7770489179975, 1422.9683479477296, 1440.3734375546671, 1451.267110109388, 1451.3396404635864, 1451.8965586154598, 935.4060171790826, 955.2405837359316, 976.2043934193609, 990.881094268678, 996.785691076422, 5361.758720857571, 5373.543248823816, 5419.756110975016, 5421.2681288025615, 5433.0, 5614.63504872182, 5635.436456354331, 5636.408177141423, 5660.0, 5688.488036076773, 5227.555657769132, 5419.241306217133, 5483.4516548344845, 5494.340679118532, 5494.945050549523, 3007.518796992471, 3017.5775391445213, 3061.494853349217, 3065.049834551296, 3067.6165479315086, 5829.387914269026, 6041.78853740117, 6042.667653279024, 6050.818475445743, 6122.969385153046, 5799.130130480377, 5899.613590806157, 5905.291365036223, 5919.467247947706, 5930.1994230779155, 6023.759049637965, 6100.755969761249, 6116.8776624468155, 6146.631202127886, 6159.384061593805, 5648.774049037993, 5762.366139724543, 5771.0, 5795.652260864362, 5799.391063938226, 5699.316082070178, 5702.429757024264, 5705.857353566194, 5742.655440673573, 5779.450952159538, 5675.269042941943, 6006.969965150146, 6074.969625151846, 6094.811511755165, 6112.572119951561, 4129.421880936731, 4150.526563070067, 4154.231467178582, 4154.771487568213, 4160.625543701081, 5742.741576628978, 5747.712614369181, 5765.221695071112, 5775.104858746901, 5796.42035796417, 5385.461453854583, 5656.547476201977, 5679.432056794452, 5680.0, 5691.857703557444, 5643.238162847963, 5647.830565083054, 5665.546756259571, 5675.517581005661, 5675.914861277167, 5298.761555730079, 5438.700871452108, 5471.781128754965, 5632.971835140798, 5633.126865335879, 5175.404828444626, 5654.547636189177, 5662.943370566241, 5667.659940403424, 5684.886302273849, 5574.0, 5574.498295153294, 5584.888302234014, 5589.944100558942, 5590.916136258041], "value": 4274.647923141952, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [793.3890904003918, 794.2534018023061, 848.7326492154967, 887.618324120628, 929.4144688846026, 16065.598360041005, 17238.482845514623, 17264.74102888458, 17307.567310817234, 17310.826891731078, 15604.375824966988, 15750.369985200578, 15750.84249157508, 15814.76277855833, 15826.604334891634, 732.3628443254363, 858.8110615664543, 866.2377108144824, 872.3413822563955, 905.0090151284334, 874.8031692869117, 886.6586364249746, 887.8313120507115, 888.8044630181349, 890.888638920135, 920.894097178823, 928.4568527411473, 930.4091901642472, 930.6975233049252, 930.7486978515797, 762.5119923249125, 899.5142622983581, 903.9141281578272, 907.4328544659588, 932.379967321737, 686.6326515314283, 690.4165979747106, 690.8031211104811, 691.1533371619776, 691.3190507350256, 13517.459301628021, 13633.113847599974, 13680.0, 13695.246761428118, 13799.586012419644, 14931.92534037323, 15162.090274583561, 15390.769138462932, 15411.61470963235, 15555.844441555666, 12393.814092788616, 12406.689832754164, 12471.688207794878, 13582.59252222435, 14092.647683807987, 4816.301636262722, 4880.219164933594, 4885.071836351082, 4922.286268491084, 5020.3724534433195, 78144.21855781427, 78566.0, 78636.60681696612, 79015.0, 79294.603526982, 11765.11761617865, 12033.699157521132, 12221.816672749916, 12363.75272494563, 12641.178323408949, 22099.779002210093, 22382.0, 22427.43931401728, 22445.663315050286, 22466.0, 8999.865002024844, 9157.404768690014, 9161.450312981242, 9340.439573625605, 9415.952920235355, 4931.112399768004, 4976.402831660224, 5018.247262910592, 5044.344235249468, 5143.434222235551, 3734.141147536028, 3871.8838434847, 3878.7781848717564, 3879.9224015520094, 3880.262750077476, 652.8204743695427, 671.8421171024805, 675.3078094952713, 684.7021545627667, 685.9691313890887, 606.9620948178664, 734.977950661481, 745.9291367320096, 755.5089192025227, 774.2103054883987, 10126.898731012596, 10163.644272450429, 10418.68743937683, 10421.739456513647, 10472.581096756045, 593.551868339401, 689.4174422612984, 709.8970649255829, 739.6449704141935, 761.7143571160815, 4656.301554766812, 4761.76191190446, 4780.633586374766, 5026.411562339759, 5178.0, 115529.0, 119388.40305798415, 120279.0, 123536.38231808784, 125485.0, 101341.0, 101846.67761802899, 102047.0, 102836.48581757043, 103244.48377758064, 86220.0, 87388.5630571843, 88638.55680721684, 89331.0, 91163.54418227999, 9106.453612783254, 10667.519961601902, 10885.401302928098, 11338.376389298668, 11354.489047992694, 42112.0, 45955.770221150015, 47108.05783884371, 48333.0, 48377.274340884214, 72769.63615181891, 73190.0, 73560.0, 83388.0, 84845.0, 13978.231197284247, 14680.0, 14775.778363324775, 14957.850421496081, 15139.318730656927, 12402.627921162379, 12576.74846503083, 15939.601509962344, 16413.917930410273, 17381.304747809947, 12834.16577922432, 14504.202268875313, 14680.55958321252, 14824.03643763152, 15325.923370383076, 14629.0, 14796.48212312564, 14983.475578354706, 15184.924075379553, 15440.536783896501, 14846.257687115816, 15015.474458393905, 15263.618409539851, 15343.309551070006, 15606.687866242839, 12349.876501234872, 12631.11582189238, 12731.490740370282, 13110.672233194246, 13390.397432115773, 12688.429020694275, 12783.552575659807, 12850.935745321214, 13007.089503735026, 13246.933765331112], "value": 8063.104452497362, "unit": "score"}], "name": "dromaeo_css", "value": 7741.965843838038, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 109.0, 108.0, 108.0, 109.0, 108.0, 110.0, 110.0, 110.0], "value": 108.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 129.0, 125.0, 182.0, 128.0, 132.0, 158.0, 123.0, 198.0, 127.0], "value": 146.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 163.0, 161.0, 162.0, 163.0, 161.0, 161.0, 161.0, 161.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 121.0, 75.0, 87.0, 75.0, 73.0, 96.0, 76.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 111.0, 86.0, 84.0, 85.0, 118.0, 83.0, 84.0, 127.0], "value": 94.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 51.0, 52.0, 53.0, 55.0, 53.0, 51.0, 50.0, 51.0], "value": 51.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 65.0, 59.0, 59.0, 59.0, 60.0, 60.0, 59.0], "value": 59.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 81.0, 79.0, 81.0, 79.0, 77.0, 82.0, 105.0, 84.0], "value": 82.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 130.0, 118.0, 114.0, 114.0, 124.0, 121.0, 119.0, 125.0, 123.0], "value": 121.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 158.0, 156.0, 152.0, 152.0, 153.0, 152.0, 153.0, 156.0, 159.0], "value": 154.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 61.0, 62.0, 61.0, 61.0, 65.0, 60.0, 59.0, 69.0, 60.0], "value": 62.4, "unit": "score"}], "name": "kraken", "value": 1483.4, "alertThreshold": 2.0}]} 03:38:33 INFO - Return code: 0 03:38:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:38:33 ERROR - # TBPL SUCCESS # 03:38:33 INFO - Running post-action listener: _resource_record_post_action 03:38:33 INFO - ##### 03:38:33 INFO - ##### Finished run-tests step (success) 03:38:33 INFO - ##### 03:38:33 INFO - Running post-run listener: _resource_record_post_run 03:38:33 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 290816; Write bytes: 505769984; Read time: 52; Write time: 449312 03:38:33 INFO - TinderboxPrint: CPU usage
13.0% 03:38:33 INFO - TinderboxPrint: I/O read bytes / time
290,816 / 52 03:38:33 INFO - TinderboxPrint: I/O write bytes / time
505,769,984 / 449,312 03:38:33 INFO - TinderboxPrint: CPU idle
8,257.9 (86.9%) 03:38:33 INFO - TinderboxPrint: CPU user
1,194.0 (12.6%) 03:38:33 INFO - TinderboxPrint: Swap in / out
0 / 0 03:38:33 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 252698624; Read time: 0; Write time: 285104 03:38:33 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 266240; Write bytes: 253071360; Read time: 36; Write time: 164208 03:38:33 INFO - Running post-run listener: _upload_blobber_files 03:38:33 INFO - Blob upload gear active. 03:38:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:38:33 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:38:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:38:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:38:34 INFO - (blobuploader) - INFO - Open directory for files ... 03:38:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:38:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:38:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:38:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:38:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:38:35 INFO - (blobuploader) - INFO - Done attempting. 03:38:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:38:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:38:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:38:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:38:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:38:35 INFO - (blobuploader) - INFO - Done attempting. 03:38:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:38:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:38:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:38:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:38:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:38:41 INFO - (blobuploader) - INFO - Done attempting. 03:38:41 INFO - (blobuploader) - INFO - Iteration through files over. 03:38:41 INFO - Return code: 0 03:38:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:38:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:38:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2e7892dddaa0fa6e29ee592ddbc7b3bae3c3911e8bd9942a5dbcfb1a01db7e0445f95e825e0901e8349d63a78117c8cdbaf8a1d4db46bd27cb8c39454d280db4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/93a1f51a9cd6ced2be3a6760f5d798608c4c246d8380b834adde9acaec409f5d41a1aeaac4f3343850457394283d9784f2986a1c1ef6852b560235fa731eef20", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/95127d50e4fff837294c3fff07dda70a035b28c03c8ced3698b354eb88d7f60ef5e7b526e93ad38062aefd3e1a5af3daa847c12956c7158651149c670d9877c7"} 03:38:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:38:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:38:41 INFO - Contents: 03:38:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2e7892dddaa0fa6e29ee592ddbc7b3bae3c3911e8bd9942a5dbcfb1a01db7e0445f95e825e0901e8349d63a78117c8cdbaf8a1d4db46bd27cb8c39454d280db4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/93a1f51a9cd6ced2be3a6760f5d798608c4c246d8380b834adde9acaec409f5d41a1aeaac4f3343850457394283d9784f2986a1c1ef6852b560235fa731eef20", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/95127d50e4fff837294c3fff07dda70a035b28c03c8ced3698b354eb88d7f60ef5e7b526e93ad38062aefd3e1a5af3daa847c12956c7158651149c670d9877c7"} 03:38:41 INFO - Running post-run listener: copy_logs_to_upload_dir 03:38:41 INFO - Copying logs to upload dir... 03:38:41 INFO - mkdir: /builds/slave/test/build/upload/logs 03:38:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.421176 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-13 03:38:41.449294) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 03:38:41.452704) ========= 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-1468404999.960070-124126227 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2e7892dddaa0fa6e29ee592ddbc7b3bae3c3911e8bd9942a5dbcfb1a01db7e0445f95e825e0901e8349d63a78117c8cdbaf8a1d4db46bd27cb8c39454d280db4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/93a1f51a9cd6ced2be3a6760f5d798608c4c246d8380b834adde9acaec409f5d41a1aeaac4f3343850457394283d9784f2986a1c1ef6852b560235fa731eef20", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/95127d50e4fff837294c3fff07dda70a035b28c03c8ced3698b354eb88d7f60ef5e7b526e93ad38062aefd3e1a5af3daa847c12956c7158651149c670d9877c7"} build_url:https://queue.taskcluster.net/v1/task/SRIHvpyuS0Grvc32KuQmsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011460 build_url: 'https://queue.taskcluster.net/v1/task/SRIHvpyuS0Grvc32KuQmsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2e7892dddaa0fa6e29ee592ddbc7b3bae3c3911e8bd9942a5dbcfb1a01db7e0445f95e825e0901e8349d63a78117c8cdbaf8a1d4db46bd27cb8c39454d280db4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/93a1f51a9cd6ced2be3a6760f5d798608c4c246d8380b834adde9acaec409f5d41a1aeaac4f3343850457394283d9784f2986a1c1ef6852b560235fa731eef20", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/95127d50e4fff837294c3fff07dda70a035b28c03c8ced3698b354eb88d7f60ef5e7b526e93ad38062aefd3e1a5af3daa847c12956c7158651149c670d9877c7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 03:38:41.482440) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 03:38:41.482917) ========= 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-1468404999.960070-124126227 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004705 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 03:38:41.564212) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 03:38:41.564506) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 03:38:41.564788) ========= ========= Total master_lag: 0.20 =========