builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-067 starttime: 1467876153.04 results: success (0) buildid: 20160706214423 builduid: 8183d856a32045d6b2b8450c4b843158 revision: a9e572ac1d5e4df9aebf5c9860bb415b8dc0a60d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 00:22:33.039793) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 00:22:33.040184) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 00:22:33.040457) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 00:22:33.072667) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 00:22:33.072933) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1467874882.370867-2055276331 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-07 00:22:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-07-07 00:22:33 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125148 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 00:22:33.214965) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 00:22:33.215307) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1467874882.370867-2055276331 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018207 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 00:22:33.270678) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 00:22:33.271003) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a9e572ac1d5e4df9aebf5c9860bb415b8dc0a60d --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 a9e572ac1d5e4df9aebf5c9860bb415b8dc0a60d --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=e0e61f6f900f4dc42e3e8956000001ad-1467874882.370867-2055276331 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-07 00:22:33,557 truncating revision to first 12 chars 2016-07-07 00:22:33,557 Setting DEBUG logging. 2016-07-07 00:22:33,557 attempt 1/10 2016-07-07 00:22:33,557 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a9e572ac1d5e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-07 00:22:33,883 unpacking tar archive at: mozilla-aurora-a9e572ac1d5e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.664448 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 00:22:33.948856) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 00:22:33.949154) ========= script_repo_revision: a9e572ac1d5e4df9aebf5c9860bb415b8dc0a60d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 00:22:33.949543) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 00:22:33.949824) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 00:22:33.958234) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-07-07 00:22:33.958518) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1467874882.370867-2055276331 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:22:34 INFO - MultiFileLogger online at 20160707 00:22:34 in /builds/slave/test 00:22:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 00:22:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:22:34 INFO - {'append_to_log': False, 00:22:34 INFO - 'base_work_dir': '/builds/slave/test', 00:22:34 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 00:22:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:22:34 INFO - 'branch': 'Mozilla-Aurora', 00:22:34 INFO - 'buildbot_json_path': 'buildprops.json', 00:22:34 INFO - 'config_files': ('talos/linux_config.py',), 00:22:34 INFO - 'default_actions': ('clobber', 00:22:34 INFO - 'read-buildbot-config', 00:22:34 INFO - 'download-and-extract', 00:22:34 INFO - 'populate-webroot', 00:22:34 INFO - 'create-virtualenv', 00:22:34 INFO - 'install', 00:22:34 INFO - 'run-tests'), 00:22:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:22:34 INFO - 'download_minidump_stackwalk': True, 00:22:34 INFO - 'download_symbols': 'ondemand', 00:22:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:22:34 INFO - 'tooltool.py': '/tools/tooltool.py', 00:22:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:22:34 INFO - '/tools/misc-python/virtualenv.py')}, 00:22:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:22:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:22:34 INFO - 'installer_path': 'installer.exe', 00:22:34 INFO - 'log_level': 'info', 00:22:34 INFO - 'log_name': 'talos', 00:22:34 INFO - 'log_to_console': True, 00:22:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:22:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:22:34 INFO - 'opt_config_files': (), 00:22:34 INFO - 'pip_index': False, 00:22:34 INFO - 'sps_profile': False, 00:22:34 INFO - 'sps_profile_interval': 0, 00:22:34 INFO - 'suite': 'dromaeojs-e10s', 00:22:34 INFO - 'system_bits': '32', 00:22:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:22:34 INFO - 'title': 'talos-linux64-ix-067', 00:22:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:22:34 INFO - 'use_talos_json': True, 00:22:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:22:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:22:34 INFO - 'work_dir': 'build'} 00:22:34 INFO - ##### 00:22:34 INFO - ##### Running clobber step. 00:22:34 INFO - ##### 00:22:34 INFO - Running pre-action listener: _resource_record_pre_action 00:22:34 INFO - Running main action method: clobber 00:22:34 INFO - rmtree: /builds/slave/test/build 00:22:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:22:34 INFO - Running post-action listener: _resource_record_post_action 00:22:34 INFO - ##### 00:22:34 INFO - ##### Finished clobber step (success) 00:22:34 INFO - ##### 00:22:34 INFO - ##### 00:22:34 INFO - ##### Running read-buildbot-config step. 00:22:34 INFO - ##### 00:22:34 INFO - Running pre-action listener: _resource_record_pre_action 00:22:34 INFO - Running main action method: read_buildbot_config 00:22:34 INFO - Using buildbot properties: 00:22:34 INFO - { 00:22:34 INFO - "project": "", 00:22:34 INFO - "product": "firefox", 00:22:34 INFO - "script_repo_revision": "production", 00:22:34 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 00:22:34 INFO - "repository": "", 00:22:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 00:22:34 INFO - "buildid": "20160706214423", 00:22:34 INFO - "pgo_build": "True", 00:22:34 INFO - "basedir": "/builds/slave/test", 00:22:34 INFO - "buildnumber": 432, 00:22:34 INFO - "slavename": "talos-linux64-ix-067", 00:22:34 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 00:22:34 INFO - "platform": "ubuntu64_hw", 00:22:34 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 00:22:34 INFO - "branch": "mozilla-aurora", 00:22:34 INFO - "repo_path": "releases/mozilla-aurora", 00:22:34 INFO - "revision": "a9e572ac1d5e4df9aebf5c9860bb415b8dc0a60d", 00:22:34 INFO - "stage_platform": "linux64-pgo", 00:22:34 INFO - "builduid": "8183d856a32045d6b2b8450c4b843158", 00:22:34 INFO - "slavebuilddir": "test" 00:22:34 INFO - } 00:22:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/fBi9cm12SXaq4eVj2OyQLg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 00:22:34 INFO - Running post-action listener: _resource_record_post_action 00:22:34 INFO - ##### 00:22:34 INFO - ##### Finished read-buildbot-config step (success) 00:22:34 INFO - ##### 00:22:34 INFO - ##### 00:22:34 INFO - ##### Running download-and-extract step. 00:22:34 INFO - ##### 00:22:34 INFO - Running pre-action listener: _resource_record_pre_action 00:22:34 INFO - Running main action method: download_and_extract 00:22:34 INFO - mkdir: /builds/slave/test/build/tests 00:22:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:22:34 INFO - https://queue.taskcluster.net/v1/task/fBi9cm12SXaq4eVj2OyQLg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 00:22:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fBi9cm12SXaq4eVj2OyQLg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 00:22:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fBi9cm12SXaq4eVj2OyQLg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 00:22:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fBi9cm12SXaq4eVj2OyQLg/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 00:22:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fBi9cm12SXaq4eVj2OyQLg/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 00:22:35 INFO - Downloaded 1361 bytes. 00:22:35 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 00:22:35 INFO - Using the following test package requirements: 00:22:35 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 00:22:35 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 00:22:35 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 00:22:35 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 00:22:35 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 00:22:35 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 00:22:35 INFO - u'jsshell-linux-x86_64.zip'], 00:22:35 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 00:22:35 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 00:22:35 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 00:22:35 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 00:22:35 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 00:22:35 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 00:22:35 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 00:22:35 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 00:22:35 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 00:22:35 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 00:22:35 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 00:22:35 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:22:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:22:36 INFO - https://queue.taskcluster.net/v1/task/fBi9cm12SXaq4eVj2OyQLg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:22:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fBi9cm12SXaq4eVj2OyQLg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 00:22:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fBi9cm12SXaq4eVj2OyQLg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 00:22:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fBi9cm12SXaq4eVj2OyQLg/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 00:22:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fBi9cm12SXaq4eVj2OyQLg/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 00:22:37 INFO - Downloaded 24526522 bytes. 00:22:37 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'] 00:22:37 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 00:22:38 INFO - Return code: 0 00:22:38 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 00:22: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')]} 00:22:38 INFO - https://queue.taskcluster.net/v1/task/fBi9cm12SXaq4eVj2OyQLg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:22:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fBi9cm12SXaq4eVj2OyQLg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 00:22:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fBi9cm12SXaq4eVj2OyQLg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 00:22:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fBi9cm12SXaq4eVj2OyQLg/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 00:22:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fBi9cm12SXaq4eVj2OyQLg/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 00:22:44 INFO - Downloaded 24526522 bytes. 00:22:44 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'] 00:22:44 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 00:22:45 INFO - Return code: 0 00:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:22:45 INFO - https://queue.taskcluster.net/v1/task/fBi9cm12SXaq4eVj2OyQLg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:22:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fBi9cm12SXaq4eVj2OyQLg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 00:22:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fBi9cm12SXaq4eVj2OyQLg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 00:22:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fBi9cm12SXaq4eVj2OyQLg/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 00:22:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fBi9cm12SXaq4eVj2OyQLg/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 00:22:46 INFO - Downloaded 10833369 bytes. 00:22:46 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'] 00:22:46 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 00:22:47 INFO - Return code: 0 00:22:47 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')]} 00:22:47 INFO - https://queue.taskcluster.net/v1/task/fBi9cm12SXaq4eVj2OyQLg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:22:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fBi9cm12SXaq4eVj2OyQLg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 00:22:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fBi9cm12SXaq4eVj2OyQLg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 00:22:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fBi9cm12SXaq4eVj2OyQLg/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 00:22:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fBi9cm12SXaq4eVj2OyQLg/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 00:22:50 INFO - Downloaded 63640298 bytes. 00:22:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fBi9cm12SXaq4eVj2OyQLg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 00:22:50 INFO - mkdir: /builds/slave/test/properties 00:22:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:22:50 INFO - Writing to file /builds/slave/test/properties/build_url 00:22:50 INFO - Contents: 00:22:50 INFO - build_url:https://queue.taskcluster.net/v1/task/fBi9cm12SXaq4eVj2OyQLg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 00:22:51 INFO - Running post-action listener: _resource_record_post_action 00:22:51 INFO - Running post-action listener: set_extra_try_arguments 00:22:51 INFO - ##### 00:22:51 INFO - ##### Finished download-and-extract step (success) 00:22:51 INFO - ##### 00:22:51 INFO - ##### 00:22:51 INFO - ##### Running populate-webroot step. 00:22:51 INFO - ##### 00:22:51 INFO - Running pre-action listener: _resource_record_pre_action 00:22:51 INFO - Running main action method: populate_webroot 00:22:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:22:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:22:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:22:51 INFO - '--tppagecycles', 00:22:51 INFO - '7'], 00:22:51 INFO - 'tests': ['tsvgm']}}, 00:22:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:22:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:22:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:22:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:22:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:22:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:22:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:22:51 INFO - 'talos_options': ['--disable-e10s'], 00:22:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:22:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:22:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:22:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:22:51 INFO - 'talos_options': ['--disable-e10s'], 00:22:51 INFO - 'tests': ['damp', 'tps']}, 00:22:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:22:51 INFO - 'tests': ['damp', 'tps']}, 00:22:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:22:51 INFO - 'tests': ['dromaeo_dom']}, 00:22:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:22:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:22:51 INFO - 'tests': ['a11yr', 00:22:51 INFO - 'ts_paint', 00:22:51 INFO - 'tpaint', 00:22:51 INFO - 'sessionrestore', 00:22:51 INFO - 'sessionrestore_no_auto_restore', 00:22:51 INFO - 'tabpaint']}, 00:22:51 INFO - 'other-e10s': {'tests': ['a11yr', 00:22:51 INFO - 'ts_paint', 00:22:51 INFO - 'tpaint', 00:22:51 INFO - 'sessionrestore', 00:22:51 INFO - 'sessionrestore_no_auto_restore', 00:22:51 INFO - 'tabpaint']}, 00:22:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:22:51 INFO - 'ts_paint', 00:22:51 INFO - 'tpaint', 00:22:51 INFO - 'sessionrestore', 00:22:51 INFO - 'sessionrestore_no_auto_restore', 00:22:51 INFO - 'tabpaint']}, 00:22:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:22:51 INFO - 'ts_paint', 00:22:51 INFO - 'tpaint', 00:22:51 INFO - 'sessionrestore', 00:22:51 INFO - 'sessionrestore_no_auto_restore', 00:22:51 INFO - 'tabpaint']}, 00:22:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:22:51 INFO - 'tests': ['a11yr', 00:22:51 INFO - 'ts_paint', 00:22:51 INFO - 'tpaint', 00:22:51 INFO - 'sessionrestore', 00:22:51 INFO - 'sessionrestore_no_auto_restore', 00:22:51 INFO - 'tabpaint']}, 00:22:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:22:51 INFO - 'tests': ['a11yr', 00:22:51 INFO - 'ts_paint', 00:22:51 INFO - 'tpaint', 00:22:51 INFO - 'sessionrestore', 00:22:51 INFO - 'sessionrestore_no_auto_restore', 00:22:51 INFO - 'tabpaint']}, 00:22:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:22:51 INFO - 'tests': ['tsvgx', 00:22:51 INFO - 'tsvgr_opacity', 00:22:51 INFO - 'tart', 00:22:51 INFO - 'tscrollx', 00:22:51 INFO - 'cart']}, 00:22:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:22:51 INFO - 'tsvgr_opacity', 00:22:51 INFO - 'tart', 00:22:51 INFO - 'tscrollx', 00:22:51 INFO - 'cart']}, 00:22:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:22:51 INFO - 'talos_options': ['--disable-e10s'], 00:22:51 INFO - 'tests': ['tp5o']}, 00:22:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:22:51 INFO - 'tests': ['tp5o']}, 00:22:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:22:51 INFO - 'talos_options': ['--disable-e10s', 00:22:51 INFO - '--xperf_path', 00:22:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:22:51 INFO - 'tests': ['tp5n']}, 00:22:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:22:51 INFO - 'talos_options': ['--xperf_path', 00:22:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:22:51 INFO - 'tests': ['tp5n']}}, 00:22:51 INFO - 'talos.zip': {'path': '', 00:22:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:22:51 INFO - Running post-action listener: _resource_record_post_action 00:22:51 INFO - ##### 00:22:51 INFO - ##### Finished populate-webroot step (success) 00:22:51 INFO - ##### 00:22:51 INFO - ##### 00:22:51 INFO - ##### Running create-virtualenv step. 00:22:51 INFO - ##### 00:22:51 INFO - Running pre-action listener: _resource_record_pre_action 00:22:51 INFO - Running main action method: create_virtualenv 00:22:51 INFO - Creating virtualenv /builds/slave/test/build/venv 00:22:51 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 00:22:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:22:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:22:51 INFO - Using real prefix '/usr' 00:22:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:22:52 INFO - Installing distribute.............................................................................................................................................................................................done. 00:22:54 INFO - Installing pip.................done. 00:22:54 INFO - Return code: 0 00:22:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:22:54 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')]} 00:22:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:22:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:22:54 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')]} 00:22:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:22:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:22:54 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 0x7f733a586f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24372e0>, '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 0x23a3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a35d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1467874882.370867-2055276331', '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 00:22:54 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 00:22:54 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 00:22:54 INFO - Using env: {'DISPLAY': ':0', 00:22:54 INFO - 'HOME': '/home/cltbld', 00:22:54 INFO - 'LANG': 'en_US.UTF-8', 00:22:54 INFO - 'LANGUAGE': 'en_US:en', 00:22:54 INFO - 'LOGNAME': 'cltbld', 00:22:54 INFO - 'MAIL': '/var/mail/cltbld', 00:22:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:22:54 INFO - 'MOZ_NO_REMOTE': '1', 00:22:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:22:54 INFO - 'NO_EM_RESTART': '1', 00:22:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:22:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:22:54 INFO - 'PWD': '/builds/slave/test', 00:22:54 INFO - 'SHELL': '/bin/bash', 00:22:54 INFO - 'SHLVL': '1', 00:22:54 INFO - 'TERM': 'linux', 00:22:54 INFO - 'TMOUT': '86400', 00:22:54 INFO - 'USER': 'cltbld', 00:22:54 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1467874882.370867-2055276331', 00:22:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:22:54 INFO - '_': '/tools/buildbot/bin/python'} 00:22:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:22:54 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 00:22:54 INFO - Cleaning up... 00:22:54 INFO - Return code: 0 00:22:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:22:54 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')]} 00:22:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:22:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:22:54 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')]} 00:22:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:22:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:22:54 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 0x7f733a586f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24372e0>, '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 0x23a3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a35d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1467874882.370867-2055276331', '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 00:22:54 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 00:22:54 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 00:22:54 INFO - Using env: {'DISPLAY': ':0', 00:22:54 INFO - 'HOME': '/home/cltbld', 00:22:54 INFO - 'LANG': 'en_US.UTF-8', 00:22:54 INFO - 'LANGUAGE': 'en_US:en', 00:22:54 INFO - 'LOGNAME': 'cltbld', 00:22:54 INFO - 'MAIL': '/var/mail/cltbld', 00:22:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:22:54 INFO - 'MOZ_NO_REMOTE': '1', 00:22:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:22:54 INFO - 'NO_EM_RESTART': '1', 00:22:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:22:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:22:54 INFO - 'PWD': '/builds/slave/test', 00:22:54 INFO - 'SHELL': '/bin/bash', 00:22:54 INFO - 'SHLVL': '1', 00:22:54 INFO - 'TERM': 'linux', 00:22:54 INFO - 'TMOUT': '86400', 00:22:54 INFO - 'USER': 'cltbld', 00:22:54 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1467874882.370867-2055276331', 00:22:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:22:54 INFO - '_': '/tools/buildbot/bin/python'} 00:22:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:22:54 INFO - Downloading/unpacking psutil>=3.1.1 00:22:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:22:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:22:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:22:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:22:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:22:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:22:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:22:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:22:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:22:56 INFO - Installing collected packages: psutil 00:22:56 INFO - Running setup.py install for psutil 00:22:56 INFO - building 'psutil._psutil_linux' extension 00:22:56 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 00:22:56 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 00:22:56 INFO - building 'psutil._psutil_posix' extension 00:22:56 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 00:22:57 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 00:22:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:22:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:22:57 INFO - Successfully installed psutil 00:22:57 INFO - Cleaning up... 00:22:57 INFO - Return code: 0 00:22:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:22:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:22:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:22:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:22:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:22:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:22:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:22:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f733a586f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24372e0>, '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 0x23a3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a35d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1467874882.370867-2055276331', '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 00:22:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 00:22:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 00:22:57 INFO - Using env: {'DISPLAY': ':0', 00:22:57 INFO - 'HOME': '/home/cltbld', 00:22:57 INFO - 'LANG': 'en_US.UTF-8', 00:22:57 INFO - 'LANGUAGE': 'en_US:en', 00:22:57 INFO - 'LOGNAME': 'cltbld', 00:22:57 INFO - 'MAIL': '/var/mail/cltbld', 00:22:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:22:57 INFO - 'MOZ_NO_REMOTE': '1', 00:22:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:22:57 INFO - 'NO_EM_RESTART': '1', 00:22:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:22:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:22:57 INFO - 'PWD': '/builds/slave/test', 00:22:57 INFO - 'SHELL': '/bin/bash', 00:22:57 INFO - 'SHLVL': '1', 00:22:57 INFO - 'TERM': 'linux', 00:22:57 INFO - 'TMOUT': '86400', 00:22:57 INFO - 'USER': 'cltbld', 00:22:57 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1467874882.370867-2055276331', 00:22:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:22:57 INFO - '_': '/tools/buildbot/bin/python'} 00:22:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:22:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:22:57 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 00:22:57 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 00:22:57 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 00:22:57 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 00:22:57 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 00:22:57 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 00:22:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:22:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:22:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:22:59 INFO - Installing collected packages: mozsystemmonitor 00:22:59 INFO - Running setup.py install for mozsystemmonitor 00:22:59 INFO - Successfully installed mozsystemmonitor 00:22:59 INFO - Cleaning up... 00:22:59 INFO - Return code: 0 00:22:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:22:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:22:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:22:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:22:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:22:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:22:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:22:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f733a586f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24372e0>, '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 0x23a3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a35d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1467874882.370867-2055276331', '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 00:22:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 00:22:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 00:22:59 INFO - Using env: {'DISPLAY': ':0', 00:22:59 INFO - 'HOME': '/home/cltbld', 00:22:59 INFO - 'LANG': 'en_US.UTF-8', 00:22:59 INFO - 'LANGUAGE': 'en_US:en', 00:22:59 INFO - 'LOGNAME': 'cltbld', 00:22:59 INFO - 'MAIL': '/var/mail/cltbld', 00:22:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:22:59 INFO - 'MOZ_NO_REMOTE': '1', 00:22:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:22:59 INFO - 'NO_EM_RESTART': '1', 00:22:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:22:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:22:59 INFO - 'PWD': '/builds/slave/test', 00:22:59 INFO - 'SHELL': '/bin/bash', 00:22:59 INFO - 'SHLVL': '1', 00:22:59 INFO - 'TERM': 'linux', 00:22:59 INFO - 'TMOUT': '86400', 00:22:59 INFO - 'USER': 'cltbld', 00:22:59 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1467874882.370867-2055276331', 00:22:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:22:59 INFO - '_': '/tools/buildbot/bin/python'} 00:22:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:22:59 INFO - Downloading/unpacking jsonschema==2.5.1 00:22:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:22:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:22:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:22:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:22:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:22:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:23:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:23:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:23:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:23:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:23:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:23:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:23:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:23:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:23:01 INFO - Downloading functools32-3.2.3-2.tar.gz 00:23:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:23:01 INFO - warning: no files found matching '*.txt' 00:23:01 INFO - no previously-included directories found matching 'build' 00:23:01 INFO - no previously-included directories found matching 'dist' 00:23:01 INFO - no previously-included directories found matching '.git*' 00:23:01 INFO - Installing collected packages: jsonschema, functools32 00:23:02 INFO - Running setup.py install for functools32 00:23:02 INFO - warning: no files found matching '*.txt' 00:23:02 INFO - no previously-included directories found matching 'build' 00:23:02 INFO - no previously-included directories found matching 'dist' 00:23:02 INFO - no previously-included directories found matching '.git*' 00:23:02 INFO - Successfully installed jsonschema functools32 00:23:02 INFO - Cleaning up... 00:23:02 INFO - Return code: 0 00:23:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:23:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:23:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:23:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:23:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f733a586f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24372e0>, '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 0x23a3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a35d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1467874882.370867-2055276331', '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 00:23:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 00:23:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 00:23:02 INFO - Using env: {'DISPLAY': ':0', 00:23:02 INFO - 'HOME': '/home/cltbld', 00:23:02 INFO - 'LANG': 'en_US.UTF-8', 00:23:02 INFO - 'LANGUAGE': 'en_US:en', 00:23:02 INFO - 'LOGNAME': 'cltbld', 00:23:02 INFO - 'MAIL': '/var/mail/cltbld', 00:23:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:23:02 INFO - 'MOZ_NO_REMOTE': '1', 00:23:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:23:02 INFO - 'NO_EM_RESTART': '1', 00:23:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:23:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:23:02 INFO - 'PWD': '/builds/slave/test', 00:23:02 INFO - 'SHELL': '/bin/bash', 00:23:02 INFO - 'SHLVL': '1', 00:23:02 INFO - 'TERM': 'linux', 00:23:02 INFO - 'TMOUT': '86400', 00:23:02 INFO - 'USER': 'cltbld', 00:23:02 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1467874882.370867-2055276331', 00:23:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:23:02 INFO - '_': '/tools/buildbot/bin/python'} 00:23:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:23:02 INFO - Downloading/unpacking blobuploader==1.2.4 00:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:23:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:23:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:23:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:23:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:23:04 INFO - Downloading blobuploader-1.2.4.tar.gz 00:23:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:23:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:23:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:23:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:23:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:23:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:23:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:23:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:23:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:23:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:23:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:23:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:23:05 INFO - Downloading docopt-0.6.1.tar.gz 00:23:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:23:05 INFO - Installing collected packages: blobuploader, requests, docopt 00:23:05 INFO - Running setup.py install for blobuploader 00:23:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:23:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:23:05 INFO - Running setup.py install for requests 00:23:05 INFO - Running setup.py install for docopt 00:23:05 INFO - Successfully installed blobuploader requests docopt 00:23:05 INFO - Cleaning up... 00:23:05 INFO - Return code: 0 00:23:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:23:05 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')]} 00:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:23:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:05 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')]} 00:23:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:23:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:05 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 0x7f733a586f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24372e0>, '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 0x23a3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a35d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1467874882.370867-2055276331', '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 00:23:05 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 00:23:05 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 00:23:05 INFO - Using env: {'DISPLAY': ':0', 00:23:05 INFO - 'HOME': '/home/cltbld', 00:23:05 INFO - 'LANG': 'en_US.UTF-8', 00:23:05 INFO - 'LANGUAGE': 'en_US:en', 00:23:05 INFO - 'LOGNAME': 'cltbld', 00:23:05 INFO - 'MAIL': '/var/mail/cltbld', 00:23:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:23:05 INFO - 'MOZ_NO_REMOTE': '1', 00:23:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:23:05 INFO - 'NO_EM_RESTART': '1', 00:23:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:23:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:23:05 INFO - 'PWD': '/builds/slave/test', 00:23:05 INFO - 'SHELL': '/bin/bash', 00:23:05 INFO - 'SHLVL': '1', 00:23:05 INFO - 'TERM': 'linux', 00:23:05 INFO - 'TMOUT': '86400', 00:23:05 INFO - 'USER': 'cltbld', 00:23:05 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1467874882.370867-2055276331', 00:23:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:23:05 INFO - '_': '/tools/buildbot/bin/python'} 00:23:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:23:05 INFO - Running setup.py (path:/tmp/pip-O_gAnP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:23:05 INFO - Running setup.py (path:/tmp/pip-SdXJdO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:23:06 INFO - Running setup.py (path:/tmp/pip-qJnoti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:23:06 INFO - Running setup.py (path:/tmp/pip-gMV37n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:23:06 INFO - Running setup.py (path:/tmp/pip-Iv1M1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:23:06 INFO - Running setup.py (path:/tmp/pip-AgmYiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:23:06 INFO - Running setup.py (path:/tmp/pip-UwSg0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:23:06 INFO - Running setup.py (path:/tmp/pip-W1MuZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:23:06 INFO - Running setup.py (path:/tmp/pip-a95gMk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:23:06 INFO - Running setup.py (path:/tmp/pip-TOhY16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:23:06 INFO - Running setup.py (path:/tmp/pip-dDUUIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:23:06 INFO - Running setup.py (path:/tmp/pip-bVHuwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:23:06 INFO - Running setup.py (path:/tmp/pip-Ub0gqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:23:06 INFO - Running setup.py (path:/tmp/pip-o3cFqu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:23:06 INFO - Running setup.py (path:/tmp/pip-P2fg_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:23:06 INFO - Running setup.py (path:/tmp/pip-GOxcMM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:23:07 INFO - Running setup.py (path:/tmp/pip-pWSzOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:23:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:23:07 INFO - Running setup.py install for manifestparser 00:23:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:23:07 INFO - Running setup.py install for mozcrash 00:23:07 INFO - Running setup.py install for mozdebug 00:23:07 INFO - Running setup.py install for mozdevice 00:23:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:23:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:23:07 INFO - Running setup.py install for mozfile 00:23:07 INFO - Running setup.py install for mozhttpd 00:23:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:23:07 INFO - Running setup.py install for mozinfo 00:23:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:23:07 INFO - Running setup.py install for mozInstall 00:23:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:23:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:23:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:23:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:23:07 INFO - Running setup.py install for mozleak 00:23:08 INFO - Running setup.py install for mozlog 00:23:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:23:08 INFO - Running setup.py install for moznetwork 00:23:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:23:08 INFO - Running setup.py install for mozprocess 00:23:08 INFO - Running setup.py install for mozprofile 00:23:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:23:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:23:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:23:08 INFO - Running setup.py install for mozrunner 00:23:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:23:08 INFO - Running setup.py install for mozscreenshot 00:23:08 INFO - Running setup.py install for moztest 00:23:08 INFO - Running setup.py install for mozversion 00:23:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:23:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:23:08 INFO - Cleaning up... 00:23:08 INFO - Return code: 0 00:23:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:23: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')]} 00:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:23:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23: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')]} 00:23:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:23:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:08 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 0x7f733a586f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24372e0>, '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 0x23a3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a35d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1467874882.370867-2055276331', '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 00:23:08 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 00:23:08 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 00:23:08 INFO - Using env: {'DISPLAY': ':0', 00:23:08 INFO - 'HOME': '/home/cltbld', 00:23:08 INFO - 'LANG': 'en_US.UTF-8', 00:23:08 INFO - 'LANGUAGE': 'en_US:en', 00:23:08 INFO - 'LOGNAME': 'cltbld', 00:23:08 INFO - 'MAIL': '/var/mail/cltbld', 00:23:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:23:08 INFO - 'MOZ_NO_REMOTE': '1', 00:23:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:23:08 INFO - 'NO_EM_RESTART': '1', 00:23:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:23:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:23:08 INFO - 'PWD': '/builds/slave/test', 00:23:08 INFO - 'SHELL': '/bin/bash', 00:23:08 INFO - 'SHLVL': '1', 00:23:08 INFO - 'TERM': 'linux', 00:23:08 INFO - 'TMOUT': '86400', 00:23:08 INFO - 'USER': 'cltbld', 00:23:08 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1467874882.370867-2055276331', 00:23:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:23:08 INFO - '_': '/tools/buildbot/bin/python'} 00:23:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:23:09 INFO - Running setup.py (path:/tmp/pip-0oMKZ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:23:09 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)) 00:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:23:09 INFO - Running setup.py (path:/tmp/pip-Zd6XFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:23:09 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)) 00:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:23:09 INFO - Running setup.py (path:/tmp/pip-OI4kHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:23:09 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)) 00:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:23:09 INFO - Running setup.py (path:/tmp/pip-OC6A3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:23:09 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)) 00:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:23:09 INFO - Running setup.py (path:/tmp/pip-G1gmjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:23:09 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)) 00:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:23:09 INFO - Running setup.py (path:/tmp/pip-wXfYOD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:23:09 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)) 00:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:23:09 INFO - Running setup.py (path:/tmp/pip-tKOmhR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:23:09 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)) 00:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:23:09 INFO - Running setup.py (path:/tmp/pip-lHTDOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:23:09 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)) 00:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:23:09 INFO - Running setup.py (path:/tmp/pip-SwxJsg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:23:09 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)) 00:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:23:09 INFO - Running setup.py (path:/tmp/pip-1YbBkU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:23:09 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)) 00:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:23:09 INFO - Running setup.py (path:/tmp/pip-RKhhSc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:23:09 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)) 00:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:23:09 INFO - Running setup.py (path:/tmp/pip-4_kVFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:23:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 00:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:23:10 INFO - Running setup.py (path:/tmp/pip-aRLHpu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:23:10 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)) 00:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:23:10 INFO - Running setup.py (path:/tmp/pip-C4bYU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:23:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 00:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:23:10 INFO - Running setup.py (path:/tmp/pip-tEctmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:23:10 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)) 00:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:23:10 INFO - Running setup.py (path:/tmp/pip-T9_bwT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:23:10 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)) 00:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:23:10 INFO - Running setup.py (path:/tmp/pip-6SMtD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:23:10 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)) 00:23:10 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)) 00:23:10 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)) 00:23:10 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)) 00:23:10 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)) 00:23:10 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)) 00:23:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:23:10 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 00:23:10 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 00:23:10 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 00:23:10 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 00:23:10 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 00:23:10 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 00:23:12 INFO - Downloading blessings-1.6.tar.gz 00:23:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:23:12 INFO - Installing collected packages: blessings 00:23:12 INFO - Running setup.py install for blessings 00:23:12 INFO - Successfully installed blessings 00:23:12 INFO - Cleaning up... 00:23:12 INFO - Return code: 0 00:23:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:23:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:23:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:23:12 INFO - Reading from file tmpfile_stdout 00:23:12 INFO - Current package versions: 00:23:12 INFO - argparse == 1.2.1 00:23:12 INFO - blessings == 1.6 00:23:12 INFO - blobuploader == 1.2.4 00:23:12 INFO - docopt == 0.6.1 00:23:12 INFO - functools32 == 3.2.3-2 00:23:12 INFO - jsonschema == 2.5.1 00:23:12 INFO - manifestparser == 1.1 00:23:12 INFO - mozInstall == 1.12 00:23:12 INFO - mozcrash == 0.17 00:23:12 INFO - mozdebug == 0.1 00:23:12 INFO - mozdevice == 0.48 00:23:12 INFO - mozfile == 1.2 00:23:12 INFO - mozhttpd == 0.7 00:23:12 INFO - mozinfo == 0.9 00:23:12 INFO - mozleak == 0.1 00:23:12 INFO - mozlog == 3.2 00:23:12 INFO - moznetwork == 0.27 00:23:12 INFO - mozprocess == 0.22 00:23:12 INFO - mozprofile == 0.28 00:23:12 INFO - mozrunner == 6.11 00:23:12 INFO - mozscreenshot == 0.1 00:23:12 INFO - mozsystemmonitor == 0.3 00:23:12 INFO - moztest == 0.7 00:23:12 INFO - mozversion == 1.4 00:23:12 INFO - psutil == 3.1.1 00:23:12 INFO - requests == 1.2.3 00:23:12 INFO - wsgiref == 0.1.2 00:23:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:23:12 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')]} 00:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:23:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:12 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')]} 00:23:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:23:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:12 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 0x7f733a586f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24372e0>, '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 0x23a3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a35d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1467874882.370867-2055276331', '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 00:23:12 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 00:23:12 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 00:23:12 INFO - Using env: {'DISPLAY': ':0', 00:23:12 INFO - 'HOME': '/home/cltbld', 00:23:12 INFO - 'LANG': 'en_US.UTF-8', 00:23:12 INFO - 'LANGUAGE': 'en_US:en', 00:23:12 INFO - 'LOGNAME': 'cltbld', 00:23:12 INFO - 'MAIL': '/var/mail/cltbld', 00:23:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:23:12 INFO - 'MOZ_NO_REMOTE': '1', 00:23:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:23:12 INFO - 'NO_EM_RESTART': '1', 00:23:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:23:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:23:12 INFO - 'PWD': '/builds/slave/test', 00:23:12 INFO - 'SHELL': '/bin/bash', 00:23:12 INFO - 'SHLVL': '1', 00:23:12 INFO - 'TERM': 'linux', 00:23:12 INFO - 'TMOUT': '86400', 00:23:12 INFO - 'USER': 'cltbld', 00:23:12 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1467874882.370867-2055276331', 00:23:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:23:12 INFO - '_': '/tools/buildbot/bin/python'} 00:23:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:23:12 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)) 00:23:12 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)) 00:23:12 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)) 00:23:12 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)) 00:23:12 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)) 00:23:12 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)) 00:23:12 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)) 00:23:12 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)) 00:23:12 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)) 00:23:12 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)) 00:23:12 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)) 00:23:12 INFO - Cleaning up... 00:23:12 INFO - Return code: 0 00:23:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:23:12 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')]} 00:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:23:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:12 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')]} 00:23:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:23:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:12 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 0x7f733a586f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24372e0>, '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 0x23a3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a35d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1467874882.370867-2055276331', '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 00:23:12 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 00:23:12 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 00:23:12 INFO - Using env: {'DISPLAY': ':0', 00:23:12 INFO - 'HOME': '/home/cltbld', 00:23:12 INFO - 'LANG': 'en_US.UTF-8', 00:23:12 INFO - 'LANGUAGE': 'en_US:en', 00:23:12 INFO - 'LOGNAME': 'cltbld', 00:23:12 INFO - 'MAIL': '/var/mail/cltbld', 00:23:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:23:12 INFO - 'MOZ_NO_REMOTE': '1', 00:23:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:23:12 INFO - 'NO_EM_RESTART': '1', 00:23:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:23:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:23:12 INFO - 'PWD': '/builds/slave/test', 00:23:12 INFO - 'SHELL': '/bin/bash', 00:23:12 INFO - 'SHLVL': '1', 00:23:12 INFO - 'TERM': 'linux', 00:23:12 INFO - 'TMOUT': '86400', 00:23:12 INFO - 'USER': 'cltbld', 00:23:12 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1467874882.370867-2055276331', 00:23:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:23:12 INFO - '_': '/tools/buildbot/bin/python'} 00:23:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:23:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:23:13 INFO - Cleaning up... 00:23:13 INFO - Return code: 0 00:23:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 00:23:13 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')]} 00:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:23:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:13 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')]} 00:23:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:23:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:13 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 0x7f733a586f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24372e0>, '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 0x23a3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a35d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1467874882.370867-2055276331', '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 00:23:13 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 00:23:13 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 00:23:13 INFO - Using env: {'DISPLAY': ':0', 00:23:13 INFO - 'HOME': '/home/cltbld', 00:23:13 INFO - 'LANG': 'en_US.UTF-8', 00:23:13 INFO - 'LANGUAGE': 'en_US:en', 00:23:13 INFO - 'LOGNAME': 'cltbld', 00:23:13 INFO - 'MAIL': '/var/mail/cltbld', 00:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:23:13 INFO - 'MOZ_NO_REMOTE': '1', 00:23:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:23:13 INFO - 'NO_EM_RESTART': '1', 00:23:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:23:13 INFO - 'PWD': '/builds/slave/test', 00:23:13 INFO - 'SHELL': '/bin/bash', 00:23:13 INFO - 'SHLVL': '1', 00:23:13 INFO - 'TERM': 'linux', 00:23:13 INFO - 'TMOUT': '86400', 00:23:13 INFO - 'USER': 'cltbld', 00:23:13 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1467874882.370867-2055276331', 00:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:23:13 INFO - '_': '/tools/buildbot/bin/python'} 00:23:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:23:13 INFO - Downloading/unpacking flake8 00:23:13 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 00:23:13 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 00:23:13 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 00:23:13 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 00:23:13 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 00:23:13 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 00:23:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 00:23:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 00:23:15 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 00:23:15 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 00:23:15 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 00:23:15 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 00:23:15 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 00:23:15 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 00:23:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 00:23:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 00:23:15 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 00:23:15 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 00:23:15 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 00:23:15 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 00:23:15 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 00:23:15 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 00:23:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 00:23:15 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 00:23:15 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 00:23:15 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 00:23:15 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 00:23:15 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 00:23:15 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 00:23:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 00:23:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:23:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:23:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:23:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:23:16 INFO - no previously-included directories found matching 'docs/_build' 00:23:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 00:23:16 INFO - Running setup.py install for pep8 00:23:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:23:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:23:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:23:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:23:16 INFO - no previously-included directories found matching 'docs/_build' 00:23:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 00:23:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 00:23:16 INFO - Cleaning up... 00:23:16 INFO - Return code: 0 00:23:16 INFO - Running post-action listener: _resource_record_post_action 00:23:16 INFO - Running post-action listener: _start_resource_monitoring 00:23:16 INFO - Starting resource monitoring. 00:23:16 INFO - ##### 00:23:16 INFO - ##### Finished create-virtualenv step (success) 00:23:16 INFO - ##### 00:23:16 INFO - ##### 00:23:16 INFO - ##### Running install step. 00:23:16 INFO - ##### 00:23:16 INFO - Running pre-action listener: _resource_record_pre_action 00:23:16 INFO - Running main action method: install 00:23:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:23:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:23:16 INFO - Reading from file tmpfile_stdout 00:23:16 INFO - Detecting whether we're running mozinstall >=1.0... 00:23:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:23:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:23:16 INFO - Reading from file tmpfile_stdout 00:23:16 INFO - Output received: 00:23:16 INFO - Usage: mozinstall [options] installer 00:23:16 INFO - Options: 00:23:16 INFO - -h, --help show this help message and exit 00:23:16 INFO - -d DEST, --destination=DEST 00:23:16 INFO - Directory to install application into. [default: 00:23:16 INFO - "/builds/slave/test"] 00:23:16 INFO - --app=APP Application being installed. [default: firefox] 00:23:16 INFO - mkdir: /builds/slave/test/build/application 00:23:16 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'] 00:23:16 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 00:23:32 INFO - Reading from file tmpfile_stdout 00:23:32 INFO - Output received: 00:23:32 INFO - /builds/slave/test/build/application/firefox/firefox 00:23:32 INFO - Running post-action listener: _resource_record_post_action 00:23:32 INFO - ##### 00:23:32 INFO - ##### Finished install step (success) 00:23:32 INFO - ##### 00:23:32 INFO - ##### 00:23:32 INFO - ##### Running run-tests step. 00:23:32 INFO - ##### 00:23:32 INFO - Running pre-action listener: _resource_record_pre_action 00:23:32 INFO - Running main action method: run_tests 00:23:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:23:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:23:32 INFO - Python 2.7.3 00:23:32 INFO - Return code: 0 00:23:32 INFO - grabbing minidump binary from tooltool 00:23:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:23:32 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 0x24372e0>, '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 0x23a3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a35d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:23:32 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 00:23:32 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 00:23:32 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 00:23:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:23:32 INFO - Return code: 0 00:23:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:23:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:23:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:23:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:23:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:23:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 00:23:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 00:23:33 INFO - Return code: 0 00:23:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fBi9cm12SXaq4eVj2OyQLg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 00:23:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fBi9cm12SXaq4eVj2OyQLg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 00:23:33 INFO - Using env: {'DISPLAY': ':0', 00:23:33 INFO - 'HOME': '/home/cltbld', 00:23:33 INFO - 'LANG': 'en_US.UTF-8', 00:23:33 INFO - 'LANGUAGE': 'en_US:en', 00:23:33 INFO - 'LOGNAME': 'cltbld', 00:23:33 INFO - 'MAIL': '/var/mail/cltbld', 00:23:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:23:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:23:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:23:33 INFO - 'MOZ_NO_REMOTE': '1', 00:23:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:23:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:23:33 INFO - 'NO_EM_RESTART': '1', 00:23:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:23:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:23:33 INFO - 'PWD': '/builds/slave/test', 00:23:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:23:33 INFO - 'SHELL': '/bin/bash', 00:23:33 INFO - 'SHLVL': '1', 00:23:33 INFO - 'TERM': 'linux', 00:23:33 INFO - 'TMOUT': '86400', 00:23:33 INFO - 'USER': 'cltbld', 00:23:33 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1467874882.370867-2055276331', 00:23:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:23:33 INFO - '_': '/tools/buildbot/bin/python'} 00:23:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fBi9cm12SXaq4eVj2OyQLg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 00:23:33 INFO - mozversion application_buildid: 20160706214423 00:23:33 INFO - mozversion application_changeset: a9e572ac1d5e4df9aebf5c9860bb415b8dc0a60d 00:23:33 INFO - mozversion application_display_name: FirefoxDeveloperEdition 00:23:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:23:33 INFO - mozversion application_name: Firefox 00:23:33 INFO - mozversion application_remotingname: firefox-dev 00:23:33 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 00:23:33 INFO - mozversion application_vendor: Mozilla 00:23:33 INFO - mozversion application_version: 49.0a2 00:23:33 INFO - mozversion platform_buildid: 20160706214423 00:23:33 INFO - mozversion platform_changeset: a9e572ac1d5e4df9aebf5c9860bb415b8dc0a60d 00:23:33 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 00:23:33 INFO - mozversion platform_version: 49.0a2 00:23:33 INFO - using testdate: 1467876213 00:23:33 INFO - actual date: 1467876213 00:23:33 INFO - starting webserver on 'localhost:59102' 00:23:33 INFO - SUITE-START | Running 2 tests 00:23:33 INFO - TEST-START | dromaeo_css 00:23:33 INFO - operating with platform_type : linux_ 00:23:33 INFO - Initialising browser for dromaeo_css test... 00:23:33 INFO - TEST-INFO | started process 16892 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI4Os7e/profile http://localhost:59102/getInfo.html) 00:23:37 INFO - PROCESS | 16892 | __metrics Screen width/height:1600/1200 00:23:37 INFO - PROCESS | 16892 | colorDepth:24 00:23:37 INFO - PROCESS | 16892 | Browser inner width/height: 1024/697 00:23:37 INFO - PROCESS | 16892 | __metrics 00:23:38 ERROR - PROCESS | 16892 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 00:23:39 INFO - TEST-INFO | 16892: exit 0 00:23:39 INFO - Browser initialized. 00:23:39 INFO - Running cycle 1/1 for dromaeo_css test... 00:23:39 INFO - TEST-INFO | started process 17018 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI4Os7e/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:23:51 INFO - PROCESS | 17018 | RSS: Main: 156147712 00:23:51 INFO - PROCESS | 17018 | 00:24:40 INFO - PROCESS | 17018 | 1467876280741 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] 00:26:48 INFO - PROCESS | 17018 | Cycle 1(1): loaded http://localhost:59102/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59102/tests/dromaeo/cssquery-ext.html) 00:26:49 INFO - PROCESS | 17018 | RSS: Main: 158519296 00:26:49 INFO - PROCESS | 17018 | 00:29:51 INFO - PROCESS | 17018 | Cycle 1(1): loaded http://localhost:59102/tests/dromaeo/cssquery-ext.html (next: http://localhost:59102/tests/dromaeo/cssquery-jquery.html) 00:29:52 INFO - PROCESS | 17018 | RSS: Main: 156987392 00:29:52 INFO - PROCESS | 17018 | 00:32:54 INFO - PROCESS | 17018 | Cycle 1(1): loaded http://localhost:59102/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59102/tests/dromaeo/cssquery-mootools.html) 00:32:54 INFO - PROCESS | 17018 | RSS: Main: 155586560 00:32:54 INFO - PROCESS | 17018 | 00:35:56 INFO - PROCESS | 17018 | Cycle 1(1): loaded http://localhost:59102/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59102/tests/dromaeo/cssquery-prototype.html) 00:35:57 INFO - PROCESS | 17018 | RSS: Main: 158183424 00:35:57 INFO - PROCESS | 17018 | 00:38:59 INFO - PROCESS | 17018 | Cycle 1(1): loaded http://localhost:59102/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59102/tests/dromaeo/cssquery-yui.html) 00:38:59 INFO - PROCESS | 17018 | RSS: Main: 156995584 00:38:59 INFO - PROCESS | 17018 | 00:42:02 INFO - PROCESS | 17018 | Cycle 1(1): loaded http://localhost:59102/tests/dromaeo/cssquery-yui.html (next: http://localhost:59102/tests/dromaeo/cssquery-dojo.html) 00:42:02 INFO - PROCESS | 17018 | RSS: Main: 158531584 00:42:02 INFO - PROCESS | 17018 | 00:42:02 INFO - PROCESS | 17018 | __start_tp_report 00:42:02 INFO - PROCESS | 17018 | _x_x_mozilla_page_load 00:42:02 INFO - PROCESS | 17018 | _x_x_mozilla_page_load_details 00:42:02 INFO - PROCESS | 17018 | |i|pagename|runs| 00:42:02 INFO - PROCESS | 17018 | |0;dojo.html;3360.26074263662;3403.52350670906;3428.1086917401485;3435.5533780608516;3437.570303712035;5705.885882282357;5734.713264336782;5759.251297331351;5790.160426738121;5825.475707186352;5802.419758024195;5867.970660146704;5873.706314684259;5876.147958546019;5886.028805247129;5255.789768409259;5257.605679574028;5274.4461831507715;5315.0432922074015;5337.386200586924;5214.035403450355;5215.86960325993;5250.921236181461;5355.2770375999135;5371.57027437804;5226;5276.1030624793875;5329.25390445338;5338.359396872381;5346.946530534684;5341.225522299264;5397.163439666858;5399.893021930495;5401.891962160774;5426.077566813651;5049.293098966147;5254.842354729364;5299.8410047698635;5319.813806516753;5344.652597581145;5585.692786896719;5625.746841392147;5642.4075472075665;5669.914951275693;5702.942970570282;6197.845053873644;6227.283862355796;6253.468455181315;6255.6246625202175;6270.46701030413;6083.270007599072;6150.231221097363;6280.717367718464;6289.1195232667005;6321.936780632181;5791.073428251501;5799.623024503394;5867.823965281048;5871.14868344092;5901.8819623607715;6325.936740632535;6334.144890439732;6369.267534233622;6376.744930202833;6410.775622853178;5961.731722072431;6080.665563393967;6131.202943617391;6134.325224225332;6156.846078847975;6292.4966002719675;6294.213223347082;6297.023961286008;6313.210848643919;6325.557210995278;6127.417895299939;6241.96879015602;6274.403931626488;6287.402696743893;6287.591306565058;5938.6139900907165;6132.8756461173125;6168.136460895478;6218;6262.624242545462;4786.2581299898575;4789.066132104276;4792.400949881265;4811.182099043171;4828.324034635154;4262.509811371732;4276.978615106905;4290.82836686529;4296.334068219431;4315.525292217853;5813.476787089182;5987.940120598825;5992.370801065826;6041.426064523863;6050.092486127116;6224.844378890564;6246.968765156236;6258.561900667;6289.528285378615;6341.936580634227;5800.53595712342;6060.545459090497;6080.665563393967;6096.420840020191;6103.542234332443;5294.708791016454;5325.920111198335;5350.3312085989255;5362.678239305654;5368.624196306221;6487.578307410004;6522.315156908551;6551.705173267119;6579.440747536513;6589.769358072444;6024.819255422344;6143.204841796883;6189.473894718999;6219.40915613016;6230.813075607739;6460.580062295936;6560.803175904731;6613.43785778195;6614.239362473185;6622.953441417002;6117.908231376444;6157.938420615916;6165.630062196283;6194.0708893666315;6212.627242365473;6026.728797204224;6215.720292586754;6229.688515574294;6266.248050234001;6297.4017468340435;6162.691865406801;6175.042868355412;6193.876122477435;6197.566170368031;6208;6180.980138277134;6185.84535386619;6206.503479721521;6211.81364559064;6213.347598502092;5824.767009319579;5968.22413086296;6004.819855404345;6057.727402266821;6080.422359875804;6129.662868542273;6134.202553668173;6151.84620384494;6177.073438984188;6177.444030037318;6027.4876635484725;6038;6052.6973651316375;6054.243219597551;6057.7879774207695 00:42:02 INFO - PROCESS | 17018 | |1;ext.html;591.5681552466699;647.6243778608408;648.8248172993292;663.7477758451788;676.2257215488269;38307;42783.35824962628;43157;43236.78381608091;43255;44772;44869.7756511217;45093.77453112738;45334;45470.31794523085;8785.912140878589;8815.118488151165;8842;8946.373753837233;8966.596503157374;8693.5218562979;8808.779780505474;8837.38138330317;8857.202851743341;8875.112488751138;8844.38089333747;8894.955525222396;8933.821323573557;8966.372353935227;8978.057303983085;8815.382923195379;8830.161134692195;8854.424462409956;8898.4660920345;8906.33202509808;8517.701880434217;8748.387612867102;8758.605862736129;8770.12298770118;8805.295576353876;40585.79707101475;40749.59250407488;40984;40984.1803163938;41126.38310425346;3665.193657395369;3788.886333410002;3801.7148713846573;3804.505414296124;4083.7141400102005;33335.49996750051;33700.32599348024;33810.49284260738;33826;33999.320013599834;4463.620592249663;4504.662150338738;4508.45898492183;4538.319252112176;4540.046590216059;378975;380411;380804;381172.0941395303;384054;63241;63835;63837.72324553576;63913;63998.36001640017;39629.40555891664;40113.799431002655;40302.39546406806;41932.37101443481;41991;17580.384686536167;17601.647967040586;17665.116744163;17669.293228270726;17721.556961075818;13674.31628418575;13691;13769.862301377058;13776.173429594257;13800.585982420544;20706.792932070788;21102.155913763585;21147;21159.57680846405;21195.8940205298;7465.776026719207;7479.364254038359;7517.323440890237;7639.85402189676;7776.7278145264645;1021.1626466297713;1142;1169.92980421175;1202.7955247607927;1223.804191329383;33082.83458582692;33349.833250834075;33464.16339591481;33672.1581960448;34010.82994585011;1167.5271515036425;1168.9006434453167;1183.7632473505334;1232.5870833270776;1256.5476428485738;16395;16437.26032328548;16488.6702265954;16525.33898644065;16892.239849206817;611604;1003237;1023069;1024433;1144954;63883.6805815968;63948;64070.35929640737;64283;64717.67641161764;1476.0922032949873;1493.6116609681344;1510.6752048309665;1515.272669118829;1515.7423238049557;32776.34447311088;33788.155296117795;33951.830240848634;34023.4896476558;34685.47971780375;54842.451575483734;54980;55520.72239638776;55555.16667249914;55575.444245557024;522323;522926;522929;524113;526446;30559.847200764743;31310.686893130776;31465.37069258648;31508.054758357284;31540.684593154692;49826.25260621021;49959.75020124876;51268.230976534636;51565.742171288905;55574.72212638911;43748.56251437445;44764.10471790611;45117.32324015077;45540.54459455496;45662.31506527338;43510;44118;44134;44662.77668611636;44771;42933.355999659405;43194.35208471813;43575.78212109046;44625.776871115435;44647.33029004503;36537;37301.81349093237;37684;38360.42459363167;39699.60300396959;29746.702532975258;29863.402731945673;30149;30338.84830575833;30614.693853062076 00:42:02 INFO - PROCESS | 17018 | |2;jquery.html;382.91767270036945;382.98659546915866;389.1671822300277;401.31775980832595;408.1530823541151;18951.620967580657;20353.389398318075;21092.472688182803;21339.786602133972;21342.253021144264;19705.802941970574;20104.09531571079;20647.380578582666;20662.07020684069;20695.275665351717;5619.4942455178925;5639.577031722617;5785.508231800302;5849.151872978416;5854.531637468992;5626.971865140668;5683.54531637468;5820.941790582104;5825.271841019872;5825.912611310834;5760.53915686744;5763.193152958589;5791.160281759164;5796.855078623026;5800.593958422912;5693.316801983768;5717.799877004327;5745.310562732478;5752.05091159956;5754;5122.820701275475;5137.049645815536;5140.511651393112;5150.459201783796;5151.948480515184;20599.279025234195;21621.783782162292;21679.24122655715;22909.312720618407;24198.758012419825;2197.507438443463;2325.209428794218;2398.760123987605;2699.4736026474843;2735.712750161244;9826.754331141707;9887.950560247153;9919.50402479873;10077.647282345082;12744.299063551502;1964.7052942058806;2063.9793602064087;2071.5028393185526;2083.802038806311;2118;85830.570847146;87350.56324718399;87838.99999999936;90101;90380.54809725909;11465.369404682822;11695.883041169649;11741.236819606698;11865.703357415961;11937.487856762054;16766.66466670684;16802.99182049081;16837.74743378826;16877.987320760792;16887.746683799753;8531.573421328909;8649.956750216334;8796.164364385373;8802.887307046263;8859.3798434109;8343.8331233375;8432.662693492191;8442.282405995558;8468.237858592756;8640.611172497252;4832.613390928717;5030.622703297267;5115.18157094863;5136.332276803992;5193.195054766517;1912.024867317678;2063.1541068161982;2073.1914553324214;2083.125087463269;2147.785221477871;422.75057715947736;422.92387370273644;431.76900358308154;971.4414211828228;1143.188336281233;11291.209615326849;11363.261388009752;11511.597094101666;11511.769764604662;11533.423328833525;432.9004329004347;444.6909397968381;447.0700942040548;448.22009703116345;448.94837093733986;6117.480014198843;6143.170671959318;6173.969130154321;6228.159198508143;6236.688165591793;485204;506569;515938;527103;545268;96047.51976240214;97541.5122924395;99927.50036249918;100435.02743214273;101576.49211753895;437.00145168290305;438.0887753472833;438.51982079622763;441.5672640811958;441.78288814316994;10558.260921735711;10687.946560267459;10855.511501982272;10867.239293249397;10878.238523303293;39877.21473423092;40031.59968400279;40059.39910901397;40396.3940540898;41176;57509.712451437474;59526;59618;61009.69495152496;61928.69035654793;8159.061707903667;8187.26314631686;8191.754247372588;8574.22831945128;8584.613692383982;11337.773244535229;13023.804642930174;13300.600981970556;13390.330483475593;13613.455461781417;11276.661700149009;11826.586069487526;11902.464389102339;11965.820512692142;12166.39168041612;11323.32060076398;11483.712907177387;11505.194636375374;11515.30908145514;11701.473433695333;8317;11998.340091295062;12211.938940305241;12229;12377;7870.488418253024;7963.800904977422;7967.601619918865;8394.328453723809;9080.001199867876;8705.781190633443;12350.876491234972;12363.32001739913;12387.566435174725;12510.437030333838 00:42:02 INFO - PROCESS | 17018 | |3;mootools.html;1549.9457518986835;1579.6208909861632;1790.1854656131454;1877.314780105262;1918.894460804656;8709.346798990086;9158.58786354614;9546.140847323739;10221.897781022188;10233.181345492361;9298.95350523248;9381.343305968569;9652.37259578127;9698.951505242481;9774.413535187876;2427.017058091476;2469.7898029965368;2473.4434752180705;2479.727230004698;2483.8137139714504;2408.6387041943763;2495.026939493599;2507.147569826259;2512.4221429071326;2516.7105782835024;2403.6514705367713;2439.42673471734;2465.2480993297036;2469.753024697534;2477.182529765182;2397.436602398426;2400.1599440195964;2402.759724027601;2434.6591477193206;2442.6091825307867;2402.68765060541;2406.6149416093517;2413.6500207469817;2414.7102347718387;2419.2863105383776;9695.951520242425;9775.853362199572;9779.315447918649;9779.657711980117;9790.853137202948;5740.684262365568;5886.6173698709445;5896.145058966469;5953.226080609536;5965.642061476326;3539.2744487380023;3642.908927276813;3679.5400574928135;3702.241040586673;3703.7962912039825;1249.650097972569;1250.8311377963948;1258.4840215511597;1278.0350835119425;1306.3533550892369;13889.513867014706;14061.086029408056;14063.859361406357;14100.506482273175;14122;5105.310783044241;5148.639595228298;5228.4510126436935;5281.419043905167;5360;11844.940775296069;11911.940440297743;11947.402629868471;11952.223105498115;12062.396880156133;5750.597458177971;5821.825345239649;5862.091375836752;5862.912056319158;5887.087501437284;4548.385967894358;5182.119039763249;5261.5264626183825;5275.050490911673;5280.128778751463;4397.868063958086;4435.778211089432;4487.304467807495;4492.326151077299;4502.954970450253;1365.1263191557412;1385.56354748256;1394.42828440341;1399.468202083202;1410.964725881861;992.9900700993043;1028.4240825137947;1039.7088815131776;1040.5629635552934;1045.1586472889246;6352.428281454691;6449.064885591563;6527;6564.7374105036215;6585.1439312889015;489.6401145158306;504.4955044955045;506.4606194402949;508.3594670714926;509.4879645955865;4549.385832912581;4655.930161047587;4659.34769132315;4684.156851766715;4744.786484608201;12105.09211809118;12230.816537751942;12581.496740130293;12599.244045357307;12607.87392126067;12299.93850030744;12356.876431235572;12384.256944583354;12420.316882571546;12525.43635536403;9179.954100229455;9366.578503967474;9419.623215071457;9433.198178154933;9446.433214007182;6324.3991820776955;6390.073439351175;6496.220453545605;6669.166354205724;6709.329067093252;11153.888461115284;11245.550177993116;11379.658610241706;11454.427278635869;11554.422278885853;11648.359340236368;11748.530058797553;11772.17594768358;11857.16999810005;11898.405079746151;8465.111163327761;8548.187922147386;8699.217070463435;8740.78148046304;8751.956240218758;9342.065793420603;9354.812903741751;9360.765980850534;9383.812323753624;9435.386699864486;8540.359473039423;8660.523671198145;8716.694915677921;8743.781405464913;8886.688965886164;8114.553699546345;8127.552984585905;8177.345812335118;8238.711645092393;8431.915680843113;7831.177726338652;7876.173001834725;7907.683692652229;7955.960220198862;8107.3108785753875;5568.610197286151;5853.268341457318;5880.794172203952;5981.491573216152;6014.849628759316;5554;5656.123300888369;5783.913241301299;5898.380670029585;5905.763769449174 00:42:02 INFO - PROCESS | 17018 | |4;prototype.html;314.8079671400445;321.6092447676073;325.255165670614;326.2724125200803;328.8768854362353;5560.138178582316;5604.495595396414;5692.434580490362;5779.584001919536;5837.591368604194;5647.37878833328;5671.688057156865;5706.914396284059;5714.3999880012625;5767.509761670252;4375.474943006843;4395.8460354426425;4398.3182606695855;4406.889827754316;4429.13631841791;4196.160767846428;4382.627476664487;4407.449068866392;4443.178012067778;4453.421055262811;4289.485261768592;4318.805653745573;4322.481302243735;4338.50107237667;4357.629601483862;4313.15893400787;4334.11150714106;4336.6530677545725;4342.392065110856;4346.4349634547625;3708.61059588742;3711.498947642088;3770.2271034437877;3786.2048969716393;3796.2407518496134;5368.32895888014;5417.699752059517;5433.320834895638;5461.371942226655;5524.558035357162;4931.852044438637;4934.136526107916;4935.185694360426;4949.960508293263;4951.653384263067;5718.714064296769;5885.323326435474;5913.7930172444185;5950.619752099152;6021.735435558538;4113.753174809491;4115.238680844053;4123.567025462313;4145.502539695226;4149.3775933609895;6163.568550201488;6172.351903050205;6226.782062627832;6230.691554773503;6278.529110316745;4026.59734026595;4194.832206711759;4218.810153543098;4229.450171477688;4233.449651545279;4257.87226383209;4280.250956082673;4289.6139347458875;4291.991382025221;4296.4414626098405;4965.602751779849;4983.476734942851;4983.6013118950395;5000.74996250186;5002.449730529639;5827.5920685552455;5974.3726908674835;5976.402359764076;5978.521718262528;6037.758489660452;1425.2659880161725;1446.6600348917996;1451.796748455217;1456.9417223311161;1460.072853737884;900.9054049324858;905.6060613633091;917.3716004536914;922.8431166701677;925.3430064654036;5118.641695081383;5192.7403629818355;5225.242339860775;5228.2941802856885;5228.424873263938;5362.460775887896;5461.962227176824;5493.423190565013;5545.306836645419;5550.9184055979;5093.777493401631;5321.255024296602;5336.386315573681;5337.93068985335;5342.545883599938;2907.5607574250457;2917.7162048698506;2924.6782853886057;2926.985365073161;2951.6900725423952;5656.660600363992;5707.571932105108;5726.255586773693;5740.770369185269;5843.328017278068;5171.3018742469285;5525.392206857243;5599.80400685974;5628.662280263197;5634.464725851038;5704.971475142681;5718.68547229898;5732.971335143297;5733.655980641175;5764.8781121497495;5536.363318218457;5543.584231182596;5560.332760068818;5794.391588883275;6310.463610592968;6143.109249158936;6197.132401463708;6197.1324014638885;6218.657973811303;6223.96888015557;5809.622374545641;6544.214694236722;6566.573172743756;6587.209534855656;6602.933970660232;4217.8523751668545;4228.577142285747;4246.214450326699;4251.234777740036;4258.765767882673;6202.534809889186;6226.968865155645;6241.065269766387;6244.937550624436;6277.686115694289;5946.108083787466;6092.238470191226;6108.35862234459;6162.445379915829;6165.9691701543;6017.2779266488305;6018.247719035121;6098.176746139392;6101.542384321105;6126.663033533198;5693.772249110155;5902.7343769531335;5933.228680271537;5953.374895635896;5994.550408719277;6072.514198864169;6102.9694851525455;6103.206583144341;6118.847028824315;6126.66303353302;5862.618929769551;5991.2510936132985;6014.548908831767;6024.578279520567;6030.276366836008 00:42:02 INFO - PROCESS | 17018 | |5;yui.html;738.3982054625479;746.4625469661842;766.0233202666603;875.2604049578106;916.2031115209567;15956.92021539892;16282.511524654265;16525.33898644053;16596.25316860741;16604.169791510405;15196.696066078672;15343.616409589738;15355.078695278291;15367.385304587802;15389.153596552213;703.7466512055656;844.2064459408167;853.4452605806214;853.9743807685749;859.6561375449808;862.2239984014406;863.7667829685981;864.9437786543886;867.0938868882033;868.7089824908663;919.1314208073339;920.7099763574486;924.9306302027342;925.6991477769752;927.4018258223442;915.9084091590854;917.3853518142861;917.7017469322464;917.8852643419573;920.5535315372039;667.3293340193075;669.3206395508563;671.7313074770083;671.7313074770083;672.1765836849869;15440.45958391451;15457.072575645385;15490.225488725631;15493.302801373853;15497.070175789377;14930.32813523394;14990.175540345277;15054.247287635575;15055.54833355001;15333.693326133414;11645.243059201124;11747.177697561174;11786.469608867621;11919.284842909366;11946.880531194663;3992.301347264217;3993.3011722948368;4016.256992456405;4058.370952502367;4191.077962848169;75035.62482187609;76055;76150.61924690341;76171;76333.61833190854;11061.944690276498;11820;12032.39838008096;12134.817977730341;12293.569725059759;20885.477863053544;21614.891925540272;21664.35006949794;22652.30107741893;22760.772392275867;8633.525156116348;8937.73186804397;9040.547972601344;9345.766355841159;9492.715218543455;4752.287156926489;4836.830710925171;4902.1911384621135;5023.296738456619;5073.7716802743225;3762;3875.2830726315724;3891;3902.746321489094;3903.9609603904164;643.1446176585131;647.3170804800886;653.8038588423549;656.0454538646259;666.4501786026548;657.9374310488527;686.3034020469228;748.7267147491235;765.0551568812513;765.1888997662495;9747.902520974842;10034.297599167989;10087.092161705335;10165.288429809842;10218.284720069523;727.7816655003478;738.1437532462318;742.4951033297409;747.7457664394132;772.4824367673672;4783.856484305476;4791.041791641685;4795.904081918342;4884.731339776346;4904.779284932187;106698;114756.42621786837;115476;117092.8290717082;118679;90385.09614903766;100112.49943750235;101161.49419253004;101180;101775.4911225454;89485;89561.99999999869;89889.40442382362;90285.54857225803;92489.53755231181;8858.013893747968;9176.35765496409;9188.264938805014;9643.27675424332;9650.372725772802;43728.56271437245;50520;51277.48722512727;52948;53112.20331695105;79404.60297698475;81336;81544.59227703823;81635;82621;12571;12736.108472406842;12740.554080607135;12749.235045897276;13173.143745656502;11716.589919352782;11879.287242765462;12106.51573937068;12359.814602780785;13238.470461181445;12722.427490763122;12816.6795830105;12883;12904.41930113166;12963.15739476931;12257.203281786655;12273.447694853574;12413;12507.499700012262;12558.99528037773;12130.878691212974;12242.891336518178;12591.685207869876;12693.80959285593;13284.601461956157;10207.132393746615;10349.844752328872;10358.792824143324;10495.16038716916;10528.947355263175;10652.946735266274;10814.35113893169;10871.945640271748;10947.069499092666;10984.560617575207 00:42:02 INFO - PROCESS | 17018 | __end_tp_report 00:42:02 INFO - PROCESS | 17018 | __start_cc_report 00:42:02 INFO - PROCESS | 17018 | _x_x_mozilla_cycle_collect,348 00:42:02 INFO - PROCESS | 17018 | __end_cc_report 00:42:02 INFO - PROCESS | 17018 | __startTimestamp1467877322460__endTimestamp 00:42:02 INFO - PROCESS | 17018 | 00:42:02 INFO - PROCESS | 17018 | ------- Summary: start ------- 00:42:02 INFO - PROCESS | 17018 | Number of tests: 6 00:42:02 INFO - PROCESS | 17018 | 00:42:02 INFO - PROCESS | 17018 | [#0] dojo.html Cycles:165 Average:5806.21 Median:6057.73 stddev:661.41 (10.9%) stddev-sans-first:635.00 00:42:02 INFO - PROCESS | 17018 | Values: 3360.3 3403.5 3428.1 3435.6 3437.6 5705.9 5734.7 5759.3 5790.2 5825.5 5802.4 5868.0 5873.7 5876.1 5886.0 5255.8 5257.6 5274.4 5315.0 5337.4 5214.0 5215.9 5250.9 5355.3 5371.6 5226.0 5276.1 5329.3 5338.4 5346.9 5341.2 5397.2 5399.9 5401.9 5426.1 5049.3 5254.8 5299.8 5319.8 5344.7 5585.7 5625.7 5642.4 5669.9 5702.9 6197.8 6227.3 6253.5 6255.6 6270.5 6083.3 6150.2 6280.7 6289.1 6321.9 5791.1 5799.6 5867.8 5871.1 5901.9 6325.9 6334.1 6369.3 6376.7 6410.8 5961.7 6080.7 6131.2 6134.3 6156.8 6292.5 6294.2 6297.0 6313.2 6325.6 6127.4 6242.0 6274.4 6287.4 6287.6 5938.6 6132.9 6168.1 6218.0 6262.6 4786.3 4789.1 4792.4 4811.2 4828.3 4262.5 4277.0 4290.8 4296.3 4315.5 5813.5 5987.9 5992.4 6041.4 6050.1 6224.8 6247.0 6258.6 6289.5 6341.9 5800.5 6060.5 6080.7 6096.4 6103.5 5294.7 5325.9 5350.3 5362.7 5368.6 6487.6 6522.3 6551.7 6579.4 6589.8 6024.8 6143.2 6189.5 6219.4 6230.8 6460.6 6560.8 6613.4 6614.2 6623.0 6117.9 6157.9 6165.6 6194.1 6212.6 6026.7 6215.7 6229.7 6266.2 6297.4 6162.7 6175.0 6193.9 6197.6 6208.0 6181.0 6185.8 6206.5 6211.8 6213.3 5824.8 5968.2 6004.8 6057.7 6080.4 6129.7 6134.2 6151.8 6177.1 6177.4 6027.5 6038.0 6052.7 6054.2 6057.8 00:42:02 INFO - PROCESS | 17018 | 00:42:02 INFO - PROCESS | 17018 | [#1] ext.html Cycles:180 Average:76031.80 Median:42858.36 stddev:183415.26 (428.0%) stddev-sans-first:183842.32 00:42:02 INFO - PROCESS | 17018 | Values: 591.6 647.6 648.8 663.7 676.2 38307.0 42783.4 43157.0 43236.8 43255.0 44772.0 44869.8 45093.8 45334.0 45470.3 8785.9 8815.1 8842.0 8946.4 8966.6 8693.5 8808.8 8837.4 8857.2 8875.1 8844.4 8895.0 8933.8 8966.4 8978.1 8815.4 8830.2 8854.4 8898.5 8906.3 8517.7 8748.4 8758.6 8770.1 8805.3 40585.8 40749.6 40984.0 40984.2 41126.4 3665.2 3788.9 3801.7 3804.5 4083.7 33335.5 33700.3 33810.5 33826.0 33999.3 4463.6 4504.7 4508.5 4538.3 4540.0 378975.0 380411.0 380804.0 381172.1 384054.0 63241.0 63835.0 63837.7 63913.0 63998.4 39629.4 40113.8 40302.4 41932.4 41991.0 17580.4 17601.6 17665.1 17669.3 17721.6 13674.3 13691.0 13769.9 13776.2 13800.6 20706.8 21102.2 21147.0 21159.6 21195.9 7465.8 7479.4 7517.3 7639.9 7776.7 1021.2 1142.0 1169.9 1202.8 1223.8 33082.8 33349.8 33464.2 33672.2 34010.8 1167.5 1168.9 1183.8 1232.6 1256.5 16395.0 16437.3 16488.7 16525.3 16892.2 611604.0 1003237.0 1023069.0 1024433.0 1144954.0 63883.7 63948.0 64070.4 64283.0 64717.7 1476.1 1493.6 1510.7 1515.3 1515.7 32776.3 33788.2 33951.8 34023.5 34685.5 54842.5 54980.0 55520.7 55555.2 55575.4 522323.0 522926.0 522929.0 524113.0 526446.0 30559.8 31310.7 31465.4 31508.1 31540.7 49826.3 49959.8 51268.2 51565.7 55574.7 43748.6 44764.1 45117.3 45540.5 45662.3 43510.0 44118.0 44134.0 44662.8 44771.0 42933.4 43194.4 43575.8 44625.8 44647.3 36537.0 37301.8 37684.0 38360.4 39699.6 29746.7 29863.4 30149.0 30338.8 30614.7 00:42:02 INFO - PROCESS | 17018 | 00:42:02 INFO - PROCESS | 17018 | [#2] jquery.html Cycles:180 Average:29699.97 Median:432.33 stddev:85403.26 (19754.0%) stddev-sans-first:85614.46 00:42:02 INFO - PROCESS | 17018 | Values: 382.9 383.0 389.2 401.3 408.2 18951.6 20353.4 21092.5 21339.8 21342.3 19705.8 20104.1 20647.4 20662.1 20695.3 5619.5 5639.6 5785.5 5849.2 5854.5 5627.0 5683.5 5820.9 5825.3 5825.9 5760.5 5763.2 5791.2 5796.9 5800.6 5693.3 5717.8 5745.3 5752.1 5754.0 5122.8 5137.0 5140.5 5150.5 5151.9 20599.3 21621.8 21679.2 22909.3 24198.8 2197.5 2325.2 2398.8 2699.5 2735.7 9826.8 9888.0 9919.5 10077.6 12744.3 1964.7 2064.0 2071.5 2083.8 2118.0 85830.6 87350.6 87839.0 90101.0 90380.5 11465.4 11695.9 11741.2 11865.7 11937.5 16766.7 16803.0 16837.7 16878.0 16887.7 8531.6 8650.0 8796.2 8802.9 8859.4 8343.8 8432.7 8442.3 8468.2 8640.6 4832.6 5030.6 5115.2 5136.3 5193.2 1912.0 2063.2 2073.2 2083.1 2147.8 422.8 422.9 431.8 971.4 1143.2 11291.2 11363.3 11511.6 11511.8 11533.4 432.9 444.7 447.1 448.2 448.9 6117.5 6143.2 6174.0 6228.2 6236.7 485204.0 506569.0 515938.0 527103.0 545268.0 96047.5 97541.5 99927.5 100435.0 101576.5 437.0 438.1 438.5 441.6 441.8 10558.3 10687.9 10855.5 10867.2 10878.2 39877.2 40031.6 40059.4 40396.4 41176.0 57509.7 59526.0 59618.0 61009.7 61928.7 8159.1 8187.3 8191.8 8574.2 8584.6 11337.8 13023.8 13300.6 13390.3 13613.5 11276.7 11826.6 11902.5 11965.8 12166.4 11323.3 11483.7 11505.2 11515.3 11701.5 8317.0 11998.3 12211.9 12229.0 12377.0 7870.5 7963.8 7967.6 8394.3 9080.0 8705.8 12350.9 12363.3 12387.6 12510.4 00:42:02 INFO - PROCESS | 17018 | 00:42:02 INFO - PROCESS | 17018 | [#3] mootools.html Cycles:180 Average:6465.03 Median:4714.47 stddev:3790.15 (80.4%) stddev-sans-first:3782.78 00:42:02 INFO - PROCESS | 17018 | Values: 1549.9 1579.6 1790.2 1877.3 1918.9 8709.3 9158.6 9546.1 10221.9 10233.2 9299.0 9381.3 9652.4 9699.0 9774.4 2427.0 2469.8 2473.4 2479.7 2483.8 2408.6 2495.0 2507.1 2512.4 2516.7 2403.7 2439.4 2465.2 2469.8 2477.2 2397.4 2400.2 2402.8 2434.7 2442.6 2402.7 2406.6 2413.7 2414.7 2419.3 9696.0 9775.9 9779.3 9779.7 9790.9 5740.7 5886.6 5896.1 5953.2 5965.6 3539.3 3642.9 3679.5 3702.2 3703.8 1249.7 1250.8 1258.5 1278.0 1306.4 13889.5 14061.1 14063.9 14100.5 14122.0 5105.3 5148.6 5228.5 5281.4 5360.0 11844.9 11911.9 11947.4 11952.2 12062.4 5750.6 5821.8 5862.1 5862.9 5887.1 4548.4 5182.1 5261.5 5275.1 5280.1 4397.9 4435.8 4487.3 4492.3 4503.0 1365.1 1385.6 1394.4 1399.5 1411.0 993.0 1028.4 1039.7 1040.6 1045.2 6352.4 6449.1 6527.0 6564.7 6585.1 489.6 504.5 506.5 508.4 509.5 4549.4 4655.9 4659.3 4684.2 4744.8 12105.1 12230.8 12581.5 12599.2 12607.9 12299.9 12356.9 12384.3 12420.3 12525.4 9180.0 9366.6 9419.6 9433.2 9446.4 6324.4 6390.1 6496.2 6669.2 6709.3 11153.9 11245.6 11379.7 11454.4 11554.4 11648.4 11748.5 11772.2 11857.2 11898.4 8465.1 8548.2 8699.2 8740.8 8752.0 9342.1 9354.8 9360.8 9383.8 9435.4 8540.4 8660.5 8716.7 8743.8 8886.7 8114.6 8127.6 8177.3 8238.7 8431.9 7831.2 7876.2 7907.7 7956.0 8107.3 5568.6 5853.3 5880.8 5981.5 6014.8 5554.0 5656.1 5783.9 5898.4 5905.8 00:42:02 INFO - PROCESS | 17018 | 00:42:02 INFO - PROCESS | 17018 | [#4] prototype.html Cycles:180 Average:4893.84 Median:5539.97 stddev:1476.58 (26.7%) stddev-sans-first:1440.17 00:42:02 INFO - PROCESS | 17018 | Values: 314.8 321.6 325.3 326.3 328.9 5560.1 5604.5 5692.4 5779.6 5837.6 5647.4 5671.7 5706.9 5714.4 5767.5 4375.5 4395.8 4398.3 4406.9 4429.1 4196.2 4382.6 4407.4 4443.2 4453.4 4289.5 4318.8 4322.5 4338.5 4357.6 4313.2 4334.1 4336.7 4342.4 4346.4 3708.6 3711.5 3770.2 3786.2 3796.2 5368.3 5417.7 5433.3 5461.4 5524.6 4931.9 4934.1 4935.2 4950.0 4951.7 5718.7 5885.3 5913.8 5950.6 6021.7 4113.8 4115.2 4123.6 4145.5 4149.4 6163.6 6172.4 6226.8 6230.7 6278.5 4026.6 4194.8 4218.8 4229.5 4233.4 4257.9 4280.3 4289.6 4292.0 4296.4 4965.6 4983.5 4983.6 5000.7 5002.4 5827.6 5974.4 5976.4 5978.5 6037.8 1425.3 1446.7 1451.8 1456.9 1460.1 900.9 905.6 917.4 922.8 925.3 5118.6 5192.7 5225.2 5228.3 5228.4 5362.5 5462.0 5493.4 5545.3 5550.9 5093.8 5321.3 5336.4 5337.9 5342.5 2907.6 2917.7 2924.7 2927.0 2951.7 5656.7 5707.6 5726.3 5740.8 5843.3 5171.3 5525.4 5599.8 5628.7 5634.5 5705.0 5718.7 5733.0 5733.7 5764.9 5536.4 5543.6 5560.3 5794.4 6310.5 6143.1 6197.1 6197.1 6218.7 6224.0 5809.6 6544.2 6566.6 6587.2 6602.9 4217.9 4228.6 4246.2 4251.2 4258.8 6202.5 6227.0 6241.1 6244.9 6277.7 5946.1 6092.2 6108.4 6162.4 6166.0 6017.3 6018.2 6098.2 6101.5 6126.7 5693.8 5902.7 5933.2 5953.4 5994.6 6072.5 6103.0 6103.2 6118.8 6126.7 5862.6 5991.3 6014.5 6024.6 6030.3 00:42:02 INFO - PROCESS | 17018 | 00:42:02 INFO - PROCESS | 17018 | [#5] yui.html Cycles:180 Average:21017.60 Median:4037.31 stddev:30466.74 (754.6%) stddev-sans-first:30514.15 00:42:02 INFO - PROCESS | 17018 | Values: 738.4 746.5 766.0 875.3 916.2 15956.9 16282.5 16525.3 16596.3 16604.2 15196.7 15343.6 15355.1 15367.4 15389.2 703.7 844.2 853.4 854.0 859.7 862.2 863.8 864.9 867.1 868.7 919.1 920.7 924.9 925.7 927.4 915.9 917.4 917.7 917.9 920.6 667.3 669.3 671.7 671.7 672.2 15440.5 15457.1 15490.2 15493.3 15497.1 14930.3 14990.2 15054.2 15055.5 15333.7 11645.2 11747.2 11786.5 11919.3 11946.9 3992.3 3993.3 4016.3 4058.4 4191.1 75035.6 76055.0 76150.6 76171.0 76333.6 11061.9 11820.0 12032.4 12134.8 12293.6 20885.5 21614.9 21664.4 22652.3 22760.8 8633.5 8937.7 9040.5 9345.8 9492.7 4752.3 4836.8 4902.2 5023.3 5073.8 3762.0 3875.3 3891.0 3902.7 3904.0 643.1 647.3 653.8 656.0 666.5 657.9 686.3 748.7 765.1 765.2 9747.9 10034.3 10087.1 10165.3 10218.3 727.8 738.1 742.5 747.7 772.5 4783.9 4791.0 4795.9 4884.7 4904.8 106698.0 114756.4 115476.0 117092.8 118679.0 90385.1 100112.5 101161.5 101180.0 101775.5 89485.0 89562.0 89889.4 90285.5 92489.5 8858.0 9176.4 9188.3 9643.3 9650.4 43728.6 50520.0 51277.5 52948.0 53112.2 79404.6 81336.0 81544.6 81635.0 82621.0 12571.0 12736.1 12740.6 12749.2 13173.1 11716.6 11879.3 12106.5 12359.8 13238.5 12722.4 12816.7 12883.0 12904.4 12963.2 12257.2 12273.4 12413.0 12507.5 12559.0 12130.9 12242.9 12591.7 12693.8 13284.6 10207.1 10349.8 10358.8 10495.2 10528.9 10652.9 10814.4 10871.9 10947.1 10984.6 00:42:02 INFO - PROCESS | 17018 | -------- Summary: end -------- 00:42:02 INFO - PROCESS | 17018 | 00:42:03 INFO - TEST-INFO | 17018: exit 0 00:42:03 INFO - TEST-OK | dromaeo_css | took 1109504ms 00:42:03 INFO - TEST-START | kraken 00:42:03 INFO - operating with platform_type : linux_ 00:42:03 INFO - Initialising browser for kraken test... 00:42:03 INFO - TEST-INFO | started process 17265 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpl7hr2a/profile http://localhost:59102/getInfo.html) 00:42:07 INFO - PROCESS | 17265 | __metrics Screen width/height:1600/1200 00:42:07 INFO - PROCESS | 17265 | colorDepth:24 00:42:07 INFO - PROCESS | 17265 | Browser inner width/height: 1024/697 00:42:07 INFO - PROCESS | 17265 | __metrics 00:42:08 ERROR - PROCESS | 17265 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 00:42:08 INFO - TEST-INFO | 17265: exit 0 00:42:08 INFO - Browser initialized. 00:42:08 INFO - Running cycle 1/1 for kraken test... 00:42:08 INFO - TEST-INFO | started process 17395 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpl7hr2a/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:42:20 INFO - PROCESS | 17395 | RSS: Main: 155914240 00:42:20 INFO - PROCESS | 17395 | 00:42:23 INFO - PROCESS | 17395 | Cycle 1(1): loaded http://localhost:59102/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59102/tests/kraken/driver.html?testName=audio-beat-detection) 00:42:23 INFO - PROCESS | 17395 | RSS: Main: 161247232 00:42:23 INFO - PROCESS | 17395 | 00:42:26 INFO - PROCESS | 17395 | Cycle 1(1): loaded http://localhost:59102/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59102/tests/kraken/driver.html?testName=audio-dft) 00:42:27 INFO - PROCESS | 17395 | RSS: Main: 160567296 00:42:27 INFO - PROCESS | 17395 | 00:42:30 INFO - PROCESS | 17395 | Cycle 1(1): loaded http://localhost:59102/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59102/tests/kraken/driver.html?testName=audio-fft) 00:42:30 INFO - PROCESS | 17395 | RSS: Main: 161136640 00:42:30 INFO - PROCESS | 17395 | 00:42:32 INFO - PROCESS | 17395 | Cycle 1(1): loaded http://localhost:59102/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59102/tests/kraken/driver.html?testName=audio-oscillator) 00:42:33 INFO - PROCESS | 17395 | RSS: Main: 160980992 00:42:33 INFO - PROCESS | 17395 | 00:42:35 INFO - PROCESS | 17395 | Cycle 1(1): loaded http://localhost:59102/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59102/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:42:36 INFO - PROCESS | 17395 | RSS: Main: 160935936 00:42:36 INFO - PROCESS | 17395 | 00:42:39 INFO - PROCESS | 17395 | Cycle 1(1): loaded http://localhost:59102/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59102/tests/kraken/driver.html?testName=imaging-darkroom) 00:42:39 INFO - PROCESS | 17395 | RSS: Main: 161345536 00:42:39 INFO - PROCESS | 17395 | 00:42:43 INFO - PROCESS | 17395 | Cycle 1(1): loaded http://localhost:59102/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59102/tests/kraken/driver.html?testName=imaging-desaturate) 00:42:43 INFO - PROCESS | 17395 | RSS: Main: 161542144 00:42:43 INFO - PROCESS | 17395 | 00:42:46 INFO - PROCESS | 17395 | Cycle 1(1): loaded http://localhost:59102/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59102/tests/kraken/driver.html?testName=json-parse-financial) 00:42:47 INFO - PROCESS | 17395 | RSS: Main: 161239040 00:42:47 INFO - PROCESS | 17395 | 00:42:48 INFO - PROCESS | 17395 | Cycle 1(1): loaded http://localhost:59102/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59102/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:42:49 INFO - PROCESS | 17395 | RSS: Main: 160714752 00:42:49 INFO - PROCESS | 17395 | 00:42:51 INFO - PROCESS | 17395 | Cycle 1(1): loaded http://localhost:59102/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59102/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:42:51 INFO - PROCESS | 17395 | RSS: Main: 160526336 00:42:51 INFO - PROCESS | 17395 | 00:42:54 INFO - PROCESS | 17395 | Cycle 1(1): loaded http://localhost:59102/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59102/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:42:54 INFO - PROCESS | 17395 | RSS: Main: 161054720 00:42:54 INFO - PROCESS | 17395 | 00:42:57 INFO - PROCESS | 17395 | Cycle 1(1): loaded http://localhost:59102/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59102/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:42:57 INFO - PROCESS | 17395 | RSS: Main: 161734656 00:42:57 INFO - PROCESS | 17395 | 00:43:00 INFO - PROCESS | 17395 | Cycle 1(1): loaded http://localhost:59102/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59102/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:43:01 INFO - PROCESS | 17395 | RSS: Main: 161574912 00:43:01 INFO - PROCESS | 17395 | 00:43:02 INFO - PROCESS | 17395 | Cycle 1(1): loaded http://localhost:59102/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59102/tests/kraken/driver.html?testName=ai-astar) 00:43:03 INFO - PROCESS | 17395 | RSS: Main: 162377728 00:43:03 INFO - PROCESS | 17395 | 00:43:03 INFO - PROCESS | 17395 | __start_tp_report 00:43:03 INFO - PROCESS | 17395 | _x_x_mozilla_page_load 00:43:03 INFO - PROCESS | 17395 | _x_x_mozilla_page_load_details 00:43:03 INFO - PROCESS | 17395 | |i|pagename|runs| 00:43:03 INFO - PROCESS | 17395 | |0;ai-astar;112;106;111;113;112;112;111;110;110;111 00:43:03 INFO - PROCESS | 17395 | |1;audio-beat-detection;151;131;149;176;127;155;153;126;181;125 00:43:03 INFO - PROCESS | 17395 | |2;audio-dft;163;162;162;163;163;162;163;167;162;163 00:43:03 INFO - PROCESS | 17395 | |3;audio-fft;75;75;76;175;77;76;75;75;173;76 00:43:03 INFO - PROCESS | 17395 | |4;audio-oscillator;86;84;147;86;85;85;139;84;86;143 00:43:03 INFO - PROCESS | 17395 | |5;imaging-gaussian-blur;118;117;118;118;118;117;117;117;118;117 00:43:03 INFO - PROCESS | 17395 | |6;imaging-darkroom;146;148;147;147;148;148;147;147;147;147 00:43:03 INFO - PROCESS | 17395 | |7;imaging-desaturate;95;95;97;96;95;95;96;96;100;95 00:43:03 INFO - PROCESS | 17395 | |8;json-parse-financial;54;56;55;53;52;55;53;52;55;51 00:43:03 INFO - PROCESS | 17395 | |9;json-stringify-tinderbox;60;60;60;60;61;60;61;60;59;61 00:43:03 INFO - PROCESS | 17395 | |10;stanford-crypto-aes;78;76;78;77;79;83;77;90;113;79 00:43:03 INFO - PROCESS | 17395 | |11;stanford-crypto-ccm;127;120;127;123;123;125;121;121;129;121 00:43:03 INFO - PROCESS | 17395 | |12;stanford-crypto-pbkdf2;160;160;161;157;161;157;160;156;157;169 00:43:03 INFO - PROCESS | 17395 | |13;stanford-crypto-sha256-iterative;63;63;62;63;62;62;62;61;60;62 00:43:03 INFO - PROCESS | 17395 | __end_tp_report 00:43:03 INFO - PROCESS | 17395 | __start_cc_report 00:43:03 INFO - PROCESS | 17395 | _x_x_mozilla_cycle_collect,885 00:43:03 INFO - PROCESS | 17395 | __end_cc_report 00:43:03 INFO - PROCESS | 17395 | __startTimestamp1467877383099__endTimestamp 00:43:03 INFO - PROCESS | 17395 | 00:43:03 INFO - PROCESS | 17395 | ------- Summary: start ------- 00:43:03 INFO - PROCESS | 17395 | Number of tests: 14 00:43:03 INFO - PROCESS | 17395 | 00:43:03 INFO - PROCESS | 17395 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.50 stddev:1.93 (1.7%) stddev-sans-first:2.00 00:43:03 INFO - PROCESS | 17395 | Values: 112.0 106.0 111.0 113.0 112.0 112.0 111.0 110.0 110.0 111.0 00:43:03 INFO - PROCESS | 17395 | 00:43:03 INFO - PROCESS | 17395 | [#1] audio-beat-detection Cycles:10 Average:147.40 Median:152.00 stddev:20.27 (13.3%) stddev-sans-first:21.45 00:43:03 INFO - PROCESS | 17395 | Values: 151.0 131.0 149.0 176.0 127.0 155.0 153.0 126.0 181.0 125.0 00:43:03 INFO - PROCESS | 17395 | 00:43:03 INFO - PROCESS | 17395 | [#2] audio-dft Cycles:10 Average:163.00 Median:163.00 stddev:1.49 (0.9%) stddev-sans-first:1.58 00:43:03 INFO - PROCESS | 17395 | Values: 163.0 162.0 162.0 163.0 163.0 162.0 163.0 167.0 162.0 163.0 00:43:03 INFO - PROCESS | 17395 | 00:43:03 INFO - PROCESS | 17395 | [#3] audio-fft Cycles:10 Average:95.30 Median:75.50 stddev:41.49 (54.9%) stddev-sans-first:43.35 00:43:03 INFO - PROCESS | 17395 | Values: 75.0 75.0 76.0 175.0 77.0 76.0 75.0 75.0 173.0 76.0 00:43:03 INFO - PROCESS | 17395 | 00:43:03 INFO - PROCESS | 17395 | [#4] audio-oscillator Cycles:10 Average:102.50 Median:85.00 stddev:28.02 (33.0%) stddev-sans-first:29.08 00:43:03 INFO - PROCESS | 17395 | Values: 86.0 84.0 147.0 86.0 85.0 85.0 139.0 84.0 86.0 143.0 00:43:03 INFO - PROCESS | 17395 | 00:43:03 INFO - PROCESS | 17395 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 00:43:03 INFO - PROCESS | 17395 | Values: 118.0 117.0 118.0 118.0 118.0 117.0 117.0 117.0 118.0 117.0 00:43:03 INFO - PROCESS | 17395 | 00:43:03 INFO - PROCESS | 17395 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 00:43:03 INFO - PROCESS | 17395 | Values: 146.0 148.0 147.0 147.0 148.0 148.0 147.0 147.0 147.0 147.0 00:43:03 INFO - PROCESS | 17395 | 00:43:03 INFO - PROCESS | 17395 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:95.50 stddev:1.56 (1.6%) stddev-sans-first:1.62 00:43:03 INFO - PROCESS | 17395 | Values: 95.0 95.0 97.0 96.0 95.0 95.0 96.0 96.0 100.0 95.0 00:43:03 INFO - PROCESS | 17395 | 00:43:03 INFO - PROCESS | 17395 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:54.50 stddev:1.65 (3.0%) stddev-sans-first:1.74 00:43:03 INFO - PROCESS | 17395 | Values: 54.0 56.0 55.0 53.0 52.0 55.0 53.0 52.0 55.0 51.0 00:43:03 INFO - PROCESS | 17395 | 00:43:03 INFO - PROCESS | 17395 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:60.00 stddev:0.63 (1.1%) stddev-sans-first:0.67 00:43:03 INFO - PROCESS | 17395 | Values: 60.0 60.0 60.0 60.0 61.0 60.0 61.0 60.0 59.0 61.0 00:43:03 INFO - PROCESS | 17395 | 00:43:03 INFO - PROCESS | 17395 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:78.50 stddev:11.31 (14.4%) stddev-sans-first:11.85 00:43:03 INFO - PROCESS | 17395 | Values: 78.0 76.0 78.0 77.0 79.0 83.0 77.0 90.0 113.0 79.0 00:43:03 INFO - PROCESS | 17395 | 00:43:03 INFO - PROCESS | 17395 | [#11] stanford-crypto-ccm Cycles:10 Average:123.70 Median:124.00 stddev:3.13 (2.5%) stddev-sans-first:3.08 00:43:03 INFO - PROCESS | 17395 | Values: 127.0 120.0 127.0 123.0 123.0 125.0 121.0 121.0 129.0 121.0 00:43:03 INFO - PROCESS | 17395 | 00:43:03 INFO - PROCESS | 17395 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.80 Median:160.00 stddev:3.74 (2.3%) stddev-sans-first:3.96 00:43:03 INFO - PROCESS | 17395 | Values: 160.0 160.0 161.0 157.0 161.0 157.0 160.0 156.0 157.0 169.0 00:43:03 INFO - PROCESS | 17395 | 00:43:03 INFO - PROCESS | 17395 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.00 Median:62.00 stddev:0.94 (1.5%) stddev-sans-first:0.93 00:43:03 INFO - PROCESS | 17395 | Values: 63.0 63.0 62.0 63.0 62.0 62.0 62.0 61.0 60.0 62.0 00:43:03 INFO - PROCESS | 17395 | -------- Summary: end -------- 00:43:03 INFO - PROCESS | 17395 | 00:43:03 INFO - TEST-INFO | 17395: exit 0 00:43:04 INFO - TEST-OK | kraken | took 60860ms 00:43:04 INFO - SUITE-END | took 1170s 00:43:04 INFO - Completed test suite (00:19:30) 00:43:04 INFO - javascript benchmark 00:43:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7501.81093329823, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3360.26074263662, 3403.52350670906, 3428.1086917401485, 3435.5533780608516, 3437.570303712035, 5705.885882282357, 5734.713264336782, 5759.251297331351, 5790.160426738121, 5825.475707186352, 5802.419758024195, 5867.970660146704, 5873.706314684259, 5876.147958546019, 5886.028805247129, 5255.789768409259, 5257.605679574028, 5274.4461831507715, 5315.0432922074015, 5337.386200586924, 5214.035403450355, 5215.86960325993, 5250.921236181461, 5355.2770375999135, 5371.57027437804, 5226.0, 5276.1030624793875, 5329.25390445338, 5338.359396872381, 5346.946530534684, 5341.225522299264, 5397.163439666858, 5399.893021930495, 5401.891962160774, 5426.077566813651, 5049.293098966147, 5254.842354729364, 5299.8410047698635, 5319.813806516753, 5344.652597581145, 5585.692786896719, 5625.746841392147, 5642.4075472075665, 5669.914951275693, 5702.942970570282, 6197.845053873644, 6227.283862355796, 6253.468455181315, 6255.6246625202175, 6270.46701030413, 6083.270007599072, 6150.231221097363, 6280.717367718464, 6289.1195232667005, 6321.936780632181, 5791.073428251501, 5799.623024503394, 5867.823965281048, 5871.14868344092, 5901.8819623607715, 6325.936740632535, 6334.144890439732, 6369.267534233622, 6376.744930202833, 6410.775622853178, 5961.731722072431, 6080.665563393967, 6131.202943617391, 6134.325224225332, 6156.846078847975, 6292.4966002719675, 6294.213223347082, 6297.023961286008, 6313.210848643919, 6325.557210995278, 6127.417895299939, 6241.96879015602, 6274.403931626488, 6287.402696743893, 6287.591306565058, 5938.6139900907165, 6132.8756461173125, 6168.136460895478, 6218.0, 6262.624242545462, 4786.2581299898575, 4789.066132104276, 4792.400949881265, 4811.182099043171, 4828.324034635154, 4262.509811371732, 4276.978615106905, 4290.82836686529, 4296.334068219431, 4315.525292217853, 5813.476787089182, 5987.940120598825, 5992.370801065826, 6041.426064523863, 6050.092486127116, 6224.844378890564, 6246.968765156236, 6258.561900667, 6289.528285378615, 6341.936580634227, 5800.53595712342, 6060.545459090497, 6080.665563393967, 6096.420840020191, 6103.542234332443, 5294.708791016454, 5325.920111198335, 5350.3312085989255, 5362.678239305654, 5368.624196306221, 6487.578307410004, 6522.315156908551, 6551.705173267119, 6579.440747536513, 6589.769358072444, 6024.819255422344, 6143.204841796883, 6189.473894718999, 6219.40915613016, 6230.813075607739, 6460.580062295936, 6560.803175904731, 6613.43785778195, 6614.239362473185, 6622.953441417002, 6117.908231376444, 6157.938420615916, 6165.630062196283, 6194.0708893666315, 6212.627242365473, 6026.728797204224, 6215.720292586754, 6229.688515574294, 6266.248050234001, 6297.4017468340435, 6162.691865406801, 6175.042868355412, 6193.876122477435, 6197.566170368031, 6208.0, 6180.980138277134, 6185.84535386619, 6206.503479721521, 6211.81364559064, 6213.347598502092, 5824.767009319579, 5968.22413086296, 6004.819855404345, 6057.727402266821, 6080.422359875804, 6129.662868542273, 6134.202553668173, 6151.84620384494, 6177.073438984188, 6177.444030037318, 6027.4876635484725, 6038.0, 6052.6973651316375, 6054.243219597551, 6057.7879774207695], "value": 5761.850553011612, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.5681552466699, 647.6243778608408, 648.8248172993292, 663.7477758451788, 676.2257215488269, 38307.0, 42783.35824962628, 43157.0, 43236.78381608091, 43255.0, 44772.0, 44869.7756511217, 45093.77453112738, 45334.0, 45470.31794523085, 8785.912140878589, 8815.118488151165, 8842.0, 8946.373753837233, 8966.596503157374, 8693.5218562979, 8808.779780505474, 8837.38138330317, 8857.202851743341, 8875.112488751138, 8844.38089333747, 8894.955525222396, 8933.821323573557, 8966.372353935227, 8978.057303983085, 8815.382923195379, 8830.161134692195, 8854.424462409956, 8898.4660920345, 8906.33202509808, 8517.701880434217, 8748.387612867102, 8758.605862736129, 8770.12298770118, 8805.295576353876, 40585.79707101475, 40749.59250407488, 40984.0, 40984.1803163938, 41126.38310425346, 3665.193657395369, 3788.886333410002, 3801.7148713846573, 3804.505414296124, 4083.7141400102005, 33335.49996750051, 33700.32599348024, 33810.49284260738, 33826.0, 33999.320013599834, 4463.620592249663, 4504.662150338738, 4508.45898492183, 4538.319252112176, 4540.046590216059, 378975.0, 380411.0, 380804.0, 381172.0941395303, 384054.0, 63241.0, 63835.0, 63837.72324553576, 63913.0, 63998.36001640017, 39629.40555891664, 40113.799431002655, 40302.39546406806, 41932.37101443481, 41991.0, 17580.384686536167, 17601.647967040586, 17665.116744163, 17669.293228270726, 17721.556961075818, 13674.31628418575, 13691.0, 13769.862301377058, 13776.173429594257, 13800.585982420544, 20706.792932070788, 21102.155913763585, 21147.0, 21159.57680846405, 21195.8940205298, 7465.776026719207, 7479.364254038359, 7517.323440890237, 7639.85402189676, 7776.7278145264645, 1021.1626466297713, 1142.0, 1169.92980421175, 1202.7955247607927, 1223.804191329383, 33082.83458582692, 33349.833250834075, 33464.16339591481, 33672.1581960448, 34010.82994585011, 1167.5271515036425, 1168.9006434453167, 1183.7632473505334, 1232.5870833270776, 1256.5476428485738, 16395.0, 16437.26032328548, 16488.6702265954, 16525.33898644065, 16892.239849206817, 611604.0, 1003237.0, 1023069.0, 1024433.0, 1144954.0, 63883.6805815968, 63948.0, 64070.35929640737, 64283.0, 64717.67641161764, 1476.0922032949873, 1493.6116609681344, 1510.6752048309665, 1515.272669118829, 1515.7423238049557, 32776.34447311088, 33788.155296117795, 33951.830240848634, 34023.4896476558, 34685.47971780375, 54842.451575483734, 54980.0, 55520.72239638776, 55555.16667249914, 55575.444245557024, 522323.0, 522926.0, 522929.0, 524113.0, 526446.0, 30559.847200764743, 31310.686893130776, 31465.37069258648, 31508.054758357284, 31540.684593154692, 49826.25260621021, 49959.75020124876, 51268.230976534636, 51565.742171288905, 55574.72212638911, 43748.56251437445, 44764.10471790611, 45117.32324015077, 45540.54459455496, 45662.31506527338, 43510.0, 44118.0, 44134.0, 44662.77668611636, 44771.0, 42933.355999659405, 43194.35208471813, 43575.78212109046, 44625.776871115435, 44647.33029004503, 36537.0, 37301.81349093237, 37684.0, 38360.42459363167, 39699.60300396959, 29746.702532975258, 29863.402731945673, 30149.0, 30338.84830575833, 30614.693853062076], "value": 21315.88455369886, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.91767270036945, 382.98659546915866, 389.1671822300277, 401.31775980832595, 408.1530823541151, 18951.620967580657, 20353.389398318075, 21092.472688182803, 21339.786602133972, 21342.253021144264, 19705.802941970574, 20104.09531571079, 20647.380578582666, 20662.07020684069, 20695.275665351717, 5619.4942455178925, 5639.577031722617, 5785.508231800302, 5849.151872978416, 5854.531637468992, 5626.971865140668, 5683.54531637468, 5820.941790582104, 5825.271841019872, 5825.912611310834, 5760.53915686744, 5763.193152958589, 5791.160281759164, 5796.855078623026, 5800.593958422912, 5693.316801983768, 5717.799877004327, 5745.310562732478, 5752.05091159956, 5754.0, 5122.820701275475, 5137.049645815536, 5140.511651393112, 5150.459201783796, 5151.948480515184, 20599.279025234195, 21621.783782162292, 21679.24122655715, 22909.312720618407, 24198.758012419825, 2197.507438443463, 2325.209428794218, 2398.760123987605, 2699.4736026474843, 2735.712750161244, 9826.754331141707, 9887.950560247153, 9919.50402479873, 10077.647282345082, 12744.299063551502, 1964.7052942058806, 2063.9793602064087, 2071.5028393185526, 2083.802038806311, 2118.0, 85830.570847146, 87350.56324718399, 87838.99999999936, 90101.0, 90380.54809725909, 11465.369404682822, 11695.883041169649, 11741.236819606698, 11865.703357415961, 11937.487856762054, 16766.66466670684, 16802.99182049081, 16837.74743378826, 16877.987320760792, 16887.746683799753, 8531.573421328909, 8649.956750216334, 8796.164364385373, 8802.887307046263, 8859.3798434109, 8343.8331233375, 8432.662693492191, 8442.282405995558, 8468.237858592756, 8640.611172497252, 4832.613390928717, 5030.622703297267, 5115.18157094863, 5136.332276803992, 5193.195054766517, 1912.024867317678, 2063.1541068161982, 2073.1914553324214, 2083.125087463269, 2147.785221477871, 422.75057715947736, 422.92387370273644, 431.76900358308154, 971.4414211828228, 1143.188336281233, 11291.209615326849, 11363.261388009752, 11511.597094101666, 11511.769764604662, 11533.423328833525, 432.9004329004347, 444.6909397968381, 447.0700942040548, 448.22009703116345, 448.94837093733986, 6117.480014198843, 6143.170671959318, 6173.969130154321, 6228.159198508143, 6236.688165591793, 485204.0, 506569.0, 515938.0, 527103.0, 545268.0, 96047.51976240214, 97541.5122924395, 99927.50036249918, 100435.02743214273, 101576.49211753895, 437.00145168290305, 438.0887753472833, 438.51982079622763, 441.5672640811958, 441.78288814316994, 10558.260921735711, 10687.946560267459, 10855.511501982272, 10867.239293249397, 10878.238523303293, 39877.21473423092, 40031.59968400279, 40059.39910901397, 40396.3940540898, 41176.0, 57509.712451437474, 59526.0, 59618.0, 61009.69495152496, 61928.69035654793, 8159.061707903667, 8187.26314631686, 8191.754247372588, 8574.22831945128, 8584.613692383982, 11337.773244535229, 13023.804642930174, 13300.600981970556, 13390.330483475593, 13613.455461781417, 11276.661700149009, 11826.586069487526, 11902.464389102339, 11965.820512692142, 12166.39168041612, 11323.32060076398, 11483.712907177387, 11505.194636375374, 11515.30908145514, 11701.473433695333, 8317.0, 11998.340091295062, 12211.938940305241, 12229.0, 12377.0, 7870.488418253024, 7963.800904977422, 7967.601619918865, 8394.328453723809, 9080.001199867876, 8705.781190633443, 12350.876491234972, 12363.32001739913, 12387.566435174725, 12510.437030333838], "value": 8510.13717956715, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1549.9457518986835, 1579.6208909861632, 1790.1854656131454, 1877.314780105262, 1918.894460804656, 8709.346798990086, 9158.58786354614, 9546.140847323739, 10221.897781022188, 10233.181345492361, 9298.95350523248, 9381.343305968569, 9652.37259578127, 9698.951505242481, 9774.413535187876, 2427.017058091476, 2469.7898029965368, 2473.4434752180705, 2479.727230004698, 2483.8137139714504, 2408.6387041943763, 2495.026939493599, 2507.147569826259, 2512.4221429071326, 2516.7105782835024, 2403.6514705367713, 2439.42673471734, 2465.2480993297036, 2469.753024697534, 2477.182529765182, 2397.436602398426, 2400.1599440195964, 2402.759724027601, 2434.6591477193206, 2442.6091825307867, 2402.68765060541, 2406.6149416093517, 2413.6500207469817, 2414.7102347718387, 2419.2863105383776, 9695.951520242425, 9775.853362199572, 9779.315447918649, 9779.657711980117, 9790.853137202948, 5740.684262365568, 5886.6173698709445, 5896.145058966469, 5953.226080609536, 5965.642061476326, 3539.2744487380023, 3642.908927276813, 3679.5400574928135, 3702.241040586673, 3703.7962912039825, 1249.650097972569, 1250.8311377963948, 1258.4840215511597, 1278.0350835119425, 1306.3533550892369, 13889.513867014706, 14061.086029408056, 14063.859361406357, 14100.506482273175, 14122.0, 5105.310783044241, 5148.639595228298, 5228.4510126436935, 5281.419043905167, 5360.0, 11844.940775296069, 11911.940440297743, 11947.402629868471, 11952.223105498115, 12062.396880156133, 5750.597458177971, 5821.825345239649, 5862.091375836752, 5862.912056319158, 5887.087501437284, 4548.385967894358, 5182.119039763249, 5261.5264626183825, 5275.050490911673, 5280.128778751463, 4397.868063958086, 4435.778211089432, 4487.304467807495, 4492.326151077299, 4502.954970450253, 1365.1263191557412, 1385.56354748256, 1394.42828440341, 1399.468202083202, 1410.964725881861, 992.9900700993043, 1028.4240825137947, 1039.7088815131776, 1040.5629635552934, 1045.1586472889246, 6352.428281454691, 6449.064885591563, 6527.0, 6564.7374105036215, 6585.1439312889015, 489.6401145158306, 504.4955044955045, 506.4606194402949, 508.3594670714926, 509.4879645955865, 4549.385832912581, 4655.930161047587, 4659.34769132315, 4684.156851766715, 4744.786484608201, 12105.09211809118, 12230.816537751942, 12581.496740130293, 12599.244045357307, 12607.87392126067, 12299.93850030744, 12356.876431235572, 12384.256944583354, 12420.316882571546, 12525.43635536403, 9179.954100229455, 9366.578503967474, 9419.623215071457, 9433.198178154933, 9446.433214007182, 6324.3991820776955, 6390.073439351175, 6496.220453545605, 6669.166354205724, 6709.329067093252, 11153.888461115284, 11245.550177993116, 11379.658610241706, 11454.427278635869, 11554.422278885853, 11648.359340236368, 11748.530058797553, 11772.17594768358, 11857.16999810005, 11898.405079746151, 8465.111163327761, 8548.187922147386, 8699.217070463435, 8740.78148046304, 8751.956240218758, 9342.065793420603, 9354.812903741751, 9360.765980850534, 9383.812323753624, 9435.386699864486, 8540.359473039423, 8660.523671198145, 8716.694915677921, 8743.781405464913, 8886.688965886164, 8114.553699546345, 8127.552984585905, 8177.345812335118, 8238.711645092393, 8431.915680843113, 7831.177726338652, 7876.173001834725, 7907.683692652229, 7955.960220198862, 8107.3108785753875, 5568.610197286151, 5853.268341457318, 5880.794172203952, 5981.491573216152, 6014.849628759316, 5554.0, 5656.123300888369, 5783.913241301299, 5898.380670029585, 5905.763769449174], "value": 5034.362795194973, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.8079671400445, 321.6092447676073, 325.255165670614, 326.2724125200803, 328.8768854362353, 5560.138178582316, 5604.495595396414, 5692.434580490362, 5779.584001919536, 5837.591368604194, 5647.37878833328, 5671.688057156865, 5706.914396284059, 5714.3999880012625, 5767.509761670252, 4375.474943006843, 4395.8460354426425, 4398.3182606695855, 4406.889827754316, 4429.13631841791, 4196.160767846428, 4382.627476664487, 4407.449068866392, 4443.178012067778, 4453.421055262811, 4289.485261768592, 4318.805653745573, 4322.481302243735, 4338.50107237667, 4357.629601483862, 4313.15893400787, 4334.11150714106, 4336.6530677545725, 4342.392065110856, 4346.4349634547625, 3708.61059588742, 3711.498947642088, 3770.2271034437877, 3786.2048969716393, 3796.2407518496134, 5368.32895888014, 5417.699752059517, 5433.320834895638, 5461.371942226655, 5524.558035357162, 4931.852044438637, 4934.136526107916, 4935.185694360426, 4949.960508293263, 4951.653384263067, 5718.714064296769, 5885.323326435474, 5913.7930172444185, 5950.619752099152, 6021.735435558538, 4113.753174809491, 4115.238680844053, 4123.567025462313, 4145.502539695226, 4149.3775933609895, 6163.568550201488, 6172.351903050205, 6226.782062627832, 6230.691554773503, 6278.529110316745, 4026.59734026595, 4194.832206711759, 4218.810153543098, 4229.450171477688, 4233.449651545279, 4257.87226383209, 4280.250956082673, 4289.6139347458875, 4291.991382025221, 4296.4414626098405, 4965.602751779849, 4983.476734942851, 4983.6013118950395, 5000.74996250186, 5002.449730529639, 5827.5920685552455, 5974.3726908674835, 5976.402359764076, 5978.521718262528, 6037.758489660452, 1425.2659880161725, 1446.6600348917996, 1451.796748455217, 1456.9417223311161, 1460.072853737884, 900.9054049324858, 905.6060613633091, 917.3716004536914, 922.8431166701677, 925.3430064654036, 5118.641695081383, 5192.7403629818355, 5225.242339860775, 5228.2941802856885, 5228.424873263938, 5362.460775887896, 5461.962227176824, 5493.423190565013, 5545.306836645419, 5550.9184055979, 5093.777493401631, 5321.255024296602, 5336.386315573681, 5337.93068985335, 5342.545883599938, 2907.5607574250457, 2917.7162048698506, 2924.6782853886057, 2926.985365073161, 2951.6900725423952, 5656.660600363992, 5707.571932105108, 5726.255586773693, 5740.770369185269, 5843.328017278068, 5171.3018742469285, 5525.392206857243, 5599.80400685974, 5628.662280263197, 5634.464725851038, 5704.971475142681, 5718.68547229898, 5732.971335143297, 5733.655980641175, 5764.8781121497495, 5536.363318218457, 5543.584231182596, 5560.332760068818, 5794.391588883275, 6310.463610592968, 6143.109249158936, 6197.132401463708, 6197.1324014638885, 6218.657973811303, 6223.96888015557, 5809.622374545641, 6544.214694236722, 6566.573172743756, 6587.209534855656, 6602.933970660232, 4217.8523751668545, 4228.577142285747, 4246.214450326699, 4251.234777740036, 4258.765767882673, 6202.534809889186, 6226.968865155645, 6241.065269766387, 6244.937550624436, 6277.686115694289, 5946.108083787466, 6092.238470191226, 6108.35862234459, 6162.445379915829, 6165.9691701543, 6017.2779266488305, 6018.247719035121, 6098.176746139392, 6101.542384321105, 6126.663033533198, 5693.772249110155, 5902.7343769531335, 5933.228680271537, 5953.374895635896, 5994.550408719277, 6072.514198864169, 6102.9694851525455, 6103.206583144341, 6118.847028824315, 6126.66303353302, 5862.618929769551, 5991.2510936132985, 6014.548908831767, 6024.578279520567, 6030.276366836008], "value": 4409.509406442882, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [738.3982054625479, 746.4625469661842, 766.0233202666603, 875.2604049578106, 916.2031115209567, 15956.92021539892, 16282.511524654265, 16525.33898644053, 16596.25316860741, 16604.169791510405, 15196.696066078672, 15343.616409589738, 15355.078695278291, 15367.385304587802, 15389.153596552213, 703.7466512055656, 844.2064459408167, 853.4452605806214, 853.9743807685749, 859.6561375449808, 862.2239984014406, 863.7667829685981, 864.9437786543886, 867.0938868882033, 868.7089824908663, 919.1314208073339, 920.7099763574486, 924.9306302027342, 925.6991477769752, 927.4018258223442, 915.9084091590854, 917.3853518142861, 917.7017469322464, 917.8852643419573, 920.5535315372039, 667.3293340193075, 669.3206395508563, 671.7313074770083, 671.7313074770083, 672.1765836849869, 15440.45958391451, 15457.072575645385, 15490.225488725631, 15493.302801373853, 15497.070175789377, 14930.32813523394, 14990.175540345277, 15054.247287635575, 15055.54833355001, 15333.693326133414, 11645.243059201124, 11747.177697561174, 11786.469608867621, 11919.284842909366, 11946.880531194663, 3992.301347264217, 3993.3011722948368, 4016.256992456405, 4058.370952502367, 4191.077962848169, 75035.62482187609, 76055.0, 76150.61924690341, 76171.0, 76333.61833190854, 11061.944690276498, 11820.0, 12032.39838008096, 12134.817977730341, 12293.569725059759, 20885.477863053544, 21614.891925540272, 21664.35006949794, 22652.30107741893, 22760.772392275867, 8633.525156116348, 8937.73186804397, 9040.547972601344, 9345.766355841159, 9492.715218543455, 4752.287156926489, 4836.830710925171, 4902.1911384621135, 5023.296738456619, 5073.7716802743225, 3762.0, 3875.2830726315724, 3891.0, 3902.746321489094, 3903.9609603904164, 643.1446176585131, 647.3170804800886, 653.8038588423549, 656.0454538646259, 666.4501786026548, 657.9374310488527, 686.3034020469228, 748.7267147491235, 765.0551568812513, 765.1888997662495, 9747.902520974842, 10034.297599167989, 10087.092161705335, 10165.288429809842, 10218.284720069523, 727.7816655003478, 738.1437532462318, 742.4951033297409, 747.7457664394132, 772.4824367673672, 4783.856484305476, 4791.041791641685, 4795.904081918342, 4884.731339776346, 4904.779284932187, 106698.0, 114756.42621786837, 115476.0, 117092.8290717082, 118679.0, 90385.09614903766, 100112.49943750235, 101161.49419253004, 101180.0, 101775.4911225454, 89485.0, 89561.99999999869, 89889.40442382362, 90285.54857225803, 92489.53755231181, 8858.013893747968, 9176.35765496409, 9188.264938805014, 9643.27675424332, 9650.372725772802, 43728.56271437245, 50520.0, 51277.48722512727, 52948.0, 53112.20331695105, 79404.60297698475, 81336.0, 81544.59227703823, 81635.0, 82621.0, 12571.0, 12736.108472406842, 12740.554080607135, 12749.235045897276, 13173.143745656502, 11716.589919352782, 11879.287242765462, 12106.51573937068, 12359.814602780785, 13238.470461181445, 12722.427490763122, 12816.6795830105, 12883.0, 12904.41930113166, 12963.15739476931, 12257.203281786655, 12273.447694853574, 12413.0, 12507.499700012262, 12558.99528037773, 12130.878691212974, 12242.891336518178, 12591.685207869876, 12693.80959285593, 13284.601461956157, 10207.132393746615, 10349.844752328872, 10358.792824143324, 10495.16038716916, 10528.947355263175, 10652.946735266274, 10814.35113893169, 10871.945640271748, 10947.069499092666, 10984.560617575207], "value": 7681.026756406773, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1522.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 111.0, 113.0, 112.0, 112.0, 111.0, 110.0, 110.0, 111.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 131.0, 149.0, 176.0, 127.0, 155.0, 153.0, 126.0, 181.0, 125.0], "value": 147.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 163.0, 163.0, 162.0, 163.0, 167.0, 162.0, 163.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 175.0, 77.0, 76.0, 75.0, 75.0, 173.0, 76.0], "value": 95.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 147.0, 86.0, 85.0, 85.0, 139.0, 84.0, 86.0, 143.0], "value": 102.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 147.0, 147.0, 148.0, 148.0, 147.0, 147.0, 147.0, 147.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 97.0, 96.0, 95.0, 95.0, 96.0, 96.0, 100.0, 95.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 55.0, 53.0, 52.0, 55.0, 53.0, 52.0, 55.0, 51.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 60.0, 61.0, 60.0, 61.0, 60.0, 59.0, 61.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 78.0, 77.0, 79.0, 83.0, 77.0, 90.0, 113.0, 79.0], "value": 83.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 120.0, 127.0, 123.0, 123.0, 125.0, 121.0, 121.0, 129.0, 121.0], "value": 123.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 157.0, 161.0, 157.0, 160.0, 156.0, 157.0, 169.0], "value": 159.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 62.0, 63.0, 62.0, 62.0, 62.0, 61.0, 60.0, 62.0], "value": 62.0, "unit": "score"}]}]} 00:43:04 INFO - Return code: 0 00:43:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:43:04 ERROR - # TBPL SUCCESS # 00:43:04 INFO - Running post-action listener: _resource_record_post_action 00:43:04 INFO - ##### 00:43:04 INFO - ##### Finished run-tests step (success) 00:43:04 INFO - ##### 00:43:04 INFO - Running post-run listener: _resource_record_post_run 00:43:04 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 506875904; Read time: 0; Write time: 389588 00:43:04 INFO - TinderboxPrint: CPU usage
13.4% 00:43:04 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 00:43:04 INFO - TinderboxPrint: I/O write bytes / time
506,875,904 / 389,588 00:43:04 INFO - TinderboxPrint: CPU idle
8,208.2 (86.6%) 00:43:04 INFO - TinderboxPrint: CPU user
1,214.0 (12.8%) 00:43:04 INFO - TinderboxPrint: Swap in / out
0 / 0 00:43:04 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 252542976; Read time: 0; Write time: 232348 00:43:04 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 254332928; Read time: 0; Write time: 157240 00:43:05 INFO - Running post-run listener: _upload_blobber_files 00:43:05 INFO - Blob upload gear active. 00:43:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:43:05 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 00:43:05 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'] 00:43:05 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 00:43:05 INFO - (blobuploader) - INFO - Open directory for files ... 00:43:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 00:43:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:43:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:43:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 00:43:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:43:06 INFO - (blobuploader) - INFO - Done attempting. 00:43:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:43:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:43:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:43:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:43:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:43:09 INFO - (blobuploader) - INFO - Done attempting. 00:43:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 00:43:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:43:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:43:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 00:43:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:43:10 INFO - (blobuploader) - INFO - Done attempting. 00:43:10 INFO - (blobuploader) - INFO - Iteration through files over. 00:43:10 INFO - Return code: 0 00:43:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:43:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:43:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7c502028fcf921249636db33268b95ea51aaf301891b2ba42517e4b4b8d9e1e7573fdce3004b6f33d8c4e5d3bdccc86c0a889dfa8be3b0dc98a67344146b2a65", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d8cb778a637eab60cfd4ddc1fc261722faa9635e757d0eab8a35527df58f8ce5ae1bf35b4c9780da3aa817846fcca0d9dcf3a31410983d60af3edb6618197557", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dbf00c70aa980db75c529370e7daf9410b6bfc5aae15bce0ba92941215153f295922f6ae9136b886deec86b065c63e2ce847b9be0361094137d85f11e4a07379"} 00:43:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:43:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:43:10 INFO - Contents: 00:43:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7c502028fcf921249636db33268b95ea51aaf301891b2ba42517e4b4b8d9e1e7573fdce3004b6f33d8c4e5d3bdccc86c0a889dfa8be3b0dc98a67344146b2a65", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d8cb778a637eab60cfd4ddc1fc261722faa9635e757d0eab8a35527df58f8ce5ae1bf35b4c9780da3aa817846fcca0d9dcf3a31410983d60af3edb6618197557", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dbf00c70aa980db75c529370e7daf9410b6bfc5aae15bce0ba92941215153f295922f6ae9136b886deec86b065c63e2ce847b9be0361094137d85f11e4a07379"} 00:43:10 INFO - Running post-run listener: copy_logs_to_upload_dir 00:43:10 INFO - Copying logs to upload dir... 00:43:10 INFO - mkdir: /builds/slave/test/build/upload/logs 00:43:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.407683 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-07-07 00:43:10.364461) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 00:43:10.368487) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1467874882.370867-2055276331 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7c502028fcf921249636db33268b95ea51aaf301891b2ba42517e4b4b8d9e1e7573fdce3004b6f33d8c4e5d3bdccc86c0a889dfa8be3b0dc98a67344146b2a65", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d8cb778a637eab60cfd4ddc1fc261722faa9635e757d0eab8a35527df58f8ce5ae1bf35b4c9780da3aa817846fcca0d9dcf3a31410983d60af3edb6618197557", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dbf00c70aa980db75c529370e7daf9410b6bfc5aae15bce0ba92941215153f295922f6ae9136b886deec86b065c63e2ce847b9be0361094137d85f11e4a07379"} build_url:https://queue.taskcluster.net/v1/task/fBi9cm12SXaq4eVj2OyQLg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011231 build_url: 'https://queue.taskcluster.net/v1/task/fBi9cm12SXaq4eVj2OyQLg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7c502028fcf921249636db33268b95ea51aaf301891b2ba42517e4b4b8d9e1e7573fdce3004b6f33d8c4e5d3bdccc86c0a889dfa8be3b0dc98a67344146b2a65", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d8cb778a637eab60cfd4ddc1fc261722faa9635e757d0eab8a35527df58f8ce5ae1bf35b4c9780da3aa817846fcca0d9dcf3a31410983d60af3edb6618197557", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dbf00c70aa980db75c529370e7daf9410b6bfc5aae15bce0ba92941215153f295922f6ae9136b886deec86b065c63e2ce847b9be0361094137d85f11e4a07379"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 00:43:10.396521) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 00:43:10.396835) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1467874882.370867-2055276331 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004494 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 00:43:10.481857) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 00:43:10.482208) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 00:43:10.482506) ========= ========= Total master_lag: 0.16 =========