builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-064 starttime: 1465232485.7 results: success (0) buildid: 20160606073136 builduid: c89a5eac9b81491a9f28c772a8802835 revision: 581cba07c3793b9788f8e041481e99874f05fa01 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 10:01:25.704472) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 10:01:25.709019) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 10:01:25.709302) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 10:01:25.802635) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 10:01:25.802910) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1465232153.185901-189158371 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-06 10:01:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 228M=0s 2016-06-06 10:01:25 (228 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.164142 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 10:01:26.005236) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 10:01:26.008597) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1465232153.185901-189158371 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.102594 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 10:01:26.123027) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 10:01:26.123351) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 581cba07c3793b9788f8e041481e99874f05fa01 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 581cba07c3793b9788f8e041481e99874f05fa01 --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=a12cd81e0ef515edd9e0d800000001bb-1465232153.185901-189158371 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-06 10:01:26,126 truncating revision to first 12 chars 2016-06-06 10:01:26,126 Setting DEBUG logging. 2016-06-06 10:01:26,126 attempt 1/10 2016-06-06 10:01:26,126 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/581cba07c379?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-06 10:01:26,442 unpacking tar archive at: mozilla-inbound-581cba07c379/testing/mozharness/ program finished with exit code 0 elapsedTime=0.660422 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 10:01:26.799770) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 10:01:26.800047) ========= script_repo_revision: 581cba07c3793b9788f8e041481e99874f05fa01 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 10:01:26.800447) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 10:01:26.800727) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 10:01:26.810965) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-06 10:01:26.811254) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1465232153.185901-189158371 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:01:27 INFO - MultiFileLogger online at 20160606 10:01:27 in /builds/slave/test 10:01:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 10:01:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:01:27 INFO - {'append_to_log': False, 10:01:27 INFO - 'base_work_dir': '/builds/slave/test', 10:01:27 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 10:01:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:01:27 INFO - 'branch': 'Mozilla-Inbound', 10:01:27 INFO - 'buildbot_json_path': 'buildprops.json', 10:01:27 INFO - 'config_files': ('talos/linux_config.py',), 10:01:27 INFO - 'default_actions': ('clobber', 10:01:27 INFO - 'read-buildbot-config', 10:01:27 INFO - 'download-and-extract', 10:01:27 INFO - 'populate-webroot', 10:01:27 INFO - 'create-virtualenv', 10:01:27 INFO - 'install', 10:01:27 INFO - 'run-tests'), 10:01:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:01:27 INFO - 'download_minidump_stackwalk': True, 10:01:27 INFO - 'download_symbols': 'ondemand', 10:01:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:01:27 INFO - 'tooltool.py': '/tools/tooltool.py', 10:01:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:01:27 INFO - '/tools/misc-python/virtualenv.py')}, 10:01:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:01:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:01:27 INFO - 'installer_path': 'installer.exe', 10:01:27 INFO - 'log_level': 'info', 10:01:27 INFO - 'log_name': 'talos', 10:01:27 INFO - 'log_to_console': True, 10:01:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:01:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:01:27 INFO - 'opt_config_files': (), 10:01:27 INFO - 'pip_index': False, 10:01:27 INFO - 'sps_profile': False, 10:01:27 INFO - 'sps_profile_interval': 0, 10:01:27 INFO - 'suite': 'dromaeojs', 10:01:27 INFO - 'system_bits': '32', 10:01:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:01:27 INFO - 'title': 'talos-linux64-ix-064', 10:01:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:01:27 INFO - 'use_talos_json': True, 10:01:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:01:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:01:27 INFO - 'work_dir': 'build'} 10:01:27 INFO - ##### 10:01:27 INFO - ##### Running clobber step. 10:01:27 INFO - ##### 10:01:27 INFO - Running pre-action listener: _resource_record_pre_action 10:01:27 INFO - Running main action method: clobber 10:01:27 INFO - rmtree: /builds/slave/test/build 10:01:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:01:28 INFO - Running post-action listener: _resource_record_post_action 10:01:28 INFO - ##### 10:01:28 INFO - ##### Finished clobber step (success) 10:01:28 INFO - ##### 10:01:28 INFO - ##### 10:01:28 INFO - ##### Running read-buildbot-config step. 10:01:28 INFO - ##### 10:01:28 INFO - Running pre-action listener: _resource_record_pre_action 10:01:28 INFO - Running main action method: read_buildbot_config 10:01:28 INFO - Using buildbot properties: 10:01:28 INFO - { 10:01:28 INFO - "project": "", 10:01:28 INFO - "product": "firefox", 10:01:28 INFO - "script_repo_revision": "production", 10:01:28 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 10:01:28 INFO - "repository": "", 10:01:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 10:01:28 INFO - "buildid": "20160606073136", 10:01:28 INFO - "pgo_build": "True", 10:01:28 INFO - "basedir": "/builds/slave/test", 10:01:28 INFO - "buildnumber": 1060, 10:01:28 INFO - "slavename": "talos-linux64-ix-064", 10:01:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:01:28 INFO - "platform": "ubuntu64_hw", 10:01:28 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 10:01:28 INFO - "branch": "mozilla-inbound", 10:01:28 INFO - "repo_path": "integration/mozilla-inbound", 10:01:28 INFO - "revision": "581cba07c3793b9788f8e041481e99874f05fa01", 10:01:28 INFO - "stage_platform": "linux64-pgo", 10:01:28 INFO - "builduid": "c89a5eac9b81491a9f28c772a8802835", 10:01:28 INFO - "slavebuilddir": "test" 10:01:28 INFO - } 10:01:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/XFucm0-JQ3qenwfLKTrzPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 10:01:28 INFO - Running post-action listener: _resource_record_post_action 10:01:28 INFO - ##### 10:01:28 INFO - ##### Finished read-buildbot-config step (success) 10:01:28 INFO - ##### 10:01:28 INFO - ##### 10:01:28 INFO - ##### Running download-and-extract step. 10:01:28 INFO - ##### 10:01:28 INFO - Running pre-action listener: _resource_record_pre_action 10:01:28 INFO - Running main action method: download_and_extract 10:01:28 INFO - mkdir: /builds/slave/test/build/tests 10:01:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:28 INFO - https://queue.taskcluster.net/v1/task/XFucm0-JQ3qenwfLKTrzPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:01:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XFucm0-JQ3qenwfLKTrzPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:01:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XFucm0-JQ3qenwfLKTrzPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:01:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XFucm0-JQ3qenwfLKTrzPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:01:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XFucm0-JQ3qenwfLKTrzPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:01:29 INFO - Downloaded 1361 bytes. 10:01:29 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:01:29 INFO - Using the following test package requirements: 10:01:29 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:01:29 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:01:29 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:01:29 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:29 INFO - u'jsshell-linux-x86_64.zip'], 10:01:29 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:01:29 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:01:29 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:01:29 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:01:29 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:01:29 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:01:29 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:01:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:29 INFO - https://queue.taskcluster.net/v1/task/XFucm0-JQ3qenwfLKTrzPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:01:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XFucm0-JQ3qenwfLKTrzPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:01:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XFucm0-JQ3qenwfLKTrzPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:01:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XFucm0-JQ3qenwfLKTrzPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:01:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XFucm0-JQ3qenwfLKTrzPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:01:30 INFO - Downloaded 24443871 bytes. 10:01:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:01:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:01:32 INFO - Return code: 0 10:01:32 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:01: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')]} 10:01:32 INFO - https://queue.taskcluster.net/v1/task/XFucm0-JQ3qenwfLKTrzPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:01:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XFucm0-JQ3qenwfLKTrzPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:01:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XFucm0-JQ3qenwfLKTrzPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:01:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XFucm0-JQ3qenwfLKTrzPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:01:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XFucm0-JQ3qenwfLKTrzPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:01:33 INFO - Downloaded 24443871 bytes. 10:01:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:01:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:01:34 INFO - Return code: 0 10:01: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')]} 10:01:34 INFO - https://queue.taskcluster.net/v1/task/XFucm0-JQ3qenwfLKTrzPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:01:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XFucm0-JQ3qenwfLKTrzPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:01:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XFucm0-JQ3qenwfLKTrzPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:01:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XFucm0-JQ3qenwfLKTrzPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:01:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XFucm0-JQ3qenwfLKTrzPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:01:35 INFO - Downloaded 10833369 bytes. 10:01:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:01:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:01:35 INFO - Return code: 0 10:01:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:35 INFO - https://queue.taskcluster.net/v1/task/XFucm0-JQ3qenwfLKTrzPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:01:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XFucm0-JQ3qenwfLKTrzPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:01:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XFucm0-JQ3qenwfLKTrzPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:01:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XFucm0-JQ3qenwfLKTrzPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:01:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XFucm0-JQ3qenwfLKTrzPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:01:37 INFO - Downloaded 59185180 bytes. 10:01:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XFucm0-JQ3qenwfLKTrzPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:01:37 INFO - mkdir: /builds/slave/test/properties 10:01:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:01:37 INFO - Writing to file /builds/slave/test/properties/build_url 10:01:37 INFO - Contents: 10:01:37 INFO - build_url:https://queue.taskcluster.net/v1/task/XFucm0-JQ3qenwfLKTrzPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:01:38 INFO - Running post-action listener: _resource_record_post_action 10:01:38 INFO - Running post-action listener: set_extra_try_arguments 10:01:38 INFO - ##### 10:01:38 INFO - ##### Finished download-and-extract step (success) 10:01:38 INFO - ##### 10:01:38 INFO - ##### 10:01:38 INFO - ##### Running populate-webroot step. 10:01:38 INFO - ##### 10:01:38 INFO - Running pre-action listener: _resource_record_pre_action 10:01:38 INFO - Running main action method: populate_webroot 10:01:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:01:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:01:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:01:38 INFO - '--tppagecycles', 10:01:38 INFO - '7'], 10:01:38 INFO - 'tests': ['tsvgm']}}, 10:01:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:01:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:01:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:01:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:01:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:01:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:01:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:38 INFO - 'talos_options': ['--disable-e10s'], 10:01:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:01:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:01:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:38 INFO - 'talos_options': ['--disable-e10s'], 10:01:38 INFO - 'tests': ['damp', 'tps']}, 10:01:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:38 INFO - 'tests': ['damp', 'tps']}, 10:01:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:01:38 INFO - 'tests': ['dromaeo_dom']}, 10:01:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:01:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:01:38 INFO - 'tests': ['a11yr', 10:01:38 INFO - 'ts_paint', 10:01:38 INFO - 'tpaint', 10:01:38 INFO - 'sessionrestore', 10:01:38 INFO - 'sessionrestore_no_auto_restore', 10:01:38 INFO - 'tabpaint']}, 10:01:38 INFO - 'other-e10s': {'tests': ['a11yr', 10:01:38 INFO - 'ts_paint', 10:01:38 INFO - 'tpaint', 10:01:38 INFO - 'sessionrestore', 10:01:38 INFO - 'sessionrestore_no_auto_restore', 10:01:38 INFO - 'tabpaint']}, 10:01:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:01:38 INFO - 'ts_paint', 10:01:38 INFO - 'tpaint', 10:01:38 INFO - 'sessionrestore', 10:01:38 INFO - 'sessionrestore_no_auto_restore', 10:01:38 INFO - 'tabpaint']}, 10:01:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:01:38 INFO - 'ts_paint', 10:01:38 INFO - 'tpaint', 10:01:38 INFO - 'sessionrestore', 10:01:38 INFO - 'sessionrestore_no_auto_restore', 10:01:38 INFO - 'tabpaint']}, 10:01:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:01:38 INFO - 'tests': ['a11yr', 10:01:38 INFO - 'ts_paint', 10:01:38 INFO - 'tpaint', 10:01:38 INFO - 'sessionrestore', 10:01:38 INFO - 'sessionrestore_no_auto_restore', 10:01:38 INFO - 'tabpaint']}, 10:01:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:01:38 INFO - 'tests': ['a11yr', 10:01:38 INFO - 'ts_paint', 10:01:38 INFO - 'tpaint', 10:01:38 INFO - 'sessionrestore', 10:01:38 INFO - 'sessionrestore_no_auto_restore', 10:01:38 INFO - 'tabpaint']}, 10:01:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:01:38 INFO - 'tests': ['tsvgx', 10:01:38 INFO - 'tsvgr_opacity', 10:01:38 INFO - 'tart', 10:01:38 INFO - 'tscrollx', 10:01:38 INFO - 'cart']}, 10:01:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:01:38 INFO - 'tsvgr_opacity', 10:01:38 INFO - 'tart', 10:01:38 INFO - 'tscrollx', 10:01:38 INFO - 'cart']}, 10:01:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:38 INFO - 'talos_options': ['--disable-e10s'], 10:01:38 INFO - 'tests': ['tp5o']}, 10:01:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:38 INFO - 'tests': ['tp5o']}, 10:01:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:38 INFO - 'talos_options': ['--disable-e10s', 10:01:38 INFO - '--xperf_path', 10:01:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:01:38 INFO - 'tests': ['tp5n']}, 10:01:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:38 INFO - 'talos_options': ['--xperf_path', 10:01:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:01:38 INFO - 'tests': ['tp5n']}}, 10:01:38 INFO - 'talos.zip': {'path': '', 10:01:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:01:38 INFO - Running post-action listener: _resource_record_post_action 10:01:38 INFO - ##### 10:01:38 INFO - ##### Finished populate-webroot step (success) 10:01:38 INFO - ##### 10:01:38 INFO - ##### 10:01:38 INFO - ##### Running create-virtualenv step. 10:01:38 INFO - ##### 10:01:38 INFO - Running pre-action listener: _resource_record_pre_action 10:01:38 INFO - Running main action method: create_virtualenv 10:01:38 INFO - Creating virtualenv /builds/slave/test/build/venv 10:01:38 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:01:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:01:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:01:38 INFO - Using real prefix '/usr' 10:01:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:01:39 INFO - Installing distribute.............................................................................................................................................................................................done. 10:01:41 INFO - Installing pip.................done. 10:01:41 INFO - Return code: 0 10:01:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:01:41 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')]} 10:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:41 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')]} 10:01:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:41 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 0x7f6baac7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20781c0>, '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 0x20790c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2079550>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1465232153.185901-189158371', '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 10:01:41 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 10:01:41 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 10:01:41 INFO - Using env: {'DISPLAY': ':0', 10:01:41 INFO - 'HOME': '/home/cltbld', 10:01:41 INFO - 'LANG': 'en_US.UTF-8', 10:01:41 INFO - 'LANGUAGE': 'en_US:en', 10:01:41 INFO - 'LOGNAME': 'cltbld', 10:01:41 INFO - 'MAIL': '/var/mail/cltbld', 10:01:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:41 INFO - 'MOZ_NO_REMOTE': '1', 10:01:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:41 INFO - 'NO_EM_RESTART': '1', 10:01:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:41 INFO - 'PWD': '/builds/slave/test', 10:01:41 INFO - 'SHELL': '/bin/bash', 10:01:41 INFO - 'SHLVL': '1', 10:01:41 INFO - 'TERM': 'linux', 10:01:41 INFO - 'TMOUT': '86400', 10:01:41 INFO - 'USER': 'cltbld', 10:01:41 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1465232153.185901-189158371', 10:01:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:41 INFO - '_': '/tools/buildbot/bin/python'} 10:01:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:41 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 10:01:41 INFO - Cleaning up... 10:01:41 INFO - Return code: 0 10:01:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:01:41 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')]} 10:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:41 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')]} 10:01:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:41 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 0x7f6baac7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20781c0>, '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 0x20790c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2079550>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1465232153.185901-189158371', '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 10:01:41 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 10:01:41 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 10:01:41 INFO - Using env: {'DISPLAY': ':0', 10:01:41 INFO - 'HOME': '/home/cltbld', 10:01:41 INFO - 'LANG': 'en_US.UTF-8', 10:01:41 INFO - 'LANGUAGE': 'en_US:en', 10:01:41 INFO - 'LOGNAME': 'cltbld', 10:01:41 INFO - 'MAIL': '/var/mail/cltbld', 10:01:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:41 INFO - 'MOZ_NO_REMOTE': '1', 10:01:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:41 INFO - 'NO_EM_RESTART': '1', 10:01:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:41 INFO - 'PWD': '/builds/slave/test', 10:01:41 INFO - 'SHELL': '/bin/bash', 10:01:41 INFO - 'SHLVL': '1', 10:01:41 INFO - 'TERM': 'linux', 10:01:41 INFO - 'TMOUT': '86400', 10:01:41 INFO - 'USER': 'cltbld', 10:01:41 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1465232153.185901-189158371', 10:01:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:41 INFO - '_': '/tools/buildbot/bin/python'} 10:01:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:41 INFO - Downloading/unpacking psutil>=3.1.1 10:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:01:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:01:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:01:43 INFO - Installing collected packages: psutil 10:01:43 INFO - Running setup.py install for psutil 10:01:43 INFO - building 'psutil._psutil_linux' extension 10:01:43 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:01:45 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 10:01:45 INFO - building 'psutil._psutil_posix' extension 10:01:45 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 10:01:45 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 10:01:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:01:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:01:45 INFO - Successfully installed psutil 10:01:45 INFO - Cleaning up... 10:01:45 INFO - Return code: 0 10:01:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:01: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')]} 10:01:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01: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')]} 10:01:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6baac7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20781c0>, '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 0x20790c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2079550>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1465232153.185901-189158371', '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 10:01:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:01:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:01:45 INFO - Using env: {'DISPLAY': ':0', 10:01:45 INFO - 'HOME': '/home/cltbld', 10:01:45 INFO - 'LANG': 'en_US.UTF-8', 10:01:45 INFO - 'LANGUAGE': 'en_US:en', 10:01:45 INFO - 'LOGNAME': 'cltbld', 10:01:45 INFO - 'MAIL': '/var/mail/cltbld', 10:01:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:45 INFO - 'MOZ_NO_REMOTE': '1', 10:01:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:45 INFO - 'NO_EM_RESTART': '1', 10:01:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:45 INFO - 'PWD': '/builds/slave/test', 10:01:45 INFO - 'SHELL': '/bin/bash', 10:01:45 INFO - 'SHLVL': '1', 10:01:45 INFO - 'TERM': 'linux', 10:01:45 INFO - 'TMOUT': '86400', 10:01:45 INFO - 'USER': 'cltbld', 10:01:45 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1465232153.185901-189158371', 10:01:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:45 INFO - '_': '/tools/buildbot/bin/python'} 10:01:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:01:45 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 10:01:45 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 10:01:45 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 10:01:45 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 10:01:45 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 10:01:45 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 10:01:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:01:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:01:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:01:47 INFO - Installing collected packages: mozsystemmonitor 10:01:47 INFO - Running setup.py install for mozsystemmonitor 10:01:47 INFO - Successfully installed mozsystemmonitor 10:01:47 INFO - Cleaning up... 10:01:47 INFO - Return code: 0 10:01:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:01: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')]} 10:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01: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')]} 10:01:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:47 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 0x7f6baac7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20781c0>, '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 0x20790c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2079550>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1465232153.185901-189158371', '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 10:01:47 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 10:01:47 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 10:01:47 INFO - Using env: {'DISPLAY': ':0', 10:01:47 INFO - 'HOME': '/home/cltbld', 10:01:47 INFO - 'LANG': 'en_US.UTF-8', 10:01:47 INFO - 'LANGUAGE': 'en_US:en', 10:01:47 INFO - 'LOGNAME': 'cltbld', 10:01:47 INFO - 'MAIL': '/var/mail/cltbld', 10:01:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:47 INFO - 'MOZ_NO_REMOTE': '1', 10:01:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:47 INFO - 'NO_EM_RESTART': '1', 10:01:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:47 INFO - 'PWD': '/builds/slave/test', 10:01:47 INFO - 'SHELL': '/bin/bash', 10:01:47 INFO - 'SHLVL': '1', 10:01:47 INFO - 'TERM': 'linux', 10:01:47 INFO - 'TMOUT': '86400', 10:01:47 INFO - 'USER': 'cltbld', 10:01:47 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1465232153.185901-189158371', 10:01:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:47 INFO - '_': '/tools/buildbot/bin/python'} 10:01:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:47 INFO - Downloading/unpacking jsonschema==2.5.1 10:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:01:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:50 INFO - Downloading functools32-3.2.3-2.tar.gz 10:01:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:01:50 INFO - warning: no files found matching '*.txt' 10:01:50 INFO - no previously-included directories found matching 'build' 10:01:50 INFO - no previously-included directories found matching 'dist' 10:01:50 INFO - no previously-included directories found matching '.git*' 10:01:50 INFO - Installing collected packages: jsonschema, functools32 10:01:50 INFO - Running setup.py install for functools32 10:01:50 INFO - warning: no files found matching '*.txt' 10:01:50 INFO - no previously-included directories found matching 'build' 10:01:50 INFO - no previously-included directories found matching 'dist' 10:01:50 INFO - no previously-included directories found matching '.git*' 10:01:50 INFO - Successfully installed jsonschema functools32 10:01:50 INFO - Cleaning up... 10:01:50 INFO - Return code: 0 10:01:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:01:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:50 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 0x7f6baac7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20781c0>, '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 0x20790c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2079550>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1465232153.185901-189158371', '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 10:01:50 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 10:01:50 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 10:01:50 INFO - Using env: {'DISPLAY': ':0', 10:01:50 INFO - 'HOME': '/home/cltbld', 10:01:50 INFO - 'LANG': 'en_US.UTF-8', 10:01:50 INFO - 'LANGUAGE': 'en_US:en', 10:01:50 INFO - 'LOGNAME': 'cltbld', 10:01:50 INFO - 'MAIL': '/var/mail/cltbld', 10:01:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:50 INFO - 'MOZ_NO_REMOTE': '1', 10:01:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:50 INFO - 'NO_EM_RESTART': '1', 10:01:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:50 INFO - 'PWD': '/builds/slave/test', 10:01:50 INFO - 'SHELL': '/bin/bash', 10:01:50 INFO - 'SHLVL': '1', 10:01:50 INFO - 'TERM': 'linux', 10:01:50 INFO - 'TMOUT': '86400', 10:01:50 INFO - 'USER': 'cltbld', 10:01:50 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1465232153.185901-189158371', 10:01:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:50 INFO - '_': '/tools/buildbot/bin/python'} 10:01:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:50 INFO - Downloading/unpacking blobuploader==1.2.4 10:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:52 INFO - Downloading blobuploader-1.2.4.tar.gz 10:01:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:01:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:01:52 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 10:01:52 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 10:01:52 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 10:01:52 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 10:01:52 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 10:01:52 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 10:01:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:01:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:01:52 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 10:01:52 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 10:01:52 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 10:01:52 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 10:01:52 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 10:01:52 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 10:01:53 INFO - Downloading docopt-0.6.1.tar.gz 10:01:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:01:53 INFO - Installing collected packages: blobuploader, requests, docopt 10:01:53 INFO - Running setup.py install for blobuploader 10:01:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:01:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:01:53 INFO - Running setup.py install for requests 10:01:53 INFO - Running setup.py install for docopt 10:01:53 INFO - Successfully installed blobuploader requests docopt 10:01:53 INFO - Cleaning up... 10:01:53 INFO - Return code: 0 10:01:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:01:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:53 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 0x7f6baac7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20781c0>, '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 0x20790c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2079550>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1465232153.185901-189158371', '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 10:01:53 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 10:01:53 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 10:01:53 INFO - Using env: {'DISPLAY': ':0', 10:01:53 INFO - 'HOME': '/home/cltbld', 10:01:53 INFO - 'LANG': 'en_US.UTF-8', 10:01:53 INFO - 'LANGUAGE': 'en_US:en', 10:01:53 INFO - 'LOGNAME': 'cltbld', 10:01:53 INFO - 'MAIL': '/var/mail/cltbld', 10:01:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:53 INFO - 'MOZ_NO_REMOTE': '1', 10:01:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:53 INFO - 'NO_EM_RESTART': '1', 10:01:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:53 INFO - 'PWD': '/builds/slave/test', 10:01:53 INFO - 'SHELL': '/bin/bash', 10:01:53 INFO - 'SHLVL': '1', 10:01:53 INFO - 'TERM': 'linux', 10:01:53 INFO - 'TMOUT': '86400', 10:01:53 INFO - 'USER': 'cltbld', 10:01:53 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1465232153.185901-189158371', 10:01:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:53 INFO - '_': '/tools/buildbot/bin/python'} 10:01:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:01:54 INFO - Running setup.py (path:/tmp/pip-oFX5g1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:01:54 INFO - Running setup.py (path:/tmp/pip-XTvGW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:01:54 INFO - Running setup.py (path:/tmp/pip-z6HAlL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:01:54 INFO - Running setup.py (path:/tmp/pip-eQA10L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:01:54 INFO - Running setup.py (path:/tmp/pip-zIW7yf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:01:54 INFO - Running setup.py (path:/tmp/pip-dLWJaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:01:54 INFO - Running setup.py (path:/tmp/pip-P4IMMZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:01:54 INFO - Running setup.py (path:/tmp/pip-obHtvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:01:54 INFO - Running setup.py (path:/tmp/pip-70pxbq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:01:54 INFO - Running setup.py (path:/tmp/pip-2X643V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:01:54 INFO - Running setup.py (path:/tmp/pip-IWV4e2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:01:54 INFO - Running setup.py (path:/tmp/pip-CXjVB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:01:54 INFO - Running setup.py (path:/tmp/pip-83XcsZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:01:54 INFO - Running setup.py (path:/tmp/pip-5ijZuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:01:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:01:55 INFO - Running setup.py (path:/tmp/pip-rtXd6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:01:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:01:55 INFO - Running setup.py (path:/tmp/pip-UOdUKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:01:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:01:55 INFO - Running setup.py (path:/tmp/pip-pcUFgv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:01:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:01:55 INFO - Running setup.py install for manifestparser 10:01:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:01:55 INFO - Running setup.py install for mozcrash 10:01:55 INFO - Running setup.py install for mozdebug 10:01:55 INFO - Running setup.py install for mozdevice 10:01:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:01:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:01:55 INFO - Running setup.py install for mozfile 10:01:55 INFO - Running setup.py install for mozhttpd 10:01:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:01:55 INFO - Running setup.py install for mozinfo 10:01:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:01:55 INFO - Running setup.py install for mozInstall 10:01:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:01:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:01:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:01:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:01:56 INFO - Running setup.py install for mozleak 10:01:56 INFO - Running setup.py install for mozlog 10:01:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:01:56 INFO - Running setup.py install for moznetwork 10:01:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:01:56 INFO - Running setup.py install for mozprocess 10:01:56 INFO - Running setup.py install for mozprofile 10:01:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:01:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:01:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:01:56 INFO - Running setup.py install for mozrunner 10:01:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:01:56 INFO - Running setup.py install for mozscreenshot 10:01:56 INFO - Running setup.py install for moztest 10:01:56 INFO - Running setup.py install for mozversion 10:01:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:01:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:01:56 INFO - Cleaning up... 10:01:57 INFO - Return code: 0 10:01:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:01: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')]} 10:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01: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')]} 10:01:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:57 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 0x7f6baac7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20781c0>, '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 0x20790c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2079550>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1465232153.185901-189158371', '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 10:01:57 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 10:01:57 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 10:01:57 INFO - Using env: {'DISPLAY': ':0', 10:01:57 INFO - 'HOME': '/home/cltbld', 10:01:57 INFO - 'LANG': 'en_US.UTF-8', 10:01:57 INFO - 'LANGUAGE': 'en_US:en', 10:01:57 INFO - 'LOGNAME': 'cltbld', 10:01:57 INFO - 'MAIL': '/var/mail/cltbld', 10:01:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:57 INFO - 'MOZ_NO_REMOTE': '1', 10:01:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:57 INFO - 'NO_EM_RESTART': '1', 10:01:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:57 INFO - 'PWD': '/builds/slave/test', 10:01:57 INFO - 'SHELL': '/bin/bash', 10:01:57 INFO - 'SHLVL': '1', 10:01:57 INFO - 'TERM': 'linux', 10:01:57 INFO - 'TMOUT': '86400', 10:01:57 INFO - 'USER': 'cltbld', 10:01:57 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1465232153.185901-189158371', 10:01:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:57 INFO - '_': '/tools/buildbot/bin/python'} 10:01:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:01:57 INFO - Running setup.py (path:/tmp/pip-B3N0hh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:01:57 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)) 10:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:01:57 INFO - Running setup.py (path:/tmp/pip-NjBpW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:01:57 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)) 10:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:01:57 INFO - Running setup.py (path:/tmp/pip-G1JPBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:01:57 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)) 10:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:01:57 INFO - Running setup.py (path:/tmp/pip-qz_nJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:01:57 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)) 10:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:01:57 INFO - Running setup.py (path:/tmp/pip-l8qrnD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:01:57 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)) 10:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:01:57 INFO - Running setup.py (path:/tmp/pip-xmd0fU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:01:57 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)) 10:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:01:57 INFO - Running setup.py (path:/tmp/pip-yOjX2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:01:57 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)) 10:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:01:57 INFO - Running setup.py (path:/tmp/pip-QyNowM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:01:57 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)) 10:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:01:57 INFO - Running setup.py (path:/tmp/pip-L84NBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:01:57 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)) 10:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:01:57 INFO - Running setup.py (path:/tmp/pip-QPlrlj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:01:57 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)) 10:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:01:57 INFO - Running setup.py (path:/tmp/pip-z3L5Pt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:01:58 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)) 10:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:01:58 INFO - Running setup.py (path:/tmp/pip-rmRtrC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:01:58 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)) 10:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:01:58 INFO - Running setup.py (path:/tmp/pip-K3iqDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:01:58 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)) 10:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:01:58 INFO - Running setup.py (path:/tmp/pip-YHhVaY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:01:58 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)) 10:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:01:58 INFO - Running setup.py (path:/tmp/pip-zc46kj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:01:58 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)) 10:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:01:58 INFO - Running setup.py (path:/tmp/pip-YeweYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:01:58 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)) 10:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:01:58 INFO - Running setup.py (path:/tmp/pip-yuC5vu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:01:58 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)) 10:01:58 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)) 10:01:58 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)) 10:01:58 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)) 10:01:58 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)) 10:01:58 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)) 10:01:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:00 INFO - Downloading blessings-1.6.tar.gz 10:02:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:02:00 INFO - Installing collected packages: blessings 10:02:00 INFO - Running setup.py install for blessings 10:02:00 INFO - Successfully installed blessings 10:02:00 INFO - Cleaning up... 10:02:00 INFO - Return code: 0 10:02:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:02:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:02:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:02:00 INFO - Reading from file tmpfile_stdout 10:02:00 INFO - Current package versions: 10:02:00 INFO - argparse == 1.2.1 10:02:00 INFO - blessings == 1.6 10:02:00 INFO - blobuploader == 1.2.4 10:02:00 INFO - docopt == 0.6.1 10:02:00 INFO - functools32 == 3.2.3-2 10:02:00 INFO - jsonschema == 2.5.1 10:02:00 INFO - manifestparser == 1.1 10:02:00 INFO - mozInstall == 1.12 10:02:00 INFO - mozcrash == 0.17 10:02:00 INFO - mozdebug == 0.1 10:02:00 INFO - mozdevice == 0.48 10:02:00 INFO - mozfile == 1.2 10:02:00 INFO - mozhttpd == 0.7 10:02:00 INFO - mozinfo == 0.9 10:02:00 INFO - mozleak == 0.1 10:02:00 INFO - mozlog == 3.2 10:02:00 INFO - moznetwork == 0.27 10:02:00 INFO - mozprocess == 0.22 10:02:00 INFO - mozprofile == 0.28 10:02:00 INFO - mozrunner == 6.11 10:02:00 INFO - mozscreenshot == 0.1 10:02:00 INFO - mozsystemmonitor == 0.3 10:02:00 INFO - moztest == 0.7 10:02:00 INFO - mozversion == 1.4 10:02:00 INFO - psutil == 3.1.1 10:02:00 INFO - requests == 1.2.3 10:02:00 INFO - wsgiref == 0.1.2 10:02:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:02:00 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')]} 10:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:00 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')]} 10:02:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:00 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 0x7f6baac7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20781c0>, '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 0x20790c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2079550>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1465232153.185901-189158371', '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 10:02:00 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 10:02:00 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 10:02:00 INFO - Using env: {'DISPLAY': ':0', 10:02:00 INFO - 'HOME': '/home/cltbld', 10:02:00 INFO - 'LANG': 'en_US.UTF-8', 10:02:00 INFO - 'LANGUAGE': 'en_US:en', 10:02:00 INFO - 'LOGNAME': 'cltbld', 10:02:00 INFO - 'MAIL': '/var/mail/cltbld', 10:02:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:00 INFO - 'MOZ_NO_REMOTE': '1', 10:02:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:00 INFO - 'NO_EM_RESTART': '1', 10:02:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:00 INFO - 'PWD': '/builds/slave/test', 10:02:00 INFO - 'SHELL': '/bin/bash', 10:02:00 INFO - 'SHLVL': '1', 10:02:00 INFO - 'TERM': 'linux', 10:02:00 INFO - 'TMOUT': '86400', 10:02:00 INFO - 'USER': 'cltbld', 10:02:00 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1465232153.185901-189158371', 10:02:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:00 INFO - '_': '/tools/buildbot/bin/python'} 10:02:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:01 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)) 10:02:01 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)) 10:02:01 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)) 10:02:01 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)) 10:02:01 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)) 10:02:01 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)) 10:02:01 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)) 10:02:01 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)) 10:02:01 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)) 10:02:01 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)) 10:02:01 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)) 10:02:01 INFO - Cleaning up... 10:02:01 INFO - Return code: 0 10:02:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:02:01 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')]} 10:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:01 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')]} 10:02:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:01 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 0x7f6baac7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20781c0>, '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 0x20790c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2079550>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1465232153.185901-189158371', '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 10:02:01 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 10:02:01 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 10:02:01 INFO - Using env: {'DISPLAY': ':0', 10:02:01 INFO - 'HOME': '/home/cltbld', 10:02:01 INFO - 'LANG': 'en_US.UTF-8', 10:02:01 INFO - 'LANGUAGE': 'en_US:en', 10:02:01 INFO - 'LOGNAME': 'cltbld', 10:02:01 INFO - 'MAIL': '/var/mail/cltbld', 10:02:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:01 INFO - 'MOZ_NO_REMOTE': '1', 10:02:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:01 INFO - 'NO_EM_RESTART': '1', 10:02:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:01 INFO - 'PWD': '/builds/slave/test', 10:02:01 INFO - 'SHELL': '/bin/bash', 10:02:01 INFO - 'SHLVL': '1', 10:02:01 INFO - 'TERM': 'linux', 10:02:01 INFO - 'TMOUT': '86400', 10:02:01 INFO - 'USER': 'cltbld', 10:02:01 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1465232153.185901-189158371', 10:02:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:01 INFO - '_': '/tools/buildbot/bin/python'} 10:02:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:02:01 INFO - Cleaning up... 10:02:01 INFO - Return code: 0 10:02:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:02:01 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')]} 10:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:01 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')]} 10:02:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:01 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 0x7f6baac7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20781c0>, '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 0x20790c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2079550>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1465232153.185901-189158371', '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 10:02:01 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 10:02:01 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 10:02:01 INFO - Using env: {'DISPLAY': ':0', 10:02:01 INFO - 'HOME': '/home/cltbld', 10:02:01 INFO - 'LANG': 'en_US.UTF-8', 10:02:01 INFO - 'LANGUAGE': 'en_US:en', 10:02:01 INFO - 'LOGNAME': 'cltbld', 10:02:01 INFO - 'MAIL': '/var/mail/cltbld', 10:02:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:01 INFO - 'MOZ_NO_REMOTE': '1', 10:02:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:01 INFO - 'NO_EM_RESTART': '1', 10:02:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:01 INFO - 'PWD': '/builds/slave/test', 10:02:01 INFO - 'SHELL': '/bin/bash', 10:02:01 INFO - 'SHLVL': '1', 10:02:01 INFO - 'TERM': 'linux', 10:02:01 INFO - 'TMOUT': '86400', 10:02:01 INFO - 'USER': 'cltbld', 10:02:01 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1465232153.185901-189158371', 10:02:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:01 INFO - '_': '/tools/buildbot/bin/python'} 10:02:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:01 INFO - Downloading/unpacking flake8 10:02: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 10:02: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 10:02: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 10:02: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 10:02: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 10:02: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 10:02:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:02:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:02:03 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 10:02:03 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 10:02:03 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 10:02:03 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 10:02:03 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 10:02:03 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 10:02:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:02:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:02:03 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 10:02:03 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 10:02:03 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 10:02:03 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 10:02:03 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 10:02:03 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 10:02:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:02:03 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 10:02:03 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 10:02:03 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 10:02:03 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 10:02:03 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 10:02:03 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 10:02:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:02:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:02:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:02:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:02:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:02:04 INFO - no previously-included directories found matching 'docs/_build' 10:02:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:02:04 INFO - Running setup.py install for pep8 10:02:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:02:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:02:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:02:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:02:04 INFO - no previously-included directories found matching 'docs/_build' 10:02:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:02:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:02:04 INFO - Cleaning up... 10:02:04 INFO - Return code: 0 10:02:04 INFO - Running post-action listener: _resource_record_post_action 10:02:04 INFO - Running post-action listener: _start_resource_monitoring 10:02:04 INFO - Starting resource monitoring. 10:02:04 INFO - ##### 10:02:04 INFO - ##### Finished create-virtualenv step (success) 10:02:04 INFO - ##### 10:02:04 INFO - ##### 10:02:04 INFO - ##### Running install step. 10:02:04 INFO - ##### 10:02:04 INFO - Running pre-action listener: _resource_record_pre_action 10:02:04 INFO - Running main action method: install 10:02:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:02:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:02:04 INFO - Reading from file tmpfile_stdout 10:02:04 INFO - Detecting whether we're running mozinstall >=1.0... 10:02:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:02:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:02:04 INFO - Reading from file tmpfile_stdout 10:02:04 INFO - Output received: 10:02:04 INFO - Usage: mozinstall [options] installer 10:02:04 INFO - Options: 10:02:04 INFO - -h, --help show this help message and exit 10:02:04 INFO - -d DEST, --destination=DEST 10:02:04 INFO - Directory to install application into. [default: 10:02:04 INFO - "/builds/slave/test"] 10:02:04 INFO - --app=APP Application being installed. [default: firefox] 10:02:04 INFO - mkdir: /builds/slave/test/build/application 10:02:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:02:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:02:21 INFO - Reading from file tmpfile_stdout 10:02:21 INFO - Output received: 10:02:21 INFO - /builds/slave/test/build/application/firefox/firefox 10:02:21 INFO - Running post-action listener: _resource_record_post_action 10:02:21 INFO - ##### 10:02:21 INFO - ##### Finished install step (success) 10:02:21 INFO - ##### 10:02:21 INFO - ##### 10:02:21 INFO - ##### Running run-tests step. 10:02:21 INFO - ##### 10:02:21 INFO - Running pre-action listener: _resource_record_pre_action 10:02:21 INFO - Running main action method: run_tests 10:02:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:02:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:02:21 INFO - Python 2.7.3 10:02:21 INFO - Return code: 0 10:02:21 INFO - grabbing minidump binary from tooltool 10:02:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:21 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20781c0>, '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 0x20790c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2079550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:02:21 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:02:21 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:02:21 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:02:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:02:21 INFO - Return code: 0 10:02:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:02:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:02:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:02:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:02:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:02:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:02:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:02:22 INFO - Return code: 0 10:02:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XFucm0-JQ3qenwfLKTrzPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:02:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XFucm0-JQ3qenwfLKTrzPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:02:22 INFO - Using env: {'DISPLAY': ':0', 10:02:22 INFO - 'HOME': '/home/cltbld', 10:02:22 INFO - 'LANG': 'en_US.UTF-8', 10:02:22 INFO - 'LANGUAGE': 'en_US:en', 10:02:22 INFO - 'LOGNAME': 'cltbld', 10:02:22 INFO - 'MAIL': '/var/mail/cltbld', 10:02:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:02:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:02:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:22 INFO - 'MOZ_NO_REMOTE': '1', 10:02:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:02:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:22 INFO - 'NO_EM_RESTART': '1', 10:02:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:22 INFO - 'PWD': '/builds/slave/test', 10:02:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:02:22 INFO - 'SHELL': '/bin/bash', 10:02:22 INFO - 'SHLVL': '1', 10:02:22 INFO - 'TERM': 'linux', 10:02:22 INFO - 'TMOUT': '86400', 10:02:22 INFO - 'USER': 'cltbld', 10:02:22 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1465232153.185901-189158371', 10:02:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:22 INFO - '_': '/tools/buildbot/bin/python'} 10:02:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XFucm0-JQ3qenwfLKTrzPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:02:23 INFO - mozversion application_buildid: 20160606073136 10:02:23 INFO - mozversion application_changeset: 581cba07c3793b9788f8e041481e99874f05fa01 10:02:23 INFO - mozversion application_display_name: Nightly 10:02:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:02:23 INFO - mozversion application_name: Firefox 10:02:23 INFO - mozversion application_remotingname: firefox 10:02:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:02:23 INFO - mozversion application_vendor: Mozilla 10:02:23 INFO - mozversion application_version: 49.0a1 10:02:23 INFO - mozversion platform_buildid: 20160606073136 10:02:23 INFO - mozversion platform_changeset: 581cba07c3793b9788f8e041481e99874f05fa01 10:02:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:02:23 INFO - mozversion platform_version: 49.0a1 10:02:23 INFO - using testdate: 1465232543 10:02:23 INFO - actual date: 1465232543 10:02:23 INFO - starting webserver on 'localhost:46933' 10:02:23 INFO - SUITE-START | Running 2 tests 10:02:23 INFO - TEST-START | dromaeo_css 10:02:23 INFO - operating with platform_type : linux_ 10:02:23 INFO - Initialising browser for dromaeo_css test... 10:02:23 INFO - TEST-INFO | started process 3280 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXZkWaJ/profile http://localhost:46933/getInfo.html) 10:02:28 INFO - PROCESS | 3280 | __metrics Screen width/height:1600/1200 10:02:28 INFO - PROCESS | 3280 | colorDepth:24 10:02:28 INFO - PROCESS | 3280 | Browser inner width/height: 1024/697 10:02:28 INFO - PROCESS | 3280 | __metrics 10:02:29 ERROR - PROCESS | 3280 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:02:29 INFO - PROCESS | 3280 | console.error: PushService: 10:02:29 INFO - PROCESS | 3280 | stateChangeProcessEnqueue: Error transitioning state 10:02:29 INFO - PROCESS | 3280 | UnknownError 10:02:30 INFO - TEST-INFO | 3280: exit 0 10:02:30 INFO - Browser initialized. 10:02:30 INFO - Running cycle 1/1 for dromaeo_css test... 10:02:30 INFO - TEST-INFO | started process 3366 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXZkWaJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:02:42 INFO - PROCESS | 3366 | RSS: Main: 156319744 10:02:42 INFO - PROCESS | 3366 | 10:03:33 INFO - PROCESS | 3366 | 1465232613584 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] 10:05:41 INFO - PROCESS | 3366 | Cycle 1(1): loaded http://localhost:46933/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46933/tests/dromaeo/cssquery-ext.html) 10:05:42 INFO - PROCESS | 3366 | RSS: Main: 246779904 10:05:42 INFO - PROCESS | 3366 | 10:08:44 INFO - PROCESS | 3366 | Cycle 1(1): loaded http://localhost:46933/tests/dromaeo/cssquery-ext.html (next: http://localhost:46933/tests/dromaeo/cssquery-jquery.html) 10:08:45 INFO - PROCESS | 3366 | RSS: Main: 240660480 10:08:45 INFO - PROCESS | 3366 | 10:11:47 INFO - PROCESS | 3366 | Cycle 1(1): loaded http://localhost:46933/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46933/tests/dromaeo/cssquery-mootools.html) 10:11:47 INFO - PROCESS | 3366 | RSS: Main: 250667008 10:11:47 INFO - PROCESS | 3366 | 10:14:49 INFO - PROCESS | 3366 | Cycle 1(1): loaded http://localhost:46933/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46933/tests/dromaeo/cssquery-prototype.html) 10:14:50 INFO - PROCESS | 3366 | RSS: Main: 233439232 10:14:50 INFO - PROCESS | 3366 | 10:17:52 INFO - PROCESS | 3366 | Cycle 1(1): loaded http://localhost:46933/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46933/tests/dromaeo/cssquery-yui.html) 10:17:53 INFO - PROCESS | 3366 | RSS: Main: 230232064 10:17:53 INFO - PROCESS | 3366 | 10:20:56 INFO - PROCESS | 3366 | Cycle 1(1): loaded http://localhost:46933/tests/dromaeo/cssquery-yui.html (next: http://localhost:46933/tests/dromaeo/cssquery-dojo.html) 10:20:56 INFO - PROCESS | 3366 | RSS: Main: 284282880 10:20:56 INFO - PROCESS | 3366 | 10:20:56 INFO - PROCESS | 3366 | __start_tp_report 10:20:56 INFO - PROCESS | 3366 | _x_x_mozilla_page_load 10:20:56 INFO - PROCESS | 3366 | _x_x_mozilla_page_load_details 10:20:56 INFO - PROCESS | 3366 | |i|pagename|runs| 10:20:56 INFO - PROCESS | 3366 | |0;dojo.html;3148.858301376438;3153.4954407294836;3167.683231676832;3199.168216263771;3214.389266039452;5140.948590514103;5225.660332078422;5296.708681022542;5365.222042803791;5385.596080293979;5227.189785583231;5262.131748261532;5286;5311.256424100629;5313.256144139824;4772.451168115667;4830.420349558058;4847.830325938593;4864.5135486451245;4981.825636102737;4868.367112275399;4936.234883593031;4946.826861059863;4953.653244272902;4964.329815474901;4703.365045718835;4708.246680531116;4731.905361892777;4735.360726301939;4873.8781530461665;4721.291806229093;4738.810447582093;4742.359781429497;4810.927836082462;4852.17513022787;4800.375951126366;4808.350872632185;4814.831480898187;4815.711057336536;4817.397825271841;5082.949170508285;5210.947890521084;5283.392409872837;5291.708956007418;5343.893122137574;5721.170430287627;5732.168835518868;5762.164486149485;5762.250907382056;5768.913466297967;5426.104692725696;5762.971185144047;5789.421057894177;5799.652020878761;5816.272965879265;5270;5332.946670533283;5333.5199832015305;5391.48780865821;5401.567874570025;5858.062709966385;5873.148393482921;5876.236089308362;5881.264841894763;5883.14694369314;5408.080626293539;5635.5773317001385;5646.2942132233475;5647.915281270784;5648.548116150698;5550.72246387679;5569.331680198402;5602.299712535933;5649.887002259932;5651.15232715096;5614.63504872182;5618.634788738801;5623.268975033301;5623.662580245198;5625.46558076982;5458;5550.7779688812;5588.133839254922;5615.943840561542;5644.3508996465935;4336.6530677545725;4346.326319420495;4348.630366418826;4394.033312671208;4396.1647287016;3865.323568375523;3871.8064096795047;3878.84484620612;3899.239648268617;3914.4911161549385;5068.442471328225;5126.7180305083575;5205.843824685266;5259.47405259471;5351.518363347317;5594.748236329375;5628.85927851807;5648.915266271009;5653.830385088454;5693.459121383462;5274.4198138204765;5281.815136470205;5285.445028272053;5287.709175995357;5339.866503337447;4682.859514214579;4776.832810851603;4779.976100119477;4780.593649539828;4832.51674832521;5889.146073819272;5891.823245302648;5895.174675545427;5896.911546326808;5934.970325148433;5720.914186287292;5726.341470730836;5731.426857314402;5737.08206686928;5743.741531631003;5743.3395159557185;5806;5842.2405087338375;5875.882482350244;5908.3205431375945;5607.130894711327;5616.241807355955;5616.971915140398;5617.887642247214;5624.493795558419;5678.346990096192;5712.457316554921;5718.199452076796;5724.370319264961;5726.255586773859;5376.973115134399;5399.919001215064;5430.70131142791;5457.208704737712;5492.697901615449;5487.314085739283;5489.231507588861;5489.670619762827;5491.807786727445;5492.258545096361;5213.843584692465;5295.417504074471;5335.546478549367;5341.385740639721;5396.190571414162;5484.314460692413;5521.834344969658;5543.750531226024;5594.244776955059;5629.324481062299;5443.455654434683;5445.83662490126;5452.400235974119;5457.61796674229;5492.368377636463 10:20:56 INFO - PROCESS | 3366 | |1;ext.html;589.0722112672541;619.6839611797988;622.2315440431069;635.5963962883568;643.2056410333238;33717.83141084294;45097.32354014692;45633;45715.31427028597;45742.54257457425;46514.76742616282;46935.76532117343;47010.529894701045;47091;47110;8006.519608823489;8654.48073115612;8795.076516965722;8836.469811811312;10468.947655261712;10296.845547316796;10682.412467314294;10702.518386672618;10708.036276735093;10714.946425267863;10659.626913058044;10732.78534429311;10732.892671073267;10734.302270352402;10734.30227035244;8026.077001144856;10387.169026477864;10627.46862656868;10634.30876992993;10636.946815265952;10555.947220263926;10644.57421703131;10647.57409703611;10655.413952232624;10662.200334974908;42531.7873410631;42958.78520607377;43108;43144.352834707504;43155.13689726188;3556.8577256909693;3656.8720094796554;3746.269477451898;3773.867914622975;3948.506436695413;32410.351792964244;32502.674973250203;33256.33487330264;33474.49788253178;33789.49315760266;3835.0412396900774;3856.903577410559;3882.864099756523;3942.5268967724055;3953.1105501262273;359308;362949;363601;365069.9999999973;365192;61109;61210.0818487723;61439.38560614337;61548.38451615426;61606.38393616006;35855.282894341966;36665.633343666756;36678.449823252675;37684;37685.43471847924;16957.745633815503;17087.572810679583;17103.23035463407;17117.400890968755;17141;12964;13027.283499407624;13041.282729449782;13056.281904495345;13060;19345.12946917392;19374.73532122667;19526.22032648346;19597.31409400664;19605.50986225356;6215;7102.609356485443;7237.384822290164;7401.925980740231;7728.6522106505345;1061.1775873697945;1070.8969761146031;1071.2982996137541;1116.6984914073155;1149.9252548584316;31844.522332165037;32976;33064.173395665304;33090.338193236;33509.83245083759;1084.7233955341496;1158.102470585303;1175.6884425627215;1189.7679952409196;1214.3503225774168;17176.31294748221;17227.91386043087;17322.740158897628;17330.74003889943;17386.391476298268;526207;530508;531312;531893;532337;59927.400725992185;61206.081908771404;61407;61426;61448;1314.2902832470359;1389.0138002018477;1394.9930250348684;1395.2535393564394;1418.8439271680106;30670.233244169074;31805.20486987844;32188.19529511781;32327.35345293128;32529;51717.741411294206;52315.21527177019;52387;52421.47578524166;52457.47542524526;409869;410712;411189;411452;412967;27528.174154775388;27890.163295101178;28271.29321766972;28387.71612283851;28388.716112839433;46656.533434665216;48359.27461088157;49458.50541494683;50009.499905000484;50760.23859642034;39889.401658975716;44333.77833110814;44841.551584483735;44969.10061798811;45844.31233531566;41612.007444934694;42010.78994605008;42186.78906605447;42458;42516.362254566826;42089.78955105205;42124.57875421207;42857.57142428536;42968;43274.35088473612;37396;38407.42388864225;38717.03207419725;38923;39372.80313598413;29159.708402915698;29266.7073329264;29354.55968160522;29551;29573.556396653636 10:20:56 INFO - PROCESS | 3366 | |2;jquery.html;394.98617548385795;397.80308747170153;398.97406668566543;402.45668347730566;416.66874834506564;14133.717325653506;18130.27478900844;18863.43409697708;19653.705194422095;19654.803451965494;15567.455139070134;18042.639147217047;18850.90574547129;18852.43442696718;18888.33890813822;5659.8585035374035;5813.186153938452;5863.179154918314;5869.647821130746;5879.029960056586;4195.958040419588;4399.42807435033;5827.096799995987;6178.38216178383;6514.869702605945;6471.935280647204;6541.4112729854305;6596.076549283104;6605;6605.273419923805;6411.3588641135975;6430.614163150226;6517.0224466329955;6529.967350163266;6574.474042076622;5603.3836278009385;5753.252077229975;5769.423057694239;5792.420757924174;5796.565257605655;22459.550808983728;23268.06927722889;23318.3004509865;23370.298891033126;23481.647775283385;2508.1723031399592;2539.8349107307968;2551.1708694674303;2730.5118710302736;2933.1933718227447;14118;14316.42734290627;14490.71018579633;14595.197264150467;15232.238388080552;1931.381957773513;1971.7239586457908;1987.5329297615049;2056.5475595368994;2074.8858812765293;83786.16213837845;85310.57344713299;85479;85632.57183714103;85641.57179214065;9625.278104142217;9800.65697700577;9922.603095876084;10059.44673042975;10551.84172237417;13284.608770421417;13336.466541338237;13427.865721342858;13428.731425371438;13438.529651462348;7965.960170199112;8133.227343402367;8161.510309381456;8261;8273.296769774517;7244.166920804175;8280.917190828135;8289;8298.294644955246;8335.083140854502;4641.907161856744;4771.809127634925;4873.31773551703;4905.288733133676;4925.507449255046;1963.4993076765334;1979.416072258687;2005.4184286556736;2027.8377729781582;2029.4723371923405;896.9372143949992;986.6990567876867;1004.9296549241483;1052.1687866585312;1095.758933034747;18216.544586385447;19155.13801878919;19789;19893.801061989485;20184.394468165978;1005.3967619428284;1034.6120204923154;1072.3458690198972;1121.5906194239208;1128.5711429656842;10822.78354432907;11203.775924481464;11232.66302010941;11297.887021129683;11322.886771132184;485236;498509;501613;502411;503384;93256.53371733234;95395;95914;96051.51974240084;96230.51884740531;1035.9896401035894;1042.7549525861416;1079.5843600213975;1097.8572785537829;1111.127764704703;17545.912270438566;17601.64796704033;17777.644447111245;17889.552761180556;18087.276508939496;41914.790426048894;42028.57971420369;42089.36865947075;42969.3554596675;44096;57052;58386;58403.4159658398;59274.40725592689;59349.703251483465;6396.872062558816;7507.849843003219;8682.392232543662;8877.644894204417;9143.817123657622;9350.53247337644;12440.315782632042;12891.548795792101;12937.159084659466;13097.279649619362;11297.43512824372;11554.884451155382;11614.361210133524;11647.534098635959;11721.296722196696;11292;11423.714407139889;11490.195686301879;11518.654440366803;11574.479148438171;6312.621242725451;11377.829332559853;11519.596814111466;11632.185746997968;11635.941820290844;8834.160754728291;8985.595648195716;8990.651402289708;9043.909560904307;9161.725148245563;11352.943235284101;11717.12121590867;11731.41342932867;11738.295702257892;11789.764204715686 10:20:56 INFO - PROCESS | 3366 | |3;mootools.html;1358.0154388068645;1521.6424140327022;1547.0485651324436;1697.5586347549634;1829.2865782344888;8335.91664083359;8688.956555217232;8723.956380218098;8986.865197022034;8989.460632362063;8815.86776198356;8831.867521987175;8900.643974241022;8949.686760963368;8951.86572201416;2046.3963130876427;2322.222055611372;2402.7957623602015;2431.4407686232175;2432.20953190213;2360.8937597808053;2375.1449478187837;2388.9761102389016;2390.1156572068357;2390.832641715072;2356.905723771047;2368.14746691191;2385.6063749481314;2386.0098059305456;2387.737348891629;1980.8118228768244;2029.2086086426305;2038.1541660210994;2242.9887850560644;2322.8954697038675;2279.1567120165478;2317.165820304689;2317.3279748872806;2321.0947730385165;2323.2217207235594;8809.251213646849;8860.291176705912;8876.245519130882;8877.55612219393;8878.156575125353;5069.898602027975;5175.741212939376;5189.325387699575;5191.195364718475;5193.558547523465;3283.5731354923705;3345.0968238575692;3418.8461519231696;3428.7428442866635;3444.2422667013216;1117.580907159815;1131.8754936956927;1164.0745607242263;1194.994025029878;1201.627495476405;12516.249025058434;12533.248005119722;12554.121211515198;12555.121141520098;12563.434645440886;4768.57082862544;4820.807167713252;4844.224924012141;4881.999190166008;4892.68197567157;10419.42693151884;10463.424511651932;10491.737706557244;10536.473176341153;10547.103496202755;5393.4336894626285;5443.782248710087;5444.455554444603;5446.455354464601;5447.918281225785;4269.5090064642345;4718.363020992191;4894.681845680019;4897.1185186666025;4903.387076615423;4102.569230230843;4126.773027483458;4135.6898232632675;4136.296829538986;4238.215930052888;1296.1315918334737;1302.9674258143623;1314.7830607949772;1324.9072564920364;1327.4491086199312;904.968326108583;1017.5624481473037;1031.0926384781494;1043.4886905416442;1052.736815796051;5947.940520594739;5977.282726072812;6040.879182416415;6065.120557519135;6204.751809927642;470.5929371094048;491.14295554258047;1008.7679833638158;1017.3082304033328;1027.7995790820867;4099.508059032935;4126.814293356806;4209.915801683949;4236.639885609758;4246.150769845982;10737.35575865435;11073.390963496924;11083.334999900031;11100.167487438475;11103.888961110448;10842.620508282173;11097.33415995043;11131.777364452666;11139.610113645984;11161.776764464828;7944.404169687296;8100.797480062928;8207.425480216327;8270.214329638675;8311.501309921303;5651.265335506358;5755;5857.0043092673495;5866.032104702676;5935.792247271324;9647.807043858944;10234.795304093728;10360.119389851947;10377.27359084887;10384.42885641297;9670.56482458277;10037.849432258376;10066.396016239049;10361.326513776581;10363.896361036595;7412.4070074394995;7646.8088297793;7650.961745191461;7915.9208407915185;8075.838483230185;8632.007319158378;8639.352048596505;8643.56782160902;8681.565921704016;8684.522351270742;7625.23747625233;7949.562774047483;7968.243016913384;8020.83958320842;8180.059293181361;7823.8435231293915;8081.191880811872;8107.432479726598;8219.301359384519;8231.588420579066;7026.508144429841;7145.678444469907;7211.99032135491;7215.062041934515;7240.855182896207;5329.653572517774;5417.483104730682;5520.585956053232;5527.695976721158;5557.083081291542;5372.516473517402;5386.218998245155;5523.861903452285;5545.251391062155;5647.1529270609735 10:20:56 INFO - PROCESS | 3366 | |4;prototype.html;320.17235446371114;334.5934689352437;337.9678930501603;343.1643946989081;345.29904294282613;5197.2589182623815;5352.545033672138;5369.952859192459;5380.435054319294;5400.810971615994;5285.577153827694;5315.867103322409;5316.3354580677415;5338.252644629755;5357.732113394324;4164.895877603054;4175.582441755831;4183.4770653668365;4223.852165174219;4226.577342265779;3828.3874580067195;3946.7237293389476;4149.336106223005;4156;4169;4032.556418793945;4072.7149099563044;4081.8367265309503;4105.261053010457;4111.60939710727;3978.8607398740905;4086.1010577672864;4091.3249313863175;4093.2018256440006;4104.15864747726;3536.257385948954;3566.5006899033897;3589.8025608591515;3601.693856022215;3608.6210947850623;5154.974225128888;5170.466471428973;5180.740962951837;5193.68837869729;5243.2959288231095;4605.664357336368;4734.55021772931;4740.715557066553;4741.288806678991;4756.952430475685;5412.377576578665;5529.364123125852;5543.974364742536;5556.833295001156;5578.219049333096;3978.9403158952637;3981.3629819228786;3991.6806655467494;4017.8392864285393;4027.2750904837117;5394.190871369326;5595.328560572757;5892.263467066617;5901.4098590141075;5916.704164791786;4031.3751368537924;4051.9392209116886;4061.005053761847;4073.307537718595;4103.938440923389;4105.609967053125;4125.5874412558505;4128.91742165155;4131.091159944807;4144.316187828975;4692.779877231944;4749.548792864673;4750.572448479654;4766.213574760195;4769.236922092448;5365.490278423544;5610.4670056344585;5612.831615051555;5632.3804381518;5674.751554657969;1408.6265890756636;1417.9149251044971;1421.8720315171684;1437.360374633299;1442.2860683961505;872.2934423117296;914.6570036236411;919.797644518205;927.1331305229631;937.4750139921666;4772.904541909212;4810.5670489656095;4820.855374338776;4841.0469613535715;4848.860517778319;5089.770960306795;5121.769520371592;5134.332536770271;5165.66423182492;5212.40057393397;4585.633149348044;4749.667523273338;4779.211430114062;4819.939613285072;4843.958548912001;2713.91858244253;2732.153032559913;2732.234974207225;2732.8496932668495;2739.315171207198;5251.894962100737;5278.287431196739;5328.760205790749;5374.6506477078865;5410.377806552218;4822.807087716452;5165.509276618715;5213.5851017583545;5276.788928442896;5291.259223708684;5254.290670759398;5257.973710131425;5710.771569137188;5799.159121927297;5959.255093113361;5718.828435146952;5719.456651618089;5744.770209191753;5746;5761.683107429131;5536.474034966672;5694.487496125369;5698.487136157766;5702.830919661543;5708.172315014383;5910.911336329872;5923.466887980103;5944.227250457413;5961.8807623846415;5966.642001479925;4044.3326851069246;4075.49056367954;4080.816363263601;4104.610062044101;4109.178164367078;5504.752286147213;5750.332403602908;5755.65466072037;5807.76768929255;5821.446962538552;5513.531349835309;5532.778688852401;5545.029619816435;5597.468240517144;5601.971990140023;5555.583331250092;5566.610337276352;5575.052241118939;5579.553635709052;5592.944070559242;5186.662866913639;5417.674939503642;5439.728013599225;5451.373092094302;5484.61607687458;5574.414686457863;5593.580481463825;5596.972015139898;5627;5639.774409023593;5294.867628309323;5479.452054794648;5512.94031812348;5533.174052562565;5558.194061861089 10:20:56 INFO - PROCESS | 3366 | |5;yui.html;739.2939742545866;767.8310771630242;795.117419664173;827.3422629009937;862.7843039240192;15262.771058434118;16120.838791612081;16172.43396481122;16207;16222.918885405556;14944.775828362583;15064.849351506482;15085.773713394308;15682.529524114294;16384.344626214966;680.6426626021329;818.6316157729016;824.2993455562784;826.1944604011101;826.6280173921729;690.858374033322;691.029104108728;691.1395312835526;802.8514724775906;823.5758584329076;876.7325965580527;879.0374539878823;879.1296616349831;879.6613303878021;879.7316818370394;868.7350358140765;870.268974061788;870.6169285514353;871.0331531999444;871.0766587417357;528.3342987835317;605.5942518512608;622.3589702606323;622.7477871462065;634.7143785296635;15627.140507272095;15788;15844;15873.603159920978;15877.126758028304;14465.638359041002;14942.477013304591;14983.625409364744;15006.549803505912;15010.174440405774;13072.346382680924;13462.057655964087;13613.251271180081;13644.727105457836;13945.860541394557;4587.747673877935;4634.606058485033;4638.327442520816;4646.186917289461;4654.69744466612;64850.67574662144;67452.6627366865;67932.6603366985;75725.62137189279;77998.61000695017;12676.619701408972;12681.809772853414;12701.93649031749;12724.767584721687;12883.549075782303;23251.88374058119;23256;23274.65088023681;23284.417889552897;23303.06787728472;8920.330975176888;9072.95463522678;9205.079492050876;9214.078592140731;9288.396254243453;4696.718196908197;4699.365585645963;4851.975740121276;4869.488703686133;5105.259737338065;3555.6444355564236;3674.2651469706166;3699.2786406650985;3703.166787472797;3707.7775333480076;628.7359309090193;638.6040654794058;651.3486513486514;652.54974067893;653.6633633678659;774.4501404003221;784.4861615641764;789.5854676294877;809.9473534220257;812.8740045292989;9823.312368134304;9866.851997220047;10075.244356673278;10132.898671013343;10172.643957461454;654.2966311215463;655.9043854883602;751.9511231770027;777.3897490469953;785.4344871692373;4684.601808846286;4810.59109975656;4865.7323847188745;4877.95122048775;4948.773240850246;102144.48927755313;104703.4764826171;107741.49666618717;111735;111887.44056279666;66791.3320866785;91769.54115229381;92604.53697731468;93282.53358733164;95738.52130739302;60755.696221519494;83108;84489.15510844813;84589;85073;9377.703099056387;9430.717078487656;9507.762305942406;9527.904720952702;9651.758706032124;51884.74057629688;52779.73610131925;52892.73553632207;53810;55004.17493737517;72152;75562.24437755551;76059;76916.61541692256;80783.59608201921;12853.935730321662;13074;13108.868911311147;13163;13352.132111412728;13054.412551435398;13055.477780889038;13270.203787772765;13759.243241621807;14569.125852448888;12640.494380224687;12728.61814145577;12764.680882978;12977.221366718028;13399.33003349809;12609.93695031519;12647.92492638136;12668.113232074034;12790.808137878126;13309.534166304133;12733.363331833556;12834.101612887009;12879.227246365248;13043.804342935053;13080.084394092322;10016.497644255442;10116.443595602312;10128.898711012796;10653.307535010199;10669.89330106689;11197.72005699864;11352.764019215105;11388.202825802446;11474.4262786862;11507.884921150682 10:20:56 INFO - PROCESS | 3366 | __end_tp_report 10:20:56 INFO - PROCESS | 3366 | __start_cc_report 10:20:56 INFO - PROCESS | 3366 | _x_x_mozilla_cycle_collect,779 10:20:56 INFO - PROCESS | 3366 | __end_cc_report 10:20:56 INFO - PROCESS | 3366 | __startTimestamp1465233656327__endTimestamp 10:20:56 INFO - PROCESS | 3366 | 10:20:56 INFO - PROCESS | 3366 | ------- Summary: start ------- 10:20:56 INFO - PROCESS | 3366 | Number of tests: 6 10:20:56 INFO - PROCESS | 3366 | 10:20:56 INFO - PROCESS | 3366 | [#0] dojo.html Cycles:165 Average:5254.63 Median:5408.08 stddev:586.60 (10.8%) stddev-sans-first:564.66 10:20:56 INFO - PROCESS | 3366 | Values: 3148.9 3153.5 3167.7 3199.2 3214.4 5140.9 5225.7 5296.7 5365.2 5385.6 5227.2 5262.1 5286.0 5311.3 5313.3 4772.5 4830.4 4847.8 4864.5 4981.8 4868.4 4936.2 4946.8 4953.7 4964.3 4703.4 4708.2 4731.9 4735.4 4873.9 4721.3 4738.8 4742.4 4810.9 4852.2 4800.4 4808.4 4814.8 4815.7 4817.4 5082.9 5210.9 5283.4 5291.7 5343.9 5721.2 5732.2 5762.2 5762.3 5768.9 5426.1 5763.0 5789.4 5799.7 5816.3 5270.0 5332.9 5333.5 5391.5 5401.6 5858.1 5873.1 5876.2 5881.3 5883.1 5408.1 5635.6 5646.3 5647.9 5648.5 5550.7 5569.3 5602.3 5649.9 5651.2 5614.6 5618.6 5623.3 5623.7 5625.5 5458.0 5550.8 5588.1 5615.9 5644.4 4336.7 4346.3 4348.6 4394.0 4396.2 3865.3 3871.8 3878.8 3899.2 3914.5 5068.4 5126.7 5205.8 5259.5 5351.5 5594.7 5628.9 5648.9 5653.8 5693.5 5274.4 5281.8 5285.4 5287.7 5339.9 4682.9 4776.8 4780.0 4780.6 4832.5 5889.1 5891.8 5895.2 5896.9 5935.0 5720.9 5726.3 5731.4 5737.1 5743.7 5743.3 5806.0 5842.2 5875.9 5908.3 5607.1 5616.2 5617.0 5617.9 5624.5 5678.3 5712.5 5718.2 5724.4 5726.3 5377.0 5399.9 5430.7 5457.2 5492.7 5487.3 5489.2 5489.7 5491.8 5492.3 5213.8 5295.4 5335.5 5341.4 5396.2 5484.3 5521.8 5543.8 5594.2 5629.3 5443.5 5445.8 5452.4 5457.6 5492.4 10:20:56 INFO - PROCESS | 3366 | 10:20:56 INFO - PROCESS | 3366 | [#1] ext.html Cycles:180 Average:59953.41 Median:37037.22 stddev:116585.31 (314.8%) stddev-sans-first:116827.16 10:20:56 INFO - PROCESS | 3366 | Values: 589.1 619.7 622.2 635.6 643.2 33717.8 45097.3 45633.0 45715.3 45742.5 46514.8 46935.8 47010.5 47091.0 47110.0 8006.5 8654.5 8795.1 8836.5 10468.9 10296.8 10682.4 10702.5 10708.0 10714.9 10659.6 10732.8 10732.9 10734.3 10734.3 8026.1 10387.2 10627.5 10634.3 10636.9 10555.9 10644.6 10647.6 10655.4 10662.2 42531.8 42958.8 43108.0 43144.4 43155.1 3556.9 3656.9 3746.3 3773.9 3948.5 32410.4 32502.7 33256.3 33474.5 33789.5 3835.0 3856.9 3882.9 3942.5 3953.1 359308.0 362949.0 363601.0 365070.0 365192.0 61109.0 61210.1 61439.4 61548.4 61606.4 35855.3 36665.6 36678.4 37684.0 37685.4 16957.7 17087.6 17103.2 17117.4 17141.0 12964.0 13027.3 13041.3 13056.3 13060.0 19345.1 19374.7 19526.2 19597.3 19605.5 6215.0 7102.6 7237.4 7401.9 7728.7 1061.2 1070.9 1071.3 1116.7 1149.9 31844.5 32976.0 33064.2 33090.3 33509.8 1084.7 1158.1 1175.7 1189.8 1214.4 17176.3 17227.9 17322.7 17330.7 17386.4 526207.0 530508.0 531312.0 531893.0 532337.0 59927.4 61206.1 61407.0 61426.0 61448.0 1314.3 1389.0 1395.0 1395.3 1418.8 30670.2 31805.2 32188.2 32327.4 32529.0 51717.7 52315.2 52387.0 52421.5 52457.5 409869.0 410712.0 411189.0 411452.0 412967.0 27528.2 27890.2 28271.3 28387.7 28388.7 46656.5 48359.3 49458.5 50009.5 50760.2 39889.4 44333.8 44841.6 44969.1 45844.3 41612.0 42010.8 42186.8 42458.0 42516.4 42089.8 42124.6 42857.6 42968.0 43274.4 37396.0 38407.4 38717.0 38923.0 39372.8 29159.7 29266.7 29354.6 29551.0 29573.6 10:20:56 INFO - PROCESS | 3366 | 10:20:56 INFO - PROCESS | 3366 | [#2] jquery.html Cycles:180 Average:29480.61 Median:2640.84 stddev:82261.58 (3115.0%) stddev-sans-first:82463.35 10:20:56 INFO - PROCESS | 3366 | Values: 395.0 397.8 399.0 402.5 416.7 14133.7 18130.3 18863.4 19653.7 19654.8 15567.5 18042.6 18850.9 18852.4 18888.3 5659.9 5813.2 5863.2 5869.6 5879.0 4196.0 4399.4 5827.1 6178.4 6514.9 6471.9 6541.4 6596.1 6605.0 6605.3 6411.4 6430.6 6517.0 6530.0 6574.5 5603.4 5753.3 5769.4 5792.4 5796.6 22459.6 23268.1 23318.3 23370.3 23481.6 2508.2 2539.8 2551.2 2730.5 2933.2 14118.0 14316.4 14490.7 14595.2 15232.2 1931.4 1971.7 1987.5 2056.5 2074.9 83786.2 85310.6 85479.0 85632.6 85641.6 9625.3 9800.7 9922.6 10059.4 10551.8 13284.6 13336.5 13427.9 13428.7 13438.5 7966.0 8133.2 8161.5 8261.0 8273.3 7244.2 8280.9 8289.0 8298.3 8335.1 4641.9 4771.8 4873.3 4905.3 4925.5 1963.5 1979.4 2005.4 2027.8 2029.5 896.9 986.7 1004.9 1052.2 1095.8 18216.5 19155.1 19789.0 19893.8 20184.4 1005.4 1034.6 1072.3 1121.6 1128.6 10822.8 11203.8 11232.7 11297.9 11322.9 485236.0 498509.0 501613.0 502411.0 503384.0 93256.5 95395.0 95914.0 96051.5 96230.5 1036.0 1042.8 1079.6 1097.9 1111.1 17545.9 17601.6 17777.6 17889.6 18087.3 41914.8 42028.6 42089.4 42969.4 44096.0 57052.0 58386.0 58403.4 59274.4 59349.7 6396.9 7507.8 8682.4 8877.6 9143.8 9350.5 12440.3 12891.5 12937.2 13097.3 11297.4 11554.9 11614.4 11647.5 11721.3 11292.0 11423.7 11490.2 11518.7 11574.5 6312.6 11377.8 11519.6 11632.2 11635.9 8834.2 8985.6 8990.7 9043.9 9161.7 11352.9 11717.1 11731.4 11738.3 11789.8 10:20:56 INFO - PROCESS | 3366 | 10:20:56 INFO - PROCESS | 3366 | [#3] mootools.html Cycles:180 Average:5883.81 Median:2370.05 stddev:3343.09 (141.1%) stddev-sans-first:3335.16 10:20:56 INFO - PROCESS | 3366 | Values: 1358.0 1521.6 1547.0 1697.6 1829.3 8335.9 8689.0 8724.0 8986.9 8989.5 8815.9 8831.9 8900.6 8949.7 8951.9 2046.4 2322.2 2402.8 2431.4 2432.2 2360.9 2375.1 2389.0 2390.1 2390.8 2356.9 2368.1 2385.6 2386.0 2387.7 1980.8 2029.2 2038.2 2243.0 2322.9 2279.2 2317.2 2317.3 2321.1 2323.2 8809.3 8860.3 8876.2 8877.6 8878.2 5069.9 5175.7 5189.3 5191.2 5193.6 3283.6 3345.1 3418.8 3428.7 3444.2 1117.6 1131.9 1164.1 1195.0 1201.6 12516.2 12533.2 12554.1 12555.1 12563.4 4768.6 4820.8 4844.2 4882.0 4892.7 10419.4 10463.4 10491.7 10536.5 10547.1 5393.4 5443.8 5444.5 5446.5 5447.9 4269.5 4718.4 4894.7 4897.1 4903.4 4102.6 4126.8 4135.7 4136.3 4238.2 1296.1 1303.0 1314.8 1324.9 1327.4 905.0 1017.6 1031.1 1043.5 1052.7 5947.9 5977.3 6040.9 6065.1 6204.8 470.6 491.1 1008.8 1017.3 1027.8 4099.5 4126.8 4209.9 4236.6 4246.2 10737.4 11073.4 11083.3 11100.2 11103.9 10842.6 11097.3 11131.8 11139.6 11161.8 7944.4 8100.8 8207.4 8270.2 8311.5 5651.3 5755.0 5857.0 5866.0 5935.8 9647.8 10234.8 10360.1 10377.3 10384.4 9670.6 10037.8 10066.4 10361.3 10363.9 7412.4 7646.8 7651.0 7915.9 8075.8 8632.0 8639.4 8643.6 8681.6 8684.5 7625.2 7949.6 7968.2 8020.8 8180.1 7823.8 8081.2 8107.4 8219.3 8231.6 7026.5 7145.7 7212.0 7215.1 7240.9 5329.7 5417.5 5520.6 5527.7 5557.1 5372.5 5386.2 5523.9 5545.3 5647.2 10:20:56 INFO - PROCESS | 3366 | 10:20:56 INFO - PROCESS | 3366 | [#4] prototype.html Cycles:180 Average:4591.60 Median:5195.47 stddev:1351.02 (26.0%) stddev-sans-first:1316.22 10:20:56 INFO - PROCESS | 3366 | Values: 320.2 334.6 338.0 343.2 345.3 5197.3 5352.5 5370.0 5380.4 5400.8 5285.6 5315.9 5316.3 5338.3 5357.7 4164.9 4175.6 4183.5 4223.9 4226.6 3828.4 3946.7 4149.3 4156.0 4169.0 4032.6 4072.7 4081.8 4105.3 4111.6 3978.9 4086.1 4091.3 4093.2 4104.2 3536.3 3566.5 3589.8 3601.7 3608.6 5155.0 5170.5 5180.7 5193.7 5243.3 4605.7 4734.6 4740.7 4741.3 4757.0 5412.4 5529.4 5544.0 5556.8 5578.2 3978.9 3981.4 3991.7 4017.8 4027.3 5394.2 5595.3 5892.3 5901.4 5916.7 4031.4 4051.9 4061.0 4073.3 4103.9 4105.6 4125.6 4128.9 4131.1 4144.3 4692.8 4749.5 4750.6 4766.2 4769.2 5365.5 5610.5 5612.8 5632.4 5674.8 1408.6 1417.9 1421.9 1437.4 1442.3 872.3 914.7 919.8 927.1 937.5 4772.9 4810.6 4820.9 4841.0 4848.9 5089.8 5121.8 5134.3 5165.7 5212.4 4585.6 4749.7 4779.2 4819.9 4844.0 2713.9 2732.2 2732.2 2732.8 2739.3 5251.9 5278.3 5328.8 5374.7 5410.4 4822.8 5165.5 5213.6 5276.8 5291.3 5254.3 5258.0 5710.8 5799.2 5959.3 5718.8 5719.5 5744.8 5746.0 5761.7 5536.5 5694.5 5698.5 5702.8 5708.2 5910.9 5923.5 5944.2 5961.9 5966.6 4044.3 4075.5 4080.8 4104.6 4109.2 5504.8 5750.3 5755.7 5807.8 5821.4 5513.5 5532.8 5545.0 5597.5 5602.0 5555.6 5566.6 5575.1 5579.6 5592.9 5186.7 5417.7 5439.7 5451.4 5484.6 5574.4 5593.6 5597.0 5627.0 5639.8 5294.9 5479.5 5512.9 5533.2 5558.2 10:20:56 INFO - PROCESS | 3366 | 10:20:56 INFO - PROCESS | 3366 | [#5] yui.html Cycles:180 Average:20215.91 Median:4754.98 stddev:28060.72 (590.1%) stddev-sans-first:28101.33 10:20:56 INFO - PROCESS | 3366 | Values: 739.3 767.8 795.1 827.3 862.8 15262.8 16120.8 16172.4 16207.0 16222.9 14944.8 15064.8 15085.8 15682.5 16384.3 680.6 818.6 824.3 826.2 826.6 690.9 691.0 691.1 802.9 823.6 876.7 879.0 879.1 879.7 879.7 868.7 870.3 870.6 871.0 871.1 528.3 605.6 622.4 622.7 634.7 15627.1 15788.0 15844.0 15873.6 15877.1 14465.6 14942.5 14983.6 15006.5 15010.2 13072.3 13462.1 13613.3 13644.7 13945.9 4587.7 4634.6 4638.3 4646.2 4654.7 64850.7 67452.7 67932.7 75725.6 77998.6 12676.6 12681.8 12701.9 12724.8 12883.5 23251.9 23256.0 23274.7 23284.4 23303.1 8920.3 9073.0 9205.1 9214.1 9288.4 4696.7 4699.4 4852.0 4869.5 5105.3 3555.6 3674.3 3699.3 3703.2 3707.8 628.7 638.6 651.3 652.5 653.7 774.5 784.5 789.6 809.9 812.9 9823.3 9866.9 10075.2 10132.9 10172.6 654.3 655.9 752.0 777.4 785.4 4684.6 4810.6 4865.7 4878.0 4948.8 102144.5 104703.5 107741.5 111735.0 111887.4 66791.3 91769.5 92604.5 93282.5 95738.5 60755.7 83108.0 84489.2 84589.0 85073.0 9377.7 9430.7 9507.8 9527.9 9651.8 51884.7 52779.7 52892.7 53810.0 55004.2 72152.0 75562.2 76059.0 76916.6 80783.6 12853.9 13074.0 13108.9 13163.0 13352.1 13054.4 13055.5 13270.2 13759.2 14569.1 12640.5 12728.6 12764.7 12977.2 13399.3 12609.9 12647.9 12668.1 12790.8 13309.5 12733.4 12834.1 12879.2 13043.8 13080.1 10016.5 10116.4 10128.9 10653.3 10669.9 11197.7 11352.8 11388.2 11474.4 11507.9 10:20:56 INFO - PROCESS | 3366 | -------- Summary: end -------- 10:20:56 INFO - PROCESS | 3366 | 10:20:57 INFO - TEST-INFO | 3366: exit 0 10:20:57 INFO - TEST-OK | dromaeo_css | took 1114035ms 10:20:57 INFO - TEST-START | kraken 10:20:57 INFO - operating with platform_type : linux_ 10:20:57 INFO - Initialising browser for kraken test... 10:20:57 INFO - TEST-INFO | started process 3548 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbCJptC/profile http://localhost:46933/getInfo.html) 10:21:01 INFO - PROCESS | 3548 | __metrics Screen width/height:1600/1200 10:21:01 INFO - PROCESS | 3548 | colorDepth:24 10:21:01 INFO - PROCESS | 3548 | Browser inner width/height: 1024/697 10:21:01 INFO - PROCESS | 3548 | __metrics 10:21:02 ERROR - PROCESS | 3548 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:21:02 INFO - PROCESS | 3548 | console.error: PushService: 10:21:02 INFO - PROCESS | 3548 | stateChangeProcessEnqueue: Error transitioning state 10:21:02 INFO - PROCESS | 3548 | UnknownError 10:21:03 INFO - TEST-INFO | 3548: exit 0 10:21:03 INFO - Browser initialized. 10:21:03 INFO - Running cycle 1/1 for kraken test... 10:21:03 INFO - TEST-INFO | started process 3630 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbCJptC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:21:14 INFO - PROCESS | 3630 | RSS: Main: 160231424 10:21:14 INFO - PROCESS | 3630 | 10:21:17 INFO - PROCESS | 3630 | Cycle 1(1): loaded http://localhost:46933/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46933/tests/kraken/driver.html?testName=audio-beat-detection) 10:21:18 INFO - PROCESS | 3630 | RSS: Main: 218624000 10:21:18 INFO - PROCESS | 3630 | 10:21:21 INFO - PROCESS | 3630 | Cycle 1(1): loaded http://localhost:46933/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46933/tests/kraken/driver.html?testName=audio-dft) 10:21:21 INFO - PROCESS | 3630 | RSS: Main: 207466496 10:21:21 INFO - PROCESS | 3630 | 10:21:24 INFO - PROCESS | 3630 | Cycle 1(1): loaded http://localhost:46933/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46933/tests/kraken/driver.html?testName=audio-fft) 10:21:25 INFO - PROCESS | 3630 | RSS: Main: 272089088 10:21:25 INFO - PROCESS | 3630 | 10:21:27 INFO - PROCESS | 3630 | Cycle 1(1): loaded http://localhost:46933/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46933/tests/kraken/driver.html?testName=audio-oscillator) 10:21:28 INFO - PROCESS | 3630 | RSS: Main: 183365632 10:21:28 INFO - PROCESS | 3630 | 10:21:30 INFO - PROCESS | 3630 | Cycle 1(1): loaded http://localhost:46933/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46933/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:21:30 INFO - PROCESS | 3630 | RSS: Main: 187965440 10:21:30 INFO - PROCESS | 3630 | 10:21:33 INFO - PROCESS | 3630 | Cycle 1(1): loaded http://localhost:46933/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46933/tests/kraken/driver.html?testName=imaging-darkroom) 10:21:34 INFO - PROCESS | 3630 | RSS: Main: 222109696 10:21:34 INFO - PROCESS | 3630 | 10:21:37 INFO - PROCESS | 3630 | Cycle 1(1): loaded http://localhost:46933/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46933/tests/kraken/driver.html?testName=imaging-desaturate) 10:21:38 INFO - PROCESS | 3630 | RSS: Main: 224579584 10:21:38 INFO - PROCESS | 3630 | 10:21:41 INFO - PROCESS | 3630 | Cycle 1(1): loaded http://localhost:46933/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46933/tests/kraken/driver.html?testName=json-parse-financial) 10:21:41 INFO - PROCESS | 3630 | RSS: Main: 224321536 10:21:41 INFO - PROCESS | 3630 | 10:21:43 INFO - PROCESS | 3630 | Cycle 1(1): loaded http://localhost:46933/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46933/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:21:43 INFO - PROCESS | 3630 | RSS: Main: 212697088 10:21:43 INFO - PROCESS | 3630 | 10:21:45 INFO - PROCESS | 3630 | Cycle 1(1): loaded http://localhost:46933/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46933/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:21:46 INFO - PROCESS | 3630 | RSS: Main: 214245376 10:21:46 INFO - PROCESS | 3630 | 10:21:49 INFO - PROCESS | 3630 | Cycle 1(1): loaded http://localhost:46933/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46933/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:21:49 INFO - PROCESS | 3630 | RSS: Main: 217849856 10:21:49 INFO - PROCESS | 3630 | 10:21:52 INFO - PROCESS | 3630 | Cycle 1(1): loaded http://localhost:46933/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46933/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:21:53 INFO - PROCESS | 3630 | RSS: Main: 221974528 10:21:53 INFO - PROCESS | 3630 | 10:21:55 INFO - PROCESS | 3630 | Cycle 1(1): loaded http://localhost:46933/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46933/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:21:56 INFO - PROCESS | 3630 | RSS: Main: 220897280 10:21:56 INFO - PROCESS | 3630 | 10:21:58 INFO - PROCESS | 3630 | Cycle 1(1): loaded http://localhost:46933/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46933/tests/kraken/driver.html?testName=ai-astar) 10:21:58 INFO - PROCESS | 3630 | RSS: Main: 262811648 10:21:58 INFO - PROCESS | 3630 | 10:21:58 INFO - PROCESS | 3630 | __start_tp_report 10:21:58 INFO - PROCESS | 3630 | _x_x_mozilla_page_load 10:21:58 INFO - PROCESS | 3630 | _x_x_mozilla_page_load_details 10:21:58 INFO - PROCESS | 3630 | |i|pagename|runs| 10:21:58 INFO - PROCESS | 3630 | |0;ai-astar;113;107;110;114;112;112;113;112;112;112 10:21:58 INFO - PROCESS | 3630 | |1;audio-beat-detection;165;133;142;183;129;127;160;126;184;126 10:21:58 INFO - PROCESS | 3630 | |2;audio-dft;161;159;160;159;160;160;161;160;162;160 10:21:58 INFO - PROCESS | 3630 | |3;audio-fft;74;74;75;115;77;76;74;74;96;75 10:21:58 INFO - PROCESS | 3630 | |4;audio-oscillator;85;86;115;86;85;85;119;84;85;133 10:21:58 INFO - PROCESS | 3630 | |5;imaging-gaussian-blur;117;116;117;116;117;116;116;116;117;116 10:21:58 INFO - PROCESS | 3630 | |6;imaging-darkroom;147;146;146;146;146;146;147;146;146;147 10:21:58 INFO - PROCESS | 3630 | |7;imaging-desaturate;95;95;95;95;94;94;95;95;95;95 10:21:58 INFO - PROCESS | 3630 | |8;json-parse-financial;52;52;54;53;53;52;54;52;52;52 10:21:58 INFO - PROCESS | 3630 | |9;json-stringify-tinderbox;61;62;62;62;63;63;63;63;62;63 10:21:58 INFO - PROCESS | 3630 | |10;stanford-crypto-aes;86;79;78;85;84;80;81;82;115;80 10:21:58 INFO - PROCESS | 3630 | |11;stanford-crypto-ccm;125;122;135;121;121;130;121;120;135;130 10:21:58 INFO - PROCESS | 3630 | |12;stanford-crypto-pbkdf2;164;169;170;169;163;161;162;167;163;164 10:21:58 INFO - PROCESS | 3630 | |13;stanford-crypto-sha256-iterative;63;67;65;63;69;63;63;66;65;62 10:21:58 INFO - PROCESS | 3630 | __end_tp_report 10:21:58 INFO - PROCESS | 3630 | __start_cc_report 10:21:58 INFO - PROCESS | 3630 | _x_x_mozilla_cycle_collect,1611 10:21:58 INFO - PROCESS | 3630 | __end_cc_report 10:21:58 INFO - PROCESS | 3630 | __startTimestamp1465233718356__endTimestamp 10:21:58 INFO - PROCESS | 3630 | 10:21:58 INFO - PROCESS | 3630 | ------- Summary: start ------- 10:21:58 INFO - PROCESS | 3630 | Number of tests: 14 10:21:58 INFO - PROCESS | 3630 | 10:21:58 INFO - PROCESS | 3630 | [#0] ai-astar Cycles:10 Average:111.70 Median:112.00 stddev:1.95 (1.7%) stddev-sans-first:2.01 10:21:58 INFO - PROCESS | 3630 | Values: 113.0 107.0 110.0 114.0 112.0 112.0 113.0 112.0 112.0 112.0 10:21:58 INFO - PROCESS | 3630 | 10:21:58 INFO - PROCESS | 3630 | [#1] audio-beat-detection Cycles:10 Average:147.50 Median:151.00 stddev:23.53 (15.6%) stddev-sans-first:24.09 10:21:58 INFO - PROCESS | 3630 | Values: 165.0 133.0 142.0 183.0 129.0 127.0 160.0 126.0 184.0 126.0 10:21:58 INFO - PROCESS | 3630 | 10:21:58 INFO - PROCESS | 3630 | [#2] audio-dft Cycles:10 Average:160.20 Median:160.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 10:21:58 INFO - PROCESS | 3630 | Values: 161.0 159.0 160.0 159.0 160.0 160.0 161.0 160.0 162.0 160.0 10:21:58 INFO - PROCESS | 3630 | 10:21:58 INFO - PROCESS | 3630 | [#3] audio-fft Cycles:10 Average:81.00 Median:75.00 stddev:13.70 (18.3%) stddev-sans-first:14.30 10:21:58 INFO - PROCESS | 3630 | Values: 74.0 74.0 75.0 115.0 77.0 76.0 74.0 74.0 96.0 75.0 10:21:58 INFO - PROCESS | 3630 | 10:21:58 INFO - PROCESS | 3630 | [#4] audio-oscillator Cycles:10 Average:96.30 Median:85.00 stddev:18.52 (21.8%) stddev-sans-first:19.18 10:21:58 INFO - PROCESS | 3630 | Values: 85.0 86.0 115.0 86.0 85.0 85.0 119.0 84.0 85.0 133.0 10:21:58 INFO - PROCESS | 3630 | 10:21:58 INFO - PROCESS | 3630 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 10:21:58 INFO - PROCESS | 3630 | Values: 117.0 116.0 117.0 116.0 117.0 116.0 116.0 116.0 117.0 116.0 10:21:58 INFO - PROCESS | 3630 | 10:21:58 INFO - PROCESS | 3630 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 10:21:58 INFO - PROCESS | 3630 | Values: 147.0 146.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 147.0 10:21:58 INFO - PROCESS | 3630 | 10:21:58 INFO - PROCESS | 3630 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:21:58 INFO - PROCESS | 3630 | Values: 95.0 95.0 95.0 95.0 94.0 94.0 95.0 95.0 95.0 95.0 10:21:58 INFO - PROCESS | 3630 | 10:21:58 INFO - PROCESS | 3630 | [#8] json-parse-financial Cycles:10 Average:52.60 Median:52.50 stddev:0.84 (1.6%) stddev-sans-first:0.87 10:21:58 INFO - PROCESS | 3630 | Values: 52.0 52.0 54.0 53.0 53.0 52.0 54.0 52.0 52.0 52.0 10:21:58 INFO - PROCESS | 3630 | 10:21:58 INFO - PROCESS | 3630 | [#9] json-stringify-tinderbox Cycles:10 Average:62.40 Median:63.00 stddev:0.70 (1.1%) stddev-sans-first:0.53 10:21:58 INFO - PROCESS | 3630 | Values: 61.0 62.0 62.0 62.0 63.0 63.0 63.0 63.0 62.0 63.0 10:21:58 INFO - PROCESS | 3630 | 10:21:58 INFO - PROCESS | 3630 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:81.50 stddev:10.86 (13.3%) stddev-sans-first:11.52 10:21:58 INFO - PROCESS | 3630 | Values: 86.0 79.0 78.0 85.0 84.0 80.0 81.0 82.0 115.0 80.0 10:21:58 INFO - PROCESS | 3630 | 10:21:58 INFO - PROCESS | 3630 | [#11] stanford-crypto-ccm Cycles:10 Average:126.00 Median:127.50 stddev:5.98 (4.7%) stddev-sans-first:6.33 10:21:58 INFO - PROCESS | 3630 | Values: 125.0 122.0 135.0 121.0 121.0 130.0 121.0 120.0 135.0 130.0 10:21:58 INFO - PROCESS | 3630 | 10:21:58 INFO - PROCESS | 3630 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.20 Median:165.50 stddev:3.26 (2.0%) stddev-sans-first:3.43 10:21:58 INFO - PROCESS | 3630 | Values: 164.0 169.0 170.0 169.0 163.0 161.0 162.0 167.0 163.0 164.0 10:21:58 INFO - PROCESS | 3630 | 10:21:58 INFO - PROCESS | 3630 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.60 Median:65.00 stddev:2.22 (3.4%) stddev-sans-first:2.28 10:21:58 INFO - PROCESS | 3630 | Values: 63.0 67.0 65.0 63.0 69.0 63.0 63.0 66.0 65.0 62.0 10:21:58 INFO - PROCESS | 3630 | -------- Summary: end -------- 10:21:58 INFO - PROCESS | 3630 | 10:21:59 INFO - TEST-INFO | 3630: exit 0 10:21:59 INFO - TEST-OK | kraken | took 62223ms 10:21:59 INFO - SUITE-END | took 1176s 10:21:59 INFO - Completed test suite (00:19:36) 10:21:59 INFO - javascript benchmark 10:21:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3148.858301376438, 3153.4954407294836, 3167.683231676832, 3199.168216263771, 3214.389266039452, 5140.948590514103, 5225.660332078422, 5296.708681022542, 5365.222042803791, 5385.596080293979, 5227.189785583231, 5262.131748261532, 5286.0, 5311.256424100629, 5313.256144139824, 4772.451168115667, 4830.420349558058, 4847.830325938593, 4864.5135486451245, 4981.825636102737, 4868.367112275399, 4936.234883593031, 4946.826861059863, 4953.653244272902, 4964.329815474901, 4703.365045718835, 4708.246680531116, 4731.905361892777, 4735.360726301939, 4873.8781530461665, 4721.291806229093, 4738.810447582093, 4742.359781429497, 4810.927836082462, 4852.17513022787, 4800.375951126366, 4808.350872632185, 4814.831480898187, 4815.711057336536, 4817.397825271841, 5082.949170508285, 5210.947890521084, 5283.392409872837, 5291.708956007418, 5343.893122137574, 5721.170430287627, 5732.168835518868, 5762.164486149485, 5762.250907382056, 5768.913466297967, 5426.104692725696, 5762.971185144047, 5789.421057894177, 5799.652020878761, 5816.272965879265, 5270.0, 5332.946670533283, 5333.5199832015305, 5391.48780865821, 5401.567874570025, 5858.062709966385, 5873.148393482921, 5876.236089308362, 5881.264841894763, 5883.14694369314, 5408.080626293539, 5635.5773317001385, 5646.2942132233475, 5647.915281270784, 5648.548116150698, 5550.72246387679, 5569.331680198402, 5602.299712535933, 5649.887002259932, 5651.15232715096, 5614.63504872182, 5618.634788738801, 5623.268975033301, 5623.662580245198, 5625.46558076982, 5458.0, 5550.7779688812, 5588.133839254922, 5615.943840561542, 5644.3508996465935, 4336.6530677545725, 4346.326319420495, 4348.630366418826, 4394.033312671208, 4396.1647287016, 3865.323568375523, 3871.8064096795047, 3878.84484620612, 3899.239648268617, 3914.4911161549385, 5068.442471328225, 5126.7180305083575, 5205.843824685266, 5259.47405259471, 5351.518363347317, 5594.748236329375, 5628.85927851807, 5648.915266271009, 5653.830385088454, 5693.459121383462, 5274.4198138204765, 5281.815136470205, 5285.445028272053, 5287.709175995357, 5339.866503337447, 4682.859514214579, 4776.832810851603, 4779.976100119477, 4780.593649539828, 4832.51674832521, 5889.146073819272, 5891.823245302648, 5895.174675545427, 5896.911546326808, 5934.970325148433, 5720.914186287292, 5726.341470730836, 5731.426857314402, 5737.08206686928, 5743.741531631003, 5743.3395159557185, 5806.0, 5842.2405087338375, 5875.882482350244, 5908.3205431375945, 5607.130894711327, 5616.241807355955, 5616.971915140398, 5617.887642247214, 5624.493795558419, 5678.346990096192, 5712.457316554921, 5718.199452076796, 5724.370319264961, 5726.255586773859, 5376.973115134399, 5399.919001215064, 5430.70131142791, 5457.208704737712, 5492.697901615449, 5487.314085739283, 5489.231507588861, 5489.670619762827, 5491.807786727445, 5492.258545096361, 5213.843584692465, 5295.417504074471, 5335.546478549367, 5341.385740639721, 5396.190571414162, 5484.314460692413, 5521.834344969658, 5543.750531226024, 5594.244776955059, 5629.324481062299, 5443.455654434683, 5445.83662490126, 5452.400235974119, 5457.61796674229, 5492.368377636463], "value": 5216.611081741719, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.0722112672541, 619.6839611797988, 622.2315440431069, 635.5963962883568, 643.2056410333238, 33717.83141084294, 45097.32354014692, 45633.0, 45715.31427028597, 45742.54257457425, 46514.76742616282, 46935.76532117343, 47010.529894701045, 47091.0, 47110.0, 8006.519608823489, 8654.48073115612, 8795.076516965722, 8836.469811811312, 10468.947655261712, 10296.845547316796, 10682.412467314294, 10702.518386672618, 10708.036276735093, 10714.946425267863, 10659.626913058044, 10732.78534429311, 10732.892671073267, 10734.302270352402, 10734.30227035244, 8026.077001144856, 10387.169026477864, 10627.46862656868, 10634.30876992993, 10636.946815265952, 10555.947220263926, 10644.57421703131, 10647.57409703611, 10655.413952232624, 10662.200334974908, 42531.7873410631, 42958.78520607377, 43108.0, 43144.352834707504, 43155.13689726188, 3556.8577256909693, 3656.8720094796554, 3746.269477451898, 3773.867914622975, 3948.506436695413, 32410.351792964244, 32502.674973250203, 33256.33487330264, 33474.49788253178, 33789.49315760266, 3835.0412396900774, 3856.903577410559, 3882.864099756523, 3942.5268967724055, 3953.1105501262273, 359308.0, 362949.0, 363601.0, 365069.9999999973, 365192.0, 61109.0, 61210.0818487723, 61439.38560614337, 61548.38451615426, 61606.38393616006, 35855.282894341966, 36665.633343666756, 36678.449823252675, 37684.0, 37685.43471847924, 16957.745633815503, 17087.572810679583, 17103.23035463407, 17117.400890968755, 17141.0, 12964.0, 13027.283499407624, 13041.282729449782, 13056.281904495345, 13060.0, 19345.12946917392, 19374.73532122667, 19526.22032648346, 19597.31409400664, 19605.50986225356, 6215.0, 7102.609356485443, 7237.384822290164, 7401.925980740231, 7728.6522106505345, 1061.1775873697945, 1070.8969761146031, 1071.2982996137541, 1116.6984914073155, 1149.9252548584316, 31844.522332165037, 32976.0, 33064.173395665304, 33090.338193236, 33509.83245083759, 1084.7233955341496, 1158.102470585303, 1175.6884425627215, 1189.7679952409196, 1214.3503225774168, 17176.31294748221, 17227.91386043087, 17322.740158897628, 17330.74003889943, 17386.391476298268, 526207.0, 530508.0, 531312.0, 531893.0, 532337.0, 59927.400725992185, 61206.081908771404, 61407.0, 61426.0, 61448.0, 1314.2902832470359, 1389.0138002018477, 1394.9930250348684, 1395.2535393564394, 1418.8439271680106, 30670.233244169074, 31805.20486987844, 32188.19529511781, 32327.35345293128, 32529.0, 51717.741411294206, 52315.21527177019, 52387.0, 52421.47578524166, 52457.47542524526, 409869.0, 410712.0, 411189.0, 411452.0, 412967.0, 27528.174154775388, 27890.163295101178, 28271.29321766972, 28387.71612283851, 28388.716112839433, 46656.533434665216, 48359.27461088157, 49458.50541494683, 50009.499905000484, 50760.23859642034, 39889.401658975716, 44333.77833110814, 44841.551584483735, 44969.10061798811, 45844.31233531566, 41612.007444934694, 42010.78994605008, 42186.78906605447, 42458.0, 42516.362254566826, 42089.78955105205, 42124.57875421207, 42857.57142428536, 42968.0, 43274.35088473612, 37396.0, 38407.42388864225, 38717.03207419725, 38923.0, 39372.80313598413, 29159.708402915698, 29266.7073329264, 29354.55968160522, 29551.0, 29573.556396653636], "value": 20602.28417501064, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.98617548385795, 397.80308747170153, 398.97406668566543, 402.45668347730566, 416.66874834506564, 14133.717325653506, 18130.27478900844, 18863.43409697708, 19653.705194422095, 19654.803451965494, 15567.455139070134, 18042.639147217047, 18850.90574547129, 18852.43442696718, 18888.33890813822, 5659.8585035374035, 5813.186153938452, 5863.179154918314, 5869.647821130746, 5879.029960056586, 4195.958040419588, 4399.42807435033, 5827.096799995987, 6178.38216178383, 6514.869702605945, 6471.935280647204, 6541.4112729854305, 6596.076549283104, 6605.0, 6605.273419923805, 6411.3588641135975, 6430.614163150226, 6517.0224466329955, 6529.967350163266, 6574.474042076622, 5603.3836278009385, 5753.252077229975, 5769.423057694239, 5792.420757924174, 5796.565257605655, 22459.550808983728, 23268.06927722889, 23318.3004509865, 23370.298891033126, 23481.647775283385, 2508.1723031399592, 2539.8349107307968, 2551.1708694674303, 2730.5118710302736, 2933.1933718227447, 14118.0, 14316.42734290627, 14490.71018579633, 14595.197264150467, 15232.238388080552, 1931.381957773513, 1971.7239586457908, 1987.5329297615049, 2056.5475595368994, 2074.8858812765293, 83786.16213837845, 85310.57344713299, 85479.0, 85632.57183714103, 85641.57179214065, 9625.278104142217, 9800.65697700577, 9922.603095876084, 10059.44673042975, 10551.84172237417, 13284.608770421417, 13336.466541338237, 13427.865721342858, 13428.731425371438, 13438.529651462348, 7965.960170199112, 8133.227343402367, 8161.510309381456, 8261.0, 8273.296769774517, 7244.166920804175, 8280.917190828135, 8289.0, 8298.294644955246, 8335.083140854502, 4641.907161856744, 4771.809127634925, 4873.31773551703, 4905.288733133676, 4925.507449255046, 1963.4993076765334, 1979.416072258687, 2005.4184286556736, 2027.8377729781582, 2029.4723371923405, 896.9372143949992, 986.6990567876867, 1004.9296549241483, 1052.1687866585312, 1095.758933034747, 18216.544586385447, 19155.13801878919, 19789.0, 19893.801061989485, 20184.394468165978, 1005.3967619428284, 1034.6120204923154, 1072.3458690198972, 1121.5906194239208, 1128.5711429656842, 10822.78354432907, 11203.775924481464, 11232.66302010941, 11297.887021129683, 11322.886771132184, 485236.0, 498509.0, 501613.0, 502411.0, 503384.0, 93256.53371733234, 95395.0, 95914.0, 96051.51974240084, 96230.51884740531, 1035.9896401035894, 1042.7549525861416, 1079.5843600213975, 1097.8572785537829, 1111.127764704703, 17545.912270438566, 17601.64796704033, 17777.644447111245, 17889.552761180556, 18087.276508939496, 41914.790426048894, 42028.57971420369, 42089.36865947075, 42969.3554596675, 44096.0, 57052.0, 58386.0, 58403.4159658398, 59274.40725592689, 59349.703251483465, 6396.872062558816, 7507.849843003219, 8682.392232543662, 8877.644894204417, 9143.817123657622, 9350.53247337644, 12440.315782632042, 12891.548795792101, 12937.159084659466, 13097.279649619362, 11297.43512824372, 11554.884451155382, 11614.361210133524, 11647.534098635959, 11721.296722196696, 11292.0, 11423.714407139889, 11490.195686301879, 11518.654440366803, 11574.479148438171, 6312.621242725451, 11377.829332559853, 11519.596814111466, 11632.185746997968, 11635.941820290844, 8834.160754728291, 8985.595648195716, 8990.651402289708, 9043.909560904307, 9161.725148245563, 11352.943235284101, 11717.12121590867, 11731.41342932867, 11738.295702257892, 11789.764204715686], "value": 9384.108414439928, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1358.0154388068645, 1521.6424140327022, 1547.0485651324436, 1697.5586347549634, 1829.2865782344888, 8335.91664083359, 8688.956555217232, 8723.956380218098, 8986.865197022034, 8989.460632362063, 8815.86776198356, 8831.867521987175, 8900.643974241022, 8949.686760963368, 8951.86572201416, 2046.3963130876427, 2322.222055611372, 2402.7957623602015, 2431.4407686232175, 2432.20953190213, 2360.8937597808053, 2375.1449478187837, 2388.9761102389016, 2390.1156572068357, 2390.832641715072, 2356.905723771047, 2368.14746691191, 2385.6063749481314, 2386.0098059305456, 2387.737348891629, 1980.8118228768244, 2029.2086086426305, 2038.1541660210994, 2242.9887850560644, 2322.8954697038675, 2279.1567120165478, 2317.165820304689, 2317.3279748872806, 2321.0947730385165, 2323.2217207235594, 8809.251213646849, 8860.291176705912, 8876.245519130882, 8877.55612219393, 8878.156575125353, 5069.898602027975, 5175.741212939376, 5189.325387699575, 5191.195364718475, 5193.558547523465, 3283.5731354923705, 3345.0968238575692, 3418.8461519231696, 3428.7428442866635, 3444.2422667013216, 1117.580907159815, 1131.8754936956927, 1164.0745607242263, 1194.994025029878, 1201.627495476405, 12516.249025058434, 12533.248005119722, 12554.121211515198, 12555.121141520098, 12563.434645440886, 4768.57082862544, 4820.807167713252, 4844.224924012141, 4881.999190166008, 4892.68197567157, 10419.42693151884, 10463.424511651932, 10491.737706557244, 10536.473176341153, 10547.103496202755, 5393.4336894626285, 5443.782248710087, 5444.455554444603, 5446.455354464601, 5447.918281225785, 4269.5090064642345, 4718.363020992191, 4894.681845680019, 4897.1185186666025, 4903.387076615423, 4102.569230230843, 4126.773027483458, 4135.6898232632675, 4136.296829538986, 4238.215930052888, 1296.1315918334737, 1302.9674258143623, 1314.7830607949772, 1324.9072564920364, 1327.4491086199312, 904.968326108583, 1017.5624481473037, 1031.0926384781494, 1043.4886905416442, 1052.736815796051, 5947.940520594739, 5977.282726072812, 6040.879182416415, 6065.120557519135, 6204.751809927642, 470.5929371094048, 491.14295554258047, 1008.7679833638158, 1017.3082304033328, 1027.7995790820867, 4099.508059032935, 4126.814293356806, 4209.915801683949, 4236.639885609758, 4246.150769845982, 10737.35575865435, 11073.390963496924, 11083.334999900031, 11100.167487438475, 11103.888961110448, 10842.620508282173, 11097.33415995043, 11131.777364452666, 11139.610113645984, 11161.776764464828, 7944.404169687296, 8100.797480062928, 8207.425480216327, 8270.214329638675, 8311.501309921303, 5651.265335506358, 5755.0, 5857.0043092673495, 5866.032104702676, 5935.792247271324, 9647.807043858944, 10234.795304093728, 10360.119389851947, 10377.27359084887, 10384.42885641297, 9670.56482458277, 10037.849432258376, 10066.396016239049, 10361.326513776581, 10363.896361036595, 7412.4070074394995, 7646.8088297793, 7650.961745191461, 7915.9208407915185, 8075.838483230185, 8632.007319158378, 8639.352048596505, 8643.56782160902, 8681.565921704016, 8684.522351270742, 7625.23747625233, 7949.562774047483, 7968.243016913384, 8020.83958320842, 8180.059293181361, 7823.8435231293915, 8081.191880811872, 8107.432479726598, 8219.301359384519, 8231.588420579066, 7026.508144429841, 7145.678444469907, 7211.99032135491, 7215.062041934515, 7240.855182896207, 5329.653572517774, 5417.483104730682, 5520.585956053232, 5527.695976721158, 5557.083081291542, 5372.516473517402, 5386.218998245155, 5523.861903452285, 5545.251391062155, 5647.1529270609735], "value": 4691.188337515676, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.17235446371114, 334.5934689352437, 337.9678930501603, 343.1643946989081, 345.29904294282613, 5197.2589182623815, 5352.545033672138, 5369.952859192459, 5380.435054319294, 5400.810971615994, 5285.577153827694, 5315.867103322409, 5316.3354580677415, 5338.252644629755, 5357.732113394324, 4164.895877603054, 4175.582441755831, 4183.4770653668365, 4223.852165174219, 4226.577342265779, 3828.3874580067195, 3946.7237293389476, 4149.336106223005, 4156.0, 4169.0, 4032.556418793945, 4072.7149099563044, 4081.8367265309503, 4105.261053010457, 4111.60939710727, 3978.8607398740905, 4086.1010577672864, 4091.3249313863175, 4093.2018256440006, 4104.15864747726, 3536.257385948954, 3566.5006899033897, 3589.8025608591515, 3601.693856022215, 3608.6210947850623, 5154.974225128888, 5170.466471428973, 5180.740962951837, 5193.68837869729, 5243.2959288231095, 4605.664357336368, 4734.55021772931, 4740.715557066553, 4741.288806678991, 4756.952430475685, 5412.377576578665, 5529.364123125852, 5543.974364742536, 5556.833295001156, 5578.219049333096, 3978.9403158952637, 3981.3629819228786, 3991.6806655467494, 4017.8392864285393, 4027.2750904837117, 5394.190871369326, 5595.328560572757, 5892.263467066617, 5901.4098590141075, 5916.704164791786, 4031.3751368537924, 4051.9392209116886, 4061.005053761847, 4073.307537718595, 4103.938440923389, 4105.609967053125, 4125.5874412558505, 4128.91742165155, 4131.091159944807, 4144.316187828975, 4692.779877231944, 4749.548792864673, 4750.572448479654, 4766.213574760195, 4769.236922092448, 5365.490278423544, 5610.4670056344585, 5612.831615051555, 5632.3804381518, 5674.751554657969, 1408.6265890756636, 1417.9149251044971, 1421.8720315171684, 1437.360374633299, 1442.2860683961505, 872.2934423117296, 914.6570036236411, 919.797644518205, 927.1331305229631, 937.4750139921666, 4772.904541909212, 4810.5670489656095, 4820.855374338776, 4841.0469613535715, 4848.860517778319, 5089.770960306795, 5121.769520371592, 5134.332536770271, 5165.66423182492, 5212.40057393397, 4585.633149348044, 4749.667523273338, 4779.211430114062, 4819.939613285072, 4843.958548912001, 2713.91858244253, 2732.153032559913, 2732.234974207225, 2732.8496932668495, 2739.315171207198, 5251.894962100737, 5278.287431196739, 5328.760205790749, 5374.6506477078865, 5410.377806552218, 4822.807087716452, 5165.509276618715, 5213.5851017583545, 5276.788928442896, 5291.259223708684, 5254.290670759398, 5257.973710131425, 5710.771569137188, 5799.159121927297, 5959.255093113361, 5718.828435146952, 5719.456651618089, 5744.770209191753, 5746.0, 5761.683107429131, 5536.474034966672, 5694.487496125369, 5698.487136157766, 5702.830919661543, 5708.172315014383, 5910.911336329872, 5923.466887980103, 5944.227250457413, 5961.8807623846415, 5966.642001479925, 4044.3326851069246, 4075.49056367954, 4080.816363263601, 4104.610062044101, 4109.178164367078, 5504.752286147213, 5750.332403602908, 5755.65466072037, 5807.76768929255, 5821.446962538552, 5513.531349835309, 5532.778688852401, 5545.029619816435, 5597.468240517144, 5601.971990140023, 5555.583331250092, 5566.610337276352, 5575.052241118939, 5579.553635709052, 5592.944070559242, 5186.662866913639, 5417.674939503642, 5439.728013599225, 5451.373092094302, 5484.61607687458, 5574.414686457863, 5593.580481463825, 5596.972015139898, 5627.0, 5639.774409023593, 5294.867628309323, 5479.452054794648, 5512.94031812348, 5533.174052562565, 5558.194061861089], "value": 4163.4387986178635, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [739.2939742545866, 767.8310771630242, 795.117419664173, 827.3422629009937, 862.7843039240192, 15262.771058434118, 16120.838791612081, 16172.43396481122, 16207.0, 16222.918885405556, 14944.775828362583, 15064.849351506482, 15085.773713394308, 15682.529524114294, 16384.344626214966, 680.6426626021329, 818.6316157729016, 824.2993455562784, 826.1944604011101, 826.6280173921729, 690.858374033322, 691.029104108728, 691.1395312835526, 802.8514724775906, 823.5758584329076, 876.7325965580527, 879.0374539878823, 879.1296616349831, 879.6613303878021, 879.7316818370394, 868.7350358140765, 870.268974061788, 870.6169285514353, 871.0331531999444, 871.0766587417357, 528.3342987835317, 605.5942518512608, 622.3589702606323, 622.7477871462065, 634.7143785296635, 15627.140507272095, 15788.0, 15844.0, 15873.603159920978, 15877.126758028304, 14465.638359041002, 14942.477013304591, 14983.625409364744, 15006.549803505912, 15010.174440405774, 13072.346382680924, 13462.057655964087, 13613.251271180081, 13644.727105457836, 13945.860541394557, 4587.747673877935, 4634.606058485033, 4638.327442520816, 4646.186917289461, 4654.69744466612, 64850.67574662144, 67452.6627366865, 67932.6603366985, 75725.62137189279, 77998.61000695017, 12676.619701408972, 12681.809772853414, 12701.93649031749, 12724.767584721687, 12883.549075782303, 23251.88374058119, 23256.0, 23274.65088023681, 23284.417889552897, 23303.06787728472, 8920.330975176888, 9072.95463522678, 9205.079492050876, 9214.078592140731, 9288.396254243453, 4696.718196908197, 4699.365585645963, 4851.975740121276, 4869.488703686133, 5105.259737338065, 3555.6444355564236, 3674.2651469706166, 3699.2786406650985, 3703.166787472797, 3707.7775333480076, 628.7359309090193, 638.6040654794058, 651.3486513486514, 652.54974067893, 653.6633633678659, 774.4501404003221, 784.4861615641764, 789.5854676294877, 809.9473534220257, 812.8740045292989, 9823.312368134304, 9866.851997220047, 10075.244356673278, 10132.898671013343, 10172.643957461454, 654.2966311215463, 655.9043854883602, 751.9511231770027, 777.3897490469953, 785.4344871692373, 4684.601808846286, 4810.59109975656, 4865.7323847188745, 4877.95122048775, 4948.773240850246, 102144.48927755313, 104703.4764826171, 107741.49666618717, 111735.0, 111887.44056279666, 66791.3320866785, 91769.54115229381, 92604.53697731468, 93282.53358733164, 95738.52130739302, 60755.696221519494, 83108.0, 84489.15510844813, 84589.0, 85073.0, 9377.703099056387, 9430.717078487656, 9507.762305942406, 9527.904720952702, 9651.758706032124, 51884.74057629688, 52779.73610131925, 52892.73553632207, 53810.0, 55004.17493737517, 72152.0, 75562.24437755551, 76059.0, 76916.61541692256, 80783.59608201921, 12853.935730321662, 13074.0, 13108.868911311147, 13163.0, 13352.132111412728, 13054.412551435398, 13055.477780889038, 13270.203787772765, 13759.243241621807, 14569.125852448888, 12640.494380224687, 12728.61814145577, 12764.680882978, 12977.221366718028, 13399.33003349809, 12609.93695031519, 12647.92492638136, 12668.113232074034, 12790.808137878126, 13309.534166304133, 12733.363331833556, 12834.101612887009, 12879.227246365248, 13043.804342935053, 13080.084394092322, 10016.497644255442, 10116.443595602312, 10128.898711012796, 10653.307535010199, 10669.89330106689, 11197.72005699864, 11352.764019215105, 11388.202825802446, 11474.4262786862, 11507.884921150682], "value": 7644.928250351118, "unit": "score"}], "name": "dromaeo_css", "value": 7294.161847147479, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 107.0, 110.0, 114.0, 112.0, 112.0, 113.0, 112.0, 112.0, 112.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 133.0, 142.0, 183.0, 129.0, 127.0, 160.0, 126.0, 184.0, 126.0], "value": 147.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 160.0, 159.0, 160.0, 160.0, 161.0, 160.0, 162.0, 160.0], "value": 160.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 115.0, 77.0, 76.0, 74.0, 74.0, 96.0, 75.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 115.0, 86.0, 85.0, 85.0, 119.0, 84.0, 85.0, 133.0], "value": 96.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 116.0, 116.0, 117.0, 116.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 54.0, 53.0, 53.0, 52.0, 54.0, 52.0, 52.0, 52.0], "value": 52.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 62.0, 63.0, 63.0, 63.0, 63.0, 62.0, 63.0], "value": 62.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 79.0, 78.0, 85.0, 84.0, 80.0, 81.0, 82.0, 115.0, 80.0], "value": 85.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 122.0, 135.0, 121.0, 121.0, 130.0, 121.0, 120.0, 135.0, 130.0], "value": 126.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 169.0, 170.0, 169.0, 163.0, 161.0, 162.0, 167.0, 163.0, 164.0], "value": 165.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 67.0, 65.0, 63.0, 69.0, 63.0, 63.0, 66.0, 65.0, 62.0], "value": 64.6, "unit": "score"}], "name": "kraken", "value": 1509.9999999999998, "alertThreshold": 2.0}]} 10:21:59 INFO - Return code: 0 10:21:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:21:59 ERROR - # TBPL SUCCESS # 10:21:59 INFO - Running post-action listener: _resource_record_post_action 10:21:59 INFO - ##### 10:21:59 INFO - ##### Finished run-tests step (success) 10:21:59 INFO - ##### 10:21:59 INFO - Running post-run listener: _resource_record_post_run 10:21:59 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 7843840; Write bytes: 417660928; Read time: 1508; Write time: 395280 10:21:59 INFO - TinderboxPrint: CPU usage
13.2% 10:21:59 INFO - TinderboxPrint: I/O read bytes / time
7,843,840 / 1,508 10:21:59 INFO - TinderboxPrint: I/O write bytes / time
417,660,928 / 395,280 10:21:59 INFO - TinderboxPrint: CPU idle
8,281.1 (86.8%) 10:21:59 INFO - TinderboxPrint: CPU user
1,207.7 (12.7%) 10:21:59 INFO - TinderboxPrint: Swap in / out
0 / 0 10:21:59 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 96030720; Read time: 0; Write time: 93492 10:21:59 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 6082560; Write bytes: 321630208; Read time: 1452; Write time: 301788 10:22:00 INFO - Running post-run listener: _upload_blobber_files 10:22:00 INFO - Blob upload gear active. 10:22:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:22:00 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 10:22:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:22:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:22:00 INFO - (blobuploader) - INFO - Open directory for files ... 10:22:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:22:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:22:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:22:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:22:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:22:01 INFO - (blobuploader) - INFO - Done attempting. 10:22:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:22:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:22:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:22:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:22:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:22:05 INFO - (blobuploader) - INFO - Done attempting. 10:22:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:22:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:22:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:22:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:22:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:22:06 INFO - (blobuploader) - INFO - Done attempting. 10:22:06 INFO - (blobuploader) - INFO - Iteration through files over. 10:22:06 INFO - Return code: 0 10:22:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:22:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:22:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f74d7878b7e4d36bcdb5aeea58a42ac6ed0cb104ed77df993a7651f9045d8f5637fa9a4db7e2a26c0b14463a0741fcec3bb710bece3f2c2e45d4fee59694638a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/12f690b0043201e868844ea8358bde01faf01b19460e81f4400ffe7d63fdd5b75566eb705dc725a003212489d3b5a8b6b12187f665477b148d0193f7ca92c960", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7dc2b1c9d6d61748cbe3be6a371a2e05e3d94da5c91a8fbdbe2cd0e3436beb45e9dfc2c5746709f1e0d604be9d46226ee9d69d16dde7faaa4c48f84e3580b8ae"} 10:22:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:22:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:22:06 INFO - Contents: 10:22:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f74d7878b7e4d36bcdb5aeea58a42ac6ed0cb104ed77df993a7651f9045d8f5637fa9a4db7e2a26c0b14463a0741fcec3bb710bece3f2c2e45d4fee59694638a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/12f690b0043201e868844ea8358bde01faf01b19460e81f4400ffe7d63fdd5b75566eb705dc725a003212489d3b5a8b6b12187f665477b148d0193f7ca92c960", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7dc2b1c9d6d61748cbe3be6a371a2e05e3d94da5c91a8fbdbe2cd0e3436beb45e9dfc2c5746709f1e0d604be9d46226ee9d69d16dde7faaa4c48f84e3580b8ae"} 10:22:06 INFO - Running post-run listener: copy_logs_to_upload_dir 10:22:06 INFO - Copying logs to upload dir... 10:22:06 INFO - mkdir: /builds/slave/test/build/upload/logs 10:22:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.936933 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-06 10:22:06.741801) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 10:22:06.744998) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1465232153.185901-189158371 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f74d7878b7e4d36bcdb5aeea58a42ac6ed0cb104ed77df993a7651f9045d8f5637fa9a4db7e2a26c0b14463a0741fcec3bb710bece3f2c2e45d4fee59694638a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/12f690b0043201e868844ea8358bde01faf01b19460e81f4400ffe7d63fdd5b75566eb705dc725a003212489d3b5a8b6b12187f665477b148d0193f7ca92c960", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7dc2b1c9d6d61748cbe3be6a371a2e05e3d94da5c91a8fbdbe2cd0e3436beb45e9dfc2c5746709f1e0d604be9d46226ee9d69d16dde7faaa4c48f84e3580b8ae"} build_url:https://queue.taskcluster.net/v1/task/XFucm0-JQ3qenwfLKTrzPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011308 build_url: 'https://queue.taskcluster.net/v1/task/XFucm0-JQ3qenwfLKTrzPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f74d7878b7e4d36bcdb5aeea58a42ac6ed0cb104ed77df993a7651f9045d8f5637fa9a4db7e2a26c0b14463a0741fcec3bb710bece3f2c2e45d4fee59694638a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/12f690b0043201e868844ea8358bde01faf01b19460e81f4400ffe7d63fdd5b75566eb705dc725a003212489d3b5a8b6b12187f665477b148d0193f7ca92c960", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7dc2b1c9d6d61748cbe3be6a371a2e05e3d94da5c91a8fbdbe2cd0e3436beb45e9dfc2c5746709f1e0d604be9d46226ee9d69d16dde7faaa4c48f84e3580b8ae"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 10:22:06.771013) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 10:22:06.771388) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1465232153.185901-189158371 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004582 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 10:22:06.855500) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 10:22:06.855825) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 10:22:06.856128) ========= ========= Total master_lag: 0.15 =========