builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0266 starttime: 1468379821.51 results: success (0) buildid: 20160712191210 builduid: dfc0e09016374488ade06b12e5ce690e revision: c43fa13203725aaf441056e838e68499a8a5c526 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 20:17:01.505542) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 20:17:01.505972) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 20:17:01.506244) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 20:17:01.771002) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 20:17:01.771327) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.AsW9qm8mEJ/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.jfe3kFXymC/Listeners TMPDIR=/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-07-12 20:17:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.8M=0.001s 2016-07-12 20:17:02 (18.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.485917 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 20:17:02.281050) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 20:17:02.281372) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.AsW9qm8mEJ/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.jfe3kFXymC/Listeners TMPDIR=/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.025666 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 20:17:02.330144) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-12 20:17:02.330467) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev c43fa13203725aaf441056e838e68499a8a5c526 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev c43fa13203725aaf441056e838e68499a8a5c526 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.AsW9qm8mEJ/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.jfe3kFXymC/Listeners TMPDIR=/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-07-12 20:17:02,412 truncating revision to first 12 chars 2016-07-12 20:17:02,412 Setting DEBUG logging. 2016-07-12 20:17:02,412 attempt 1/10 2016-07-12 20:17:02,412 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/c43fa1320372?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-12 20:17:04,222 unpacking tar archive at: autoland-c43fa1320372/testing/mozharness/ program finished with exit code 0 elapsedTime=2.693891 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-12 20:17:05.045421) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 20:17:05.045722) ========= script_repo_revision: c43fa13203725aaf441056e838e68499a8a5c526 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 20:17:05.046101) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 20:17:05.046361) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 20:17:05.070405) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-07-12 20:17:05.070786) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.AsW9qm8mEJ/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.jfe3kFXymC/Listeners TMPDIR=/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 20:17:05 INFO - MultiFileLogger online at 20160712 20:17:05 in /builds/slave/test 20:17:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 20:17:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:17:05 INFO - {'append_to_log': False, 20:17:05 INFO - 'base_work_dir': '/builds/slave/test', 20:17:05 INFO - 'blob_upload_branch': 'Autoland', 20:17:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:17:05 INFO - 'branch': 'Autoland', 20:17:05 INFO - 'buildbot_json_path': 'buildprops.json', 20:17:05 INFO - 'config_files': ('talos/mac_config.py',), 20:17:05 INFO - 'default_actions': ('clobber', 20:17:05 INFO - 'read-buildbot-config', 20:17:05 INFO - 'download-and-extract', 20:17:05 INFO - 'populate-webroot', 20:17:05 INFO - 'create-virtualenv', 20:17:05 INFO - 'install', 20:17:05 INFO - 'run-tests'), 20:17:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:17:05 INFO - 'download_minidump_stackwalk': True, 20:17:05 INFO - 'download_symbols': 'ondemand', 20:17:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:17:05 INFO - 'tooltool.py': '/tools/tooltool.py', 20:17:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:17:05 INFO - '/tools/misc-python/virtualenv.py')}, 20:17:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:17:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:17:05 INFO - 'installer_path': 'installer.exe', 20:17:05 INFO - 'log_level': 'info', 20:17:05 INFO - 'log_name': 'talos', 20:17:05 INFO - 'log_to_console': True, 20:17:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:17:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:17:05 INFO - 'opt_config_files': (), 20:17:05 INFO - 'pip_index': False, 20:17:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:17:05 INFO - 'cmd': ('bash', 20:17:05 INFO - '-c', 20:17:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:17:05 INFO - 'enabled': True, 20:17:05 INFO - 'halt_on_failure': False, 20:17:05 INFO - 'name': 'check_screen_resolution'},), 20:17:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:17:05 INFO - 'cmd': ('bash', 20:17:05 INFO - '-c', 20:17:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:17:05 INFO - 'enabled': True, 20:17:05 INFO - 'halt_on_failure': False, 20:17:05 INFO - 'name': 'check_screen_resolution'},), 20:17:05 INFO - 'run_cmd_checks_enabled': True, 20:17:05 INFO - 'sps_profile': False, 20:17:05 INFO - 'sps_profile_interval': 0, 20:17:05 INFO - 'suite': 'dromaeojs', 20:17:05 INFO - 'system_bits': '32', 20:17:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:17:05 INFO - 'title': 't-yosemite-r7-0266', 20:17:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:17:05 INFO - 'use_talos_json': True, 20:17:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:17:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:17:05 INFO - 'work_dir': 'build'} 20:17:05 INFO - ##### 20:17:05 INFO - ##### Running clobber step. 20:17:05 INFO - ##### 20:17:05 INFO - Running pre-action listener: _resource_record_pre_action 20:17:05 INFO - Running main action method: clobber 20:17:05 INFO - rmtree: /builds/slave/test/build 20:17:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:17:07 INFO - Running post-action listener: _resource_record_post_action 20:17:07 INFO - ##### 20:17:07 INFO - ##### Finished clobber step (success) 20:17:07 INFO - ##### 20:17:07 INFO - ##### 20:17:07 INFO - ##### Running read-buildbot-config step. 20:17:07 INFO - ##### 20:17:07 INFO - Running pre-action listener: _resource_record_pre_action 20:17:07 INFO - Running main action method: read_buildbot_config 20:17:07 INFO - Using buildbot properties: 20:17:07 INFO - { 20:17:07 INFO - "project": "", 20:17:07 INFO - "product": "firefox", 20:17:07 INFO - "script_repo_revision": "production", 20:17:07 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 20:17:07 INFO - "repository": "", 20:17:07 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 20:17:07 INFO - "buildid": "20160712191210", 20:17:07 INFO - "pgo_build": "False", 20:17:07 INFO - "basedir": "/builds/slave/test", 20:17:07 INFO - "buildnumber": 5, 20:17:07 INFO - "slavename": "t-yosemite-r7-0266", 20:17:07 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 20:17:07 INFO - "platform": "yosemite_r7", 20:17:07 INFO - "scheduler": "tests-autoland-macosx64-talos", 20:17:07 INFO - "branch": "autoland", 20:17:07 INFO - "repo_path": "integration/autoland", 20:17:07 INFO - "revision": "c43fa13203725aaf441056e838e68499a8a5c526", 20:17:07 INFO - "stage_platform": "macosx64", 20:17:07 INFO - "builduid": "dfc0e09016374488ade06b12e5ce690e", 20:17:07 INFO - "slavebuilddir": "test" 20:17:07 INFO - } 20:17:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/TGPgJZp5TaiQfdZAEa6u2Q/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 20:17:07 INFO - Running post-action listener: _resource_record_post_action 20:17:07 INFO - ##### 20:17:07 INFO - ##### Finished read-buildbot-config step (success) 20:17:07 INFO - ##### 20:17:07 INFO - ##### 20:17:07 INFO - ##### Running download-and-extract step. 20:17:07 INFO - ##### 20:17:07 INFO - Running pre-action listener: _resource_record_pre_action 20:17:07 INFO - Running main action method: download_and_extract 20:17:07 INFO - mkdir: /builds/slave/test/build/tests 20:17:07 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')]} 20:17:07 INFO - https://queue.taskcluster.net/v1/task/TGPgJZp5TaiQfdZAEa6u2Q/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 20:17:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TGPgJZp5TaiQfdZAEa6u2Q/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 20:17:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TGPgJZp5TaiQfdZAEa6u2Q/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 20:17:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TGPgJZp5TaiQfdZAEa6u2Q/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 20:17:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TGPgJZp5TaiQfdZAEa6u2Q/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #1 20:17:10 INFO - Downloaded 1199 bytes. 20:17:10 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 20:17:10 INFO - Using the following test package requirements: 20:17:10 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 20:17:10 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 20:17:10 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 20:17:10 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 20:17:10 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 20:17:10 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 20:17:10 INFO - u'jsshell-mac.zip'], 20:17:10 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 20:17:10 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 20:17:10 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 20:17:10 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 20:17:10 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 20:17:10 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 20:17:10 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 20:17:10 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 20:17:10 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 20:17:10 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 20:17:10 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 20:17:10 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 20:17:10 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')]} 20:17:10 INFO - https://queue.taskcluster.net/v1/task/TGPgJZp5TaiQfdZAEa6u2Q/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 20:17:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TGPgJZp5TaiQfdZAEa6u2Q/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 20:17:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TGPgJZp5TaiQfdZAEa6u2Q/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 20:17:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TGPgJZp5TaiQfdZAEa6u2Q/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 20:17:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TGPgJZp5TaiQfdZAEa6u2Q/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 20:17:13 INFO - Downloaded 18822805 bytes. 20:17:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:17:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 20:17:16 INFO - Return code: 0 20:17:16 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip', u'firefox-50.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 20:17:16 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')]} 20:17:16 INFO - https://queue.taskcluster.net/v1/task/TGPgJZp5TaiQfdZAEa6u2Q/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 20:17:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TGPgJZp5TaiQfdZAEa6u2Q/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 20:17:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TGPgJZp5TaiQfdZAEa6u2Q/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 20:17:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TGPgJZp5TaiQfdZAEa6u2Q/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 20:17:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TGPgJZp5TaiQfdZAEa6u2Q/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 20:17:24 INFO - Downloaded 18822805 bytes. 20:17:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:17:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 20:17:27 INFO - Return code: 0 20:17:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:17:27 INFO - https://queue.taskcluster.net/v1/task/TGPgJZp5TaiQfdZAEa6u2Q/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 20:17:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TGPgJZp5TaiQfdZAEa6u2Q/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 20:17:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TGPgJZp5TaiQfdZAEa6u2Q/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 20:17:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TGPgJZp5TaiQfdZAEa6u2Q/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip 20:17:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TGPgJZp5TaiQfdZAEa6u2Q/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip'}, attempt #1 20:17:28 INFO - Downloaded 14403317 bytes. 20:17:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:17:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 20:17:28 INFO - Return code: 0 20:17: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')]} 20:17:28 INFO - https://queue.taskcluster.net/v1/task/TGPgJZp5TaiQfdZAEa6u2Q/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 20:17:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TGPgJZp5TaiQfdZAEa6u2Q/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 20:17:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TGPgJZp5TaiQfdZAEa6u2Q/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 20:17:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TGPgJZp5TaiQfdZAEa6u2Q/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 20:17:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TGPgJZp5TaiQfdZAEa6u2Q/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg'}, attempt #1 20:17:31 INFO - Downloaded 112793357 bytes. 20:17:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TGPgJZp5TaiQfdZAEa6u2Q/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 20:17:31 INFO - mkdir: /builds/slave/test/properties 20:17:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:17:31 INFO - Writing to file /builds/slave/test/properties/build_url 20:17:31 INFO - Contents: 20:17:31 INFO - build_url:https://queue.taskcluster.net/v1/task/TGPgJZp5TaiQfdZAEa6u2Q/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 20:17:32 INFO - Running post-action listener: _resource_record_post_action 20:17:32 INFO - Running post-action listener: set_extra_try_arguments 20:17:32 INFO - ##### 20:17:32 INFO - ##### Finished download-and-extract step (success) 20:17:32 INFO - ##### 20:17:32 INFO - ##### 20:17:32 INFO - ##### Running populate-webroot step. 20:17:32 INFO - ##### 20:17:32 INFO - Running pre-action listener: _resource_record_pre_action 20:17:32 INFO - Running main action method: populate_webroot 20:17:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:17:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:17:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:17:32 INFO - '--tppagecycles', 20:17:32 INFO - '7'], 20:17:32 INFO - 'tests': ['tsvgm']}}, 20:17:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:17:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:17:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:17:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:17:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:17:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:17:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:17:32 INFO - 'talos_options': ['--disable-e10s'], 20:17:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:17:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:17:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:17:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:17:32 INFO - 'talos_options': ['--disable-e10s'], 20:17:32 INFO - 'tests': ['damp', 'tps']}, 20:17:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:17:32 INFO - 'tests': ['damp', 'tps']}, 20:17:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:17:32 INFO - 'tests': ['dromaeo_dom']}, 20:17:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:17:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:17:32 INFO - 'tests': ['basic_compositor_video']}, 20:17:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:17:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:17:32 INFO - 'tests': ['a11yr', 20:17:32 INFO - 'ts_paint', 20:17:32 INFO - 'tpaint', 20:17:32 INFO - 'sessionrestore', 20:17:32 INFO - 'sessionrestore_no_auto_restore', 20:17:32 INFO - 'tabpaint']}, 20:17:32 INFO - 'other-e10s': {'tests': ['a11yr', 20:17:32 INFO - 'ts_paint', 20:17:32 INFO - 'tpaint', 20:17:32 INFO - 'sessionrestore', 20:17:32 INFO - 'sessionrestore_no_auto_restore', 20:17:32 INFO - 'tabpaint']}, 20:17:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:17:32 INFO - 'ts_paint', 20:17:32 INFO - 'tpaint', 20:17:32 INFO - 'sessionrestore', 20:17:32 INFO - 'sessionrestore_no_auto_restore', 20:17:32 INFO - 'tabpaint']}, 20:17:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:17:32 INFO - 'ts_paint', 20:17:32 INFO - 'tpaint', 20:17:32 INFO - 'sessionrestore', 20:17:32 INFO - 'sessionrestore_no_auto_restore', 20:17:32 INFO - 'tabpaint']}, 20:17:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:17:32 INFO - 'tests': ['a11yr', 20:17:32 INFO - 'ts_paint', 20:17:32 INFO - 'tpaint', 20:17:32 INFO - 'sessionrestore', 20:17:32 INFO - 'sessionrestore_no_auto_restore', 20:17:32 INFO - 'tabpaint']}, 20:17:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:17:32 INFO - 'tests': ['a11yr', 20:17:32 INFO - 'ts_paint', 20:17:32 INFO - 'tpaint', 20:17:32 INFO - 'sessionrestore', 20:17:32 INFO - 'sessionrestore_no_auto_restore', 20:17:32 INFO - 'tabpaint']}, 20:17:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:17:32 INFO - 'tests': ['tsvgx', 20:17:32 INFO - 'tsvgr_opacity', 20:17:32 INFO - 'tart', 20:17:32 INFO - 'tscrollx', 20:17:32 INFO - 'cart']}, 20:17:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:17:32 INFO - 'tsvgr_opacity', 20:17:32 INFO - 'tart', 20:17:32 INFO - 'tscrollx', 20:17:32 INFO - 'cart']}, 20:17:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:17:32 INFO - 'talos_options': ['--disable-e10s'], 20:17:32 INFO - 'tests': ['tp5o']}, 20:17:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:17:32 INFO - 'tests': ['tp5o']}, 20:17:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:17:32 INFO - 'talos_options': ['--disable-e10s', 20:17:32 INFO - '--xperf_path', 20:17:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:17:32 INFO - 'tests': ['tp5n']}, 20:17:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:17:32 INFO - 'talos_options': ['--xperf_path', 20:17:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:17:32 INFO - 'tests': ['tp5n']}}, 20:17:32 INFO - 'talos.zip': {'path': '', 20:17:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:17:32 INFO - Running post-action listener: _resource_record_post_action 20:17:32 INFO - ##### 20:17:32 INFO - ##### Finished populate-webroot step (success) 20:17:32 INFO - ##### 20:17:32 INFO - ##### 20:17:32 INFO - ##### Running create-virtualenv step. 20:17:32 INFO - ##### 20:17:32 INFO - Running pre-action listener: _resource_record_pre_action 20:17:32 INFO - Running main action method: create_virtualenv 20:17:32 INFO - Creating virtualenv /builds/slave/test/build/venv 20:17:32 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 20:17:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:17:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:17:32 INFO - Using real prefix '/tools/python27' 20:17:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:17:33 INFO - Installing distribute.............................................................................................................................................................................................done. 20:17:36 INFO - Installing pip.................done. 20:17:36 INFO - Return code: 0 20:17:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:17:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:17:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:17:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:17:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:17:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:36 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 0x10d22ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2c1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c7b47c660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d190d30>, '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 0x10cef5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d188b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AsW9qm8mEJ/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jfe3kFXymC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:17:36 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 20:17:36 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 20:17:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AsW9qm8mEJ/Render', 20:17:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:17:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:17:36 INFO - 'HOME': '/Users/cltbld', 20:17:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:17:36 INFO - 'LOGNAME': 'cltbld', 20:17:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:17:36 INFO - 'MOZ_NO_REMOTE': '1', 20:17:36 INFO - 'NO_EM_RESTART': '1', 20:17:36 INFO - 'PAGER': '/bin/cat', 20:17:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:17:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:17:36 INFO - 'PWD': '/builds/slave/test', 20:17:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:17:36 INFO - 'SHELL': '/bin/bash', 20:17:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jfe3kFXymC/Listeners', 20:17:36 INFO - 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', 20:17:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:17:36 INFO - 'USER': 'cltbld', 20:17:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:17:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:17:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:17:36 INFO - 'XPC_FLAGS': '0x0', 20:17:36 INFO - 'XPC_SERVICE_NAME': '0', 20:17:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:17:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:17:36 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 20:17:36 INFO - Cleaning up... 20:17:36 INFO - Return code: 0 20:17:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:17:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:17:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:17:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:17:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:17:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:36 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 0x10d22ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2c1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c7b47c660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d190d30>, '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 0x10cef5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d188b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AsW9qm8mEJ/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jfe3kFXymC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:17:36 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 20:17:36 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 20:17:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AsW9qm8mEJ/Render', 20:17:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:17:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:17:36 INFO - 'HOME': '/Users/cltbld', 20:17:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:17:36 INFO - 'LOGNAME': 'cltbld', 20:17:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:17:36 INFO - 'MOZ_NO_REMOTE': '1', 20:17:36 INFO - 'NO_EM_RESTART': '1', 20:17:36 INFO - 'PAGER': '/bin/cat', 20:17:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:17:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:17:36 INFO - 'PWD': '/builds/slave/test', 20:17:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:17:36 INFO - 'SHELL': '/bin/bash', 20:17:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jfe3kFXymC/Listeners', 20:17:36 INFO - 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', 20:17:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:17:36 INFO - 'USER': 'cltbld', 20:17:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:17:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:17:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:17:36 INFO - 'XPC_FLAGS': '0x0', 20:17:36 INFO - 'XPC_SERVICE_NAME': '0', 20:17:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:17:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:17:36 INFO - Downloading/unpacking psutil>=3.1.1 20:17:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:17:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:17:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:17:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:17:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:17:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:17:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:17:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:17:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:17:40 INFO - Installing collected packages: psutil 20:17:40 INFO - Running setup.py install for psutil 20:17:40 INFO - building 'psutil._psutil_osx' extension 20:17:40 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 20:17:40 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 20:17:40 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 20:17:41 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 20:17:41 INFO - building 'psutil._psutil_posix' extension 20:17:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 20:17:41 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:17:41 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:17:41 INFO - ^ 20:17:41 INFO - 1 warning generated. 20:17:41 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 20:17:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:17:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:17:41 INFO - Successfully installed psutil 20:17:41 INFO - Cleaning up... 20:17:41 INFO - Return code: 0 20:17:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:17: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')]} 20:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:17:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17: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')]} 20:17:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:17:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d22ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2c1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c7b47c660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d190d30>, '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 0x10cef5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d188b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AsW9qm8mEJ/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jfe3kFXymC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:17: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:17: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 mozsystemmonitor==0.3 20:17:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AsW9qm8mEJ/Render', 20:17:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:17:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:17:41 INFO - 'HOME': '/Users/cltbld', 20:17:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:17:41 INFO - 'LOGNAME': 'cltbld', 20:17:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:17:41 INFO - 'MOZ_NO_REMOTE': '1', 20:17:41 INFO - 'NO_EM_RESTART': '1', 20:17:41 INFO - 'PAGER': '/bin/cat', 20:17:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:17:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:17:41 INFO - 'PWD': '/builds/slave/test', 20:17:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:17:41 INFO - 'SHELL': '/bin/bash', 20:17:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jfe3kFXymC/Listeners', 20:17:41 INFO - 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', 20:17:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:17:41 INFO - 'USER': 'cltbld', 20:17:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:17:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:17:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:17:41 INFO - 'XPC_FLAGS': '0x0', 20:17:41 INFO - 'XPC_SERVICE_NAME': '0', 20:17:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:17:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:17:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:17: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 20:17: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 20:17: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 20:17: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 20:17: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 20:17: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 20:17:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:17:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:17:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:17:44 INFO - Installing collected packages: mozsystemmonitor 20:17:44 INFO - Running setup.py install for mozsystemmonitor 20:17:44 INFO - Successfully installed mozsystemmonitor 20:17:44 INFO - Cleaning up... 20:17:44 INFO - Return code: 0 20:17:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:17:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:17:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:17:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:17:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:17:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d22ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2c1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c7b47c660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d190d30>, '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 0x10cef5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d188b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AsW9qm8mEJ/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jfe3kFXymC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:17:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:17:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:17:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AsW9qm8mEJ/Render', 20:17:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:17:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:17:44 INFO - 'HOME': '/Users/cltbld', 20:17:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:17:44 INFO - 'LOGNAME': 'cltbld', 20:17:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:17:44 INFO - 'MOZ_NO_REMOTE': '1', 20:17:44 INFO - 'NO_EM_RESTART': '1', 20:17:44 INFO - 'PAGER': '/bin/cat', 20:17:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:17:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:17:44 INFO - 'PWD': '/builds/slave/test', 20:17:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:17:44 INFO - 'SHELL': '/bin/bash', 20:17:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jfe3kFXymC/Listeners', 20:17:44 INFO - 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', 20:17:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:17:44 INFO - 'USER': 'cltbld', 20:17:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:17:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:17:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:17:44 INFO - 'XPC_FLAGS': '0x0', 20:17:44 INFO - 'XPC_SERVICE_NAME': '0', 20:17:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:17:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:17:44 INFO - Downloading/unpacking jsonschema==2.5.1 20:17:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:17:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:17:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:17:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:17:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:17:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:17:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:17:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:17: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 20:17: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 20:17: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 20:17: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 20:17: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 20:17: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 20:17:47 INFO - Downloading functools32-3.2.3-2.tar.gz 20:17:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:17:47 INFO - warning: no files found matching '*.txt' 20:17:47 INFO - no previously-included directories found matching 'build' 20:17:47 INFO - no previously-included directories found matching 'dist' 20:17:47 INFO - no previously-included directories found matching '.git*' 20:17:47 INFO - Installing collected packages: jsonschema, functools32 20:17:47 INFO - Running setup.py install for functools32 20:17:47 INFO - warning: no files found matching '*.txt' 20:17:47 INFO - no previously-included directories found matching 'build' 20:17:47 INFO - no previously-included directories found matching 'dist' 20:17:47 INFO - no previously-included directories found matching '.git*' 20:17:47 INFO - Successfully installed jsonschema functools32 20:17:47 INFO - Cleaning up... 20:17:48 INFO - Return code: 0 20:17:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:17:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:17:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:17:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:17:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d22ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2c1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c7b47c660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d190d30>, '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 0x10cef5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d188b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AsW9qm8mEJ/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jfe3kFXymC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:17:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:17:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:17:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AsW9qm8mEJ/Render', 20:17:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:17:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:17:48 INFO - 'HOME': '/Users/cltbld', 20:17:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:17:48 INFO - 'LOGNAME': 'cltbld', 20:17:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:17:48 INFO - 'MOZ_NO_REMOTE': '1', 20:17:48 INFO - 'NO_EM_RESTART': '1', 20:17:48 INFO - 'PAGER': '/bin/cat', 20:17:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:17:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:17:48 INFO - 'PWD': '/builds/slave/test', 20:17:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:17:48 INFO - 'SHELL': '/bin/bash', 20:17:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jfe3kFXymC/Listeners', 20:17:48 INFO - 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', 20:17:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:17:48 INFO - 'USER': 'cltbld', 20:17:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:17:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:17:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:17:48 INFO - 'XPC_FLAGS': '0x0', 20:17:48 INFO - 'XPC_SERVICE_NAME': '0', 20:17:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:17:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:17:48 INFO - Downloading/unpacking blobuploader==1.2.4 20:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:17:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:17:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:17:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:17:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:17:50 INFO - Downloading blobuploader-1.2.4.tar.gz 20:17:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:17:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:17: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 20:17: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 20:17: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 20:17: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 20:17: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 20:17: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 20:17:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:17:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:17:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:17:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:17:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:17:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:17:51 INFO - Downloading docopt-0.6.1.tar.gz 20:17:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:17:52 INFO - Installing collected packages: blobuploader, requests, docopt 20:17:52 INFO - Running setup.py install for blobuploader 20:17:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:17:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:17:52 INFO - Running setup.py install for requests 20:17:52 INFO - Running setup.py install for docopt 20:17:52 INFO - Successfully installed blobuploader requests docopt 20:17:52 INFO - Cleaning up... 20:17:52 INFO - Return code: 0 20:17:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:17:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:17:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:17:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:17:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d22ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2c1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c7b47c660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d190d30>, '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 0x10cef5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d188b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AsW9qm8mEJ/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jfe3kFXymC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:17:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:17:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:17:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AsW9qm8mEJ/Render', 20:17:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:17:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:17:52 INFO - 'HOME': '/Users/cltbld', 20:17:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:17:52 INFO - 'LOGNAME': 'cltbld', 20:17:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:17:52 INFO - 'MOZ_NO_REMOTE': '1', 20:17:52 INFO - 'NO_EM_RESTART': '1', 20:17:52 INFO - 'PAGER': '/bin/cat', 20:17:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:17:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:17:52 INFO - 'PWD': '/builds/slave/test', 20:17:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:17:52 INFO - 'SHELL': '/bin/bash', 20:17:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jfe3kFXymC/Listeners', 20:17:52 INFO - 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', 20:17:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:17:52 INFO - 'USER': 'cltbld', 20:17:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:17:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:17:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:17:52 INFO - 'XPC_FLAGS': '0x0', 20:17:52 INFO - 'XPC_SERVICE_NAME': '0', 20:17:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:17:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:17:53 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-FwuH_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:17:53 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-ttAR2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:17:53 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-8LNTHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:17:53 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-KXuwqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:17:53 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-6i9FJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:17:53 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-fCL20k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:17:53 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-oCrJ5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:17:53 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-gDYW9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:17:54 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-NPXiZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:17:54 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-wlO7he-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:17:54 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-RNQwT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:17:54 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-ejs3Tx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:17:54 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-NT8Tyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:17:54 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-zVblkG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:17:54 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-SRkGcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:17:54 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-qUFMqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:17:54 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-11d6AR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:17:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:17:54 INFO - Running setup.py install for manifestparser 20:17:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:17:55 INFO - Running setup.py install for mozcrash 20:17:55 INFO - Running setup.py install for mozdebug 20:17:55 INFO - Running setup.py install for mozdevice 20:17:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:17:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:17:55 INFO - Running setup.py install for mozfile 20:17:55 INFO - Running setup.py install for mozhttpd 20:17:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:17:55 INFO - Running setup.py install for mozinfo 20:17:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:17:55 INFO - Running setup.py install for mozInstall 20:17:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:17:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:17:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:17:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:17:56 INFO - Running setup.py install for mozleak 20:17:56 INFO - Running setup.py install for mozlog 20:17:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:17:56 INFO - Running setup.py install for moznetwork 20:17:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:17:56 INFO - Running setup.py install for mozprocess 20:17:56 INFO - Running setup.py install for mozprofile 20:17:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:17:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:17:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:17:56 INFO - Running setup.py install for mozrunner 20:17:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:17:57 INFO - Running setup.py install for mozscreenshot 20:17:57 INFO - Running setup.py install for moztest 20:17:57 INFO - Running setup.py install for mozversion 20:17:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:17:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:17:57 INFO - Cleaning up... 20:17:57 INFO - Return code: 0 20:17:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:17: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')]} 20:17:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:17:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17: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')]} 20:17:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:17:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17: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 0x10d22ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2c1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c7b47c660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d190d30>, '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 0x10cef5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d188b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AsW9qm8mEJ/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jfe3kFXymC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:17: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 20:17: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 20:17:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AsW9qm8mEJ/Render', 20:17:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:17:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:17:57 INFO - 'HOME': '/Users/cltbld', 20:17:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:17:57 INFO - 'LOGNAME': 'cltbld', 20:17:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:17:57 INFO - 'MOZ_NO_REMOTE': '1', 20:17:57 INFO - 'NO_EM_RESTART': '1', 20:17:57 INFO - 'PAGER': '/bin/cat', 20:17:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:17:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:17:57 INFO - 'PWD': '/builds/slave/test', 20:17:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:17:57 INFO - 'SHELL': '/bin/bash', 20:17:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jfe3kFXymC/Listeners', 20:17:57 INFO - 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', 20:17:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:17:57 INFO - 'USER': 'cltbld', 20:17:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:17:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:17:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:17:57 INFO - 'XPC_FLAGS': '0x0', 20:17:57 INFO - 'XPC_SERVICE_NAME': '0', 20:17:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:17:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:17:57 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-DA0m7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:17: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)) 20:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:17:57 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-6NTrP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:17: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)) 20:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:17:57 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-6jf7RI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:17:58 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-27KJYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:17:58 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-7ZYjoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:17:58 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)) 20:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:17:58 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-MiiC0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:17:58 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)) 20:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:17:58 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-iFcMBd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:17:58 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)) 20:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:17:58 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-msOhqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:17:58 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)) 20:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:17:58 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-ihpspi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:17:58 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)) 20:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:17:58 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-OsjAts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:17:58 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)) 20:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:17:58 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-gvGbO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:17: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)) 20:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:17:58 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-RvVvMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:17:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 20:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:17:59 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-3Pw1pQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:17:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 20:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:17:59 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-jAWMb1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:17:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 20:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:17:59 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-FuEGnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:17:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 20:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:17:59 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-294dYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:17:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 20:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:17:59 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-ov_m4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:17:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 20:17:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:17:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:17:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:17:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:17:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:17:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:17:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:17:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:17:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:17:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:18:01 INFO - Downloading blessings-1.6.tar.gz 20:18:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:18:02 INFO - Installing collected packages: blessings 20:18:02 INFO - Running setup.py install for blessings 20:18:02 INFO - Successfully installed blessings 20:18:02 INFO - Cleaning up... 20:18:02 INFO - Return code: 0 20:18:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:18:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:18:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:18:02 INFO - Reading from file tmpfile_stdout 20:18:02 INFO - Current package versions: 20:18:02 INFO - blessings == 1.6 20:18:02 INFO - blobuploader == 1.2.4 20:18:02 INFO - docopt == 0.6.1 20:18:02 INFO - functools32 == 3.2.3-2 20:18:02 INFO - jsonschema == 2.5.1 20:18:02 INFO - manifestparser == 1.1 20:18:02 INFO - mozInstall == 1.12 20:18:02 INFO - mozcrash == 0.17 20:18:02 INFO - mozdebug == 0.1 20:18:02 INFO - mozdevice == 0.48 20:18:02 INFO - mozfile == 1.2 20:18:02 INFO - mozhttpd == 0.7 20:18:02 INFO - mozinfo == 0.9 20:18:02 INFO - mozleak == 0.1 20:18:02 INFO - mozlog == 3.2 20:18:02 INFO - moznetwork == 0.27 20:18:02 INFO - mozprocess == 0.23 20:18:02 INFO - mozprofile == 0.28 20:18:02 INFO - mozrunner == 6.12 20:18:02 INFO - mozscreenshot == 0.1 20:18:02 INFO - mozsystemmonitor == 0.3 20:18:02 INFO - moztest == 0.7 20:18:02 INFO - mozversion == 1.4 20:18:02 INFO - psutil == 3.1.1 20:18:02 INFO - requests == 1.2.3 20:18:02 INFO - wsgiref == 0.1.2 20:18:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:18:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:18:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:18:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:18:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:18:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d22ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2c1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c7b47c660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d190d30>, '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 0x10cef5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d188b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AsW9qm8mEJ/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jfe3kFXymC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:18:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 20:18:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:18:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AsW9qm8mEJ/Render', 20:18:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:18:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:18:02 INFO - 'HOME': '/Users/cltbld', 20:18:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:18:02 INFO - 'LOGNAME': 'cltbld', 20:18:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:18:02 INFO - 'MOZ_NO_REMOTE': '1', 20:18:02 INFO - 'NO_EM_RESTART': '1', 20:18:02 INFO - 'PAGER': '/bin/cat', 20:18:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:18:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:18:02 INFO - 'PWD': '/builds/slave/test', 20:18:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:18:02 INFO - 'SHELL': '/bin/bash', 20:18:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jfe3kFXymC/Listeners', 20:18:02 INFO - 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', 20:18:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:18:02 INFO - 'USER': 'cltbld', 20:18:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:18:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:18:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:18:02 INFO - 'XPC_FLAGS': '0x0', 20:18:02 INFO - 'XPC_SERVICE_NAME': '0', 20:18:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:18:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 20:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 20:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 20:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 20:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 20:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 20:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 20:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:18:02 INFO - Cleaning up... 20:18:02 INFO - Return code: 0 20:18:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:18:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:18:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:18:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:18:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:18:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d22ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2c1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c7b47c660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d190d30>, '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 0x10cef5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d188b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AsW9qm8mEJ/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jfe3kFXymC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:18:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:18:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:18:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AsW9qm8mEJ/Render', 20:18:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:18:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:18:02 INFO - 'HOME': '/Users/cltbld', 20:18:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:18:02 INFO - 'LOGNAME': 'cltbld', 20:18:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:18:02 INFO - 'MOZ_NO_REMOTE': '1', 20:18:02 INFO - 'NO_EM_RESTART': '1', 20:18:02 INFO - 'PAGER': '/bin/cat', 20:18:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:18:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:18:02 INFO - 'PWD': '/builds/slave/test', 20:18:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:18:02 INFO - 'SHELL': '/bin/bash', 20:18:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jfe3kFXymC/Listeners', 20:18:02 INFO - 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', 20:18:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:18:02 INFO - 'USER': 'cltbld', 20:18:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:18:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:18:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:18:02 INFO - 'XPC_FLAGS': '0x0', 20:18:02 INFO - 'XPC_SERVICE_NAME': '0', 20:18:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:18:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:18:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:18:03 INFO - Cleaning up... 20:18:03 INFO - Return code: 0 20:18:03 INFO - Running post-action listener: _resource_record_post_action 20:18:03 INFO - Running post-action listener: _start_resource_monitoring 20:18:03 INFO - Starting resource monitoring. 20:18:03 INFO - ##### 20:18:03 INFO - ##### Finished create-virtualenv step (success) 20:18:03 INFO - ##### 20:18:03 INFO - ##### 20:18:03 INFO - ##### Running install step. 20:18:03 INFO - ##### 20:18:03 INFO - Running pre-action listener: _resource_record_pre_action 20:18:03 INFO - Running main action method: install 20:18:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:18:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:18:03 INFO - Reading from file tmpfile_stdout 20:18:03 INFO - Detecting whether we're running mozinstall >=1.0... 20:18:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:18:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:18:03 INFO - Reading from file tmpfile_stdout 20:18:03 INFO - Output received: 20:18:03 INFO - Usage: mozinstall [options] installer 20:18:03 INFO - Options: 20:18:03 INFO - -h, --help show this help message and exit 20:18:03 INFO - -d DEST, --destination=DEST 20:18:03 INFO - Directory to install application into. [default: 20:18:03 INFO - "/builds/slave/test"] 20:18:03 INFO - --app=APP Application being installed. [default: firefox] 20:18:03 INFO - mkdir: /builds/slave/test/build/application 20:18:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 20:18:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 20:18:37 INFO - Reading from file tmpfile_stdout 20:18:37 INFO - Output received: 20:18:37 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 20:18:37 INFO - Running post-action listener: _resource_record_post_action 20:18:37 INFO - ##### 20:18:37 INFO - ##### Finished install step (success) 20:18:37 INFO - ##### 20:18:37 INFO - ##### 20:18:37 INFO - ##### Running run-tests step. 20:18:37 INFO - ##### 20:18:37 INFO - Running pre-action listener: _resource_record_pre_action 20:18:37 INFO - Running main action method: run_tests 20:18:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:18:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:18:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:18:37 INFO - 2016-07-12 20:18:37.751 screenresolution[1649:8868] starting screenresolution argv=screenresolution get 20:18:37 INFO - 2016-07-12 20:18:37.754 screenresolution[1649:8868] Display 0: 1600x1200x32@60 20:18:37 INFO - 2016-07-12 20:18:37.760 screenresolution[1650:8870] starting screenresolution argv=screenresolution list 20:18:37 INFO - Available Modes on Display 0 20:18:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:18:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:18:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:18:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:18:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:18:38 INFO - Intel Iris: 20:18:38 INFO - Chipset Model: Intel Iris 20:18:38 INFO - Type: GPU 20:18:38 INFO - Bus: Built-In 20:18:38 INFO - VRAM (Dynamic, Max): 1536 MB 20:18:38 INFO - Vendor: Intel (0x8086) 20:18:38 INFO - Device ID: 0x0a2e 20:18:38 INFO - Revision ID: 0x0009 20:18:38 INFO - Displays: 20:18:38 INFO - Display: 20:18:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:18:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:18:38 INFO - Display Serial Number: 1600x1200 60 20:18:38 INFO - Main Display: Yes 20:18:38 INFO - Mirror: Off 20:18:38 INFO - Online: Yes 20:18:38 INFO - Rotation: Supported 20:18:38 INFO - Return code: 0 20:18:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:18:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:18:38 INFO - Python 2.7.3 20:18:38 INFO - Return code: 0 20:18:38 INFO - grabbing minidump binary from tooltool 20:18:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:18:38 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/macosx64/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 0x10d190d30>, '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 0x10cef5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d188b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:18:38 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 20:18:38 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/macosx64/releng.manifest -o -c /builds/tooltool_cache 20:18:38 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 20:18:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:18:38 INFO - Return code: 0 20:18:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:18:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:18:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:18:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:18:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:18:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TGPgJZp5TaiQfdZAEa6u2Q/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0266', '--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 20:18:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TGPgJZp5TaiQfdZAEa6u2Q/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0266 --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 20:18:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AsW9qm8mEJ/Render', 20:18:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:18:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:18:38 INFO - 'HOME': '/Users/cltbld', 20:18:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:18:38 INFO - 'LOGNAME': 'cltbld', 20:18:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:18:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:18:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:18:38 INFO - 'MOZ_NO_REMOTE': '1', 20:18:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:18:38 INFO - 'NO_EM_RESTART': '1', 20:18:38 INFO - 'PAGER': '/bin/cat', 20:18:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:18:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:18:38 INFO - 'PWD': '/builds/slave/test', 20:18:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:18:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:18:38 INFO - 'SHELL': '/bin/bash', 20:18:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jfe3kFXymC/Listeners', 20:18:38 INFO - 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', 20:18:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:18:38 INFO - 'USER': 'cltbld', 20:18:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:18:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:18:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:18:38 INFO - 'XPC_FLAGS': '0x0', 20:18:38 INFO - 'XPC_SERVICE_NAME': '0', 20:18:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:18:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TGPgJZp5TaiQfdZAEa6u2Q/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0266', '--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 20:18:38 INFO - mozversion application_buildid: 20160712191210 20:18:38 INFO - mozversion application_changeset: c43fa13203725aaf441056e838e68499a8a5c526 20:18:38 INFO - mozversion application_display_name: Nightly 20:18:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:18:38 INFO - mozversion application_name: Firefox 20:18:38 INFO - mozversion application_remotingname: firefox 20:18:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 20:18:38 INFO - mozversion application_vendor: Mozilla 20:18:38 INFO - mozversion application_version: 50.0a1 20:18:38 INFO - mozversion platform_buildid: 20160712191210 20:18:38 INFO - mozversion platform_changeset: c43fa13203725aaf441056e838e68499a8a5c526 20:18:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 20:18:38 INFO - mozversion platform_version: 50.0a1 20:18:38 INFO - using testdate: 1468379918 20:18:38 INFO - actual date: 1468379918 20:18:38 INFO - starting webserver on 'localhost:49268' 20:18:38 INFO - SUITE-START | Running 2 tests 20:18:38 INFO - TEST-START | dromaeo_css 20:18:38 INFO - operating with platform_type : mac_ 20:18:38 INFO - Initialising browser for dromaeo_css test... 20:18:38 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/tmpNpNhpT/profile http://localhost:49268/getInfo.html) 20:18:40 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 20:18:40 INFO - PROCESS | 1660 | colorDepth:24 20:18:40 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 20:18:40 INFO - PROCESS | 1660 | __metrics 20:18:41 INFO - PROCESS | 1660 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:18:41 INFO - PROCESS | 1660 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:18:41 INFO - TEST-INFO | 1660: exit 0 20:18:41 INFO - Browser initialized. 20:18:41 INFO - Running cycle 1/1 for dromaeo_css test... 20:18:41 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/tmpNpNhpT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:18:53 INFO - PROCESS | 1663 | RSS: Main: 243703808 20:18:53 INFO - PROCESS | 1663 | 20:19:45 INFO - PROCESS | 1663 | 1468379985538 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] 20:21:57 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49268/tests/dromaeo/cssquery-ext.html) 20:21:58 INFO - PROCESS | 1663 | RSS: Main: 395329536 20:21:58 INFO - PROCESS | 1663 | 20:25:02 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-ext.html (next: http://localhost:49268/tests/dromaeo/cssquery-jquery.html) 20:25:02 INFO - PROCESS | 1663 | RSS: Main: 382808064 20:25:02 INFO - PROCESS | 1663 | 20:28:05 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49268/tests/dromaeo/cssquery-mootools.html) 20:28:05 INFO - PROCESS | 1663 | RSS: Main: 372826112 20:28:05 INFO - PROCESS | 1663 | 20:31:08 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49268/tests/dromaeo/cssquery-prototype.html) 20:31:08 INFO - PROCESS | 1663 | RSS: Main: 373014528 20:31:08 INFO - PROCESS | 1663 | 20:34:12 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49268/tests/dromaeo/cssquery-yui.html) 20:34:12 INFO - PROCESS | 1663 | RSS: Main: 337330176 20:34:12 INFO - PROCESS | 1663 | 20:37:16 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-yui.html (next: http://localhost:49268/tests/dromaeo/cssquery-dojo.html) 20:37:16 INFO - PROCESS | 1663 | RSS: Main: 386207744 20:37:16 INFO - PROCESS | 1663 | 20:37:16 INFO - PROCESS | 1663 | __start_tp_report 20:37:16 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 20:37:16 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 20:37:16 INFO - PROCESS | 1663 | |i|pagename|runs| 20:37:16 INFO - PROCESS | 1663 | |0;dojo.html;3367.158210447388;3373.881914133006;3397.116749645093;3415.7608967372294;3455.688987991082;5607.102863541834;5705.5720820938495;5738.598298119134;5754.683492407916;5787.739551720178;5673.290838645169;5728.942710572893;5734.139879018139;5739.139129130633;5742.569307301948;5168.121419358718;5195.168772996321;5204.985027919557;5247.606429517801;5303.390110137326;5230.21546767984;5247.86880327991;5255.027819853321;5257.421683614799;5259;5211.947880521203;5213.4004589472315;5238.869028274305;5247.23915032322;5260.631755777097;5311.62818602698;5316.946830531703;5319.780938450104;5322.988632159916;5342.706151161685;5137.666051706665;5137.974310128463;5142.357205349332;5252.527272545451;5261.789528418859;5694.9430505695245;5725.484706376405;5747.655140691572;5769.884602307972;5774.249347584829;6291.7797877074545;6297.4017468340435;6309.400606942333;6322.241331040259;6324.968375158141;6115.908261376083;6205.906911396332;6245.063240513914;6255.374462553754;6289.182406287154;5858.619189752652;5883.941160588425;5895.970520147458;5917.289925209003;5923.940760592425;5530.723463826793;6273.749050038039;6278.372162783685;6280.528960327993;6281.183446151971;6060.454559089703;6084.6178027713395;6084.824809662311;6115.362036198677;6240.563160578807;6190.442860142519;6193.256809182927;6259;6262.780802671885;6281.246250449975;6289.654069026247;6300.369963003663;6301.306856245809;6304.117423560705;6319.146915166486;6233.563650544418;6267.247930248308;6291.339409362043;6315.115883776275;6326.905096423558;4897.314375987365;4938.876528086755;4942.604591632661;4955.5044495550155;4994.600431965434;4443.888902777392;4458.063806600585;4462.531434199363;4473.977630111829;4492.775361231926;5651.12407576818;5757.798477053283;5790.449907258803;5795.362510123883;5855.092460668603;5165.845024649267;6230.065490176419;6275.090111933744;6276.466500347522;6280.780172693934;5766.135079737989;5780.277465316835;5833.329167145833;5834.679092649945;5900.734466948998;5436.592255580847;5457.099578569491;5458.590605704588;5464.26232458621;5497.147942068986;5414.648047876875;6224.62652240867;6295.5907865988565;6297.748090076529;6325.683715814099;6126.761967422386;6173.475254603409;6181.81454556364;6186.876262474815;6229.657368844576;6167.167432396748;6174.629522228681;6176.907346389898;6215.751369945152;6230.906536402048;6191.102290167991;6205.937940620536;6206.379362063938;6206.627602343874;6227.346128656426;5098.643094983316;6154.138420621027;6290.937090629035;6296.842578935563;6300.62196268207;6020.488258498077;6102.307478454246;6120.387961203844;6149.323574406722;6155.292141403616;6171.537134714825;6190.845228869314;6201.565890387629;6205.131281620486;6207.131001659862;5973.910391344047;6000;6029.141349536388;6054.697265136638;6110.7861224856915;6011.87976240464;6066.636001839904;6088.330283668704;6097.161734506546;6100.847478812888;5995.640261584319;5995.700214989321;6015.849603759941;6088.025915853442;6100.389961003864 20:37:16 INFO - PROCESS | 1663 | |1;ext.html;486.8977514721908;512.5668809855672;515.1088616693121;518.3934796288343;569.2514343638114;30165.24586885326;31617.051488455356;31627.841860790722;31712.524312135338;40660.79669601655;33275.16812079693;43340;43406.565934340644;43495.78252108735;43497.347539786926;9672.661456849011;9854.655087071955;9866.112049915506;9868.111869931705;9872.950635246814;8522.616482258314;8719.520426376546;8723.651053957834;9704.90295097047;9813.90186098137;8903.109689031078;8952.776180595472;11757.7648447031;11960.342181180074;12081.637550873444;12008.919197272244;12046.277223366582;12055.57805476804;12064.155509114365;12094.516219351215;11947.522099116024;12032.639020829389;12037.578684745991;12041.277523348626;12044.217125886877;31363.686363136534;40046.59953400487;40702;40833.59166408327;42740.78629606863;3540.6636369544854;3594.0655429588232;3604.2431089471243;3738.3084129436143;3937.153511994935;32004.519932201034;32723.50914736281;32979.6702032979;32993;33048;3277.0987978305916;3302;3304.7851889627095;3322.335532893431;3446.172918499542;548478;550101;551043;551615;552890;53343.19985200225;61734.69132654308;63330.68334658389;63372;63639.6818015907;66747.66626166838;67113.66443167753;67176.328236717;67251;67261;16850.15749212559;17027.574310642332;17030.659386812444;17042.57393565146;17058.402955896483;11918.04655627565;12211.206271592318;12837.165584236995;12975.156614820007;13133.34333283332;14056.929715351358;18034.909825450788;19398.224071037283;19566.902165489082;19684.114214860365;6771.966140169267;7026.718931242693;8061.83876322482;8099.352051835839;8218.917810821815;879.9032106468284;941.9952900235455;976.3409698453515;1034.622362837559;1121.472907733364;30434.391312173633;30692.53961190584;31487.37025259482;31578.526322105186;31648;1015.1219195395929;1061.856649352343;1081.0756802933536;1083.9295445796;1094.715374002765;15417.691646167239;15502.767458488132;15565.610859728597;15640.4525841595;15870;694465;705739;711806;712242;713940;49055.75472122688;49915;56698.43301566932;57918.13122803161;58102;1425.0665813891917;1440.5822311529748;1448.3265281644085;1450.3980847947983;1456.4538298138198;29256;30819.38361232718;30843.84578077185;30879;31597.368052638358;51196;51351;52083;52167.47832521626;52167.47832521626;552211;827781;939194;939442;952630;25891.870540647174;26150.73849261483;26157.084502042337;26167.738322617293;26180.08369707051;45083;46280.30579541377;46747.76626116984;46776;46798.53201467942;35959.64040359668;37521.81239093896;37924.05189870275;38135.279708044014;38792.6120738789;37638.43542346812;37667.43498847465;37791.811040944616;38426.80786596161;38487;36502.26995460129;36922.261554768214;37318.25363492661;37344.43983340198;37533;26144.60783088217;31307.53038704467;33232.833835830665;33628.49557256692;33916.83041584776;24698.13556525585;24754.009839606213;24765.62851557264;24780.628290576016;24961.875190624658 20:37:16 INFO - PROCESS | 1663 | |2;jquery.html;328.8306522141097;360.9133807886105;387.7692772800184;393.64571885303206;410.2717676124878;12755.936220318898;15965.84034159658;21373;21786.910654467254;21825.345239642797;17051.57371065724;21377.251796187098;21381.251656192035;21515;21761.564768704615;5359.892802143955;5872.471477567018;6131.570790044699;6149.600275982069;6153.692315384235;5212.1660534314515;6013.699315034252;6077.574569780095;6117.66352850593;6127.601705889125;5808.186853840466;6086.969565152168;6098.786542471014;6141.570090093695;6150.077488376734;6076.179715738407;6089.208402907616;6116.908246376286;6125.234345706786;6136.693165341738;5794.797182098649;5966.254218222723;5966.761329546813;5967.910481342783;5994.340622531518;16226.026438413734;21805.563888722296;23277.418064548354;26311.47377052448;26352.73647263522;2239.73123225214;2401.5317013182434;2468.2471846086937;2508.325303430483;2554.1443616388533;10040.29717919746;10088.243381746399;10194.541245643964;10565.683029509128;10586.20603454744;1900.7148927660962;1904.628597423489;1905.876118052336;1931.874428162165;1939.679952807785;122024.38987805093;128555;132911.33544332313;133214;133670.33164834115;11539.711507212387;11602.593909213307;11771.176017678852;11800.701922788487;12001.759964800654;14550;14726.484573039892;14749.188794616399;14755.40978360875;14778.778318325234;8602.87095693565;8722.520261385558;8742.213200811957;8798.560071996375;8834.116588341114;8743.038265790758;8747.51888646118;8761.605727742266;8873.866891996626;8881.333899957399;4525.253333199985;4583.243764778841;4604.493505714368;4612.331211974245;4634.814607415733;1812.1392338639305;1909.6562618728485;1954.5309125809704;1954.6677064899002;1994.1524851937868;721.4949535325188;892.5983307511646;946.2666433513945;990.6186118344489;1020.3622735790132;18654.34709785151;21722;21796.673049904264;21850.453738656342;21906.671399929015;833.2251006563954;930.5998420679038;963.6819849449665;970.1753509516855;972.6206779356057;9115.951665558414;10963.50664220112;11514.30914145154;11542.422878856023;11563.595274165533;516976;521926;523575;614906;623859;136035;145889;146753;148179;151275;976.3653625143571;991.8561808537721;1015.8831734350497;1030.4332617060586;1035.4563853976722;19529.414117576496;19787.901060494605;19852.106655200263;19874.50313742168;19884.90057549703;58075.70962145162;58774.82450351054;61241.38758612357;61424.38575614187;61692.76614467775;80601;83851.5807420959;84914.57542712247;85032.14967850242;86260;4265.42416773744;5941.0197317442135;6271.4669253114;7472.29013243741;7729.381649467917;10866.348019118877;11927.582534611247;12544.560940367044;12767.93616031914;12904.677383065124;11053.984575835528;11331.773364532828;11624.6512604622;11720.238184517979;11983.161178717755;7935.682572697027;11404.94297528507;11670.88329116732;11784.175107742376;12020.459079341275;8069.112397636372;8249.79375515617;8271.172882711922;8354.039285482248;8519.74440766778;11566.65300041;12505.312207828656;12742.87257127454;12798.360081996048;12965.935170324088;11853.76292474163;11884.584039558575;12036.699082522657;12090.758184836079;12124.818127728267 20:37:16 INFO - PROCESS | 1663 | |3;mootools.html;1530.3725472556248;1568.4667213147532;1798.343604584327;1934.5840644261482;1956.1001939108;8505.574721263934;8853.778655533615;9014.278857691384;9030.954845225773;9042.276617870571;7840.568768717718;8058.5567793771315;8480;8695.521746303952;8812.4712517249;2360.5396947595227;2387.880605969703;2391.6173412254043;2393.150431596784;2404.362843846382;2364.4679947011955;2369.016858003935;2402.7356990731005;2403.8437501562344;2406.5547873643345;2080.8959552022416;2154.396768904709;2299.034405549673;2354.81161507079;2370.691810064689;2111.3502554294414;2360.409897525619;2380.321608341614;2381.3570336009266;2384.487335222918;2300.6779050932882;2319.5592837361014;2346.4368551547677;2347.3779448446003;2354.1642716835618;8842;8893.244074253696;8906.376553641248;8914.465132092031;8916.821663566758;5211.739413029333;5377.0321342158395;5390.380106287788;5419.376771671229;5443.863903402407;3528.453089771064;3539.557555305587;3541.2533268812;3544.6987006104514;3590.317839610492;1053.952572134256;1110.7500812317164;1111.1000089927104;1784.687679656068;1859.3771086685977;11726.413679316085;11793.82309265353;11803.173777835555;11810.232334898204;11840.407979601072;4293.162833247487;4319.028218650778;4443.2224360736745;4451.287793952952;4573.47405048417;9162.496062716615;9201.677941272157;9217.631294748135;9219.585118669676;9220.723378298662;5260;5260.526552610283;5269.288646032813;5271.71005594696;5296;3736.981315093407;4407.801648925806;4547.795349209227;4552.521985191507;4949.65352425334;3486.633903440153;3653.488511608377;3762;3821.1402434452025;3880.243352546283;1137.4824454873012;1157.311399717167;1168.2348062019391;1169.4503583315827;1174.3599738142732;833.6332013913858;891.6388862510694;925.421611492817;936.7564433247269;946.6781294359951;5975.880482390327;6003.219581454383;6011.27864656244;6023.156758053876;6093.786717464867;402.3120464006582;431.7927394850489;437.1693781814578;450.86248694147946;456.58678895599536;3514.0687717754818;3627.9841644339626;3925.2149570085526;3955.624215699504;4091.529474110456;10353.119984801226;10834.133269338434;10850.131989440826;10864.402457864735;10878.782424351626;10465.319754216103;10822.67531974042;10907.400092994803;10910;10910.945445272722;7904.6442910068035;8317.542535160503;8334.583270836434;8403.243708066304;8412.621432035574;6010.909836352371;6046.788362407295;6048.788292409745;6129.969350153221;6160.9383906160365;9839.85240221383;10165.186785057325;10179.185665146919;10202.642907498202;10239.283250172417;9155.130262625307;9720.368176068532;10251.231157663056;10268.897311026794;10315.27793054479;6707.262201157966;8371.790705232417;8405.831883362422;8519.318454523747;8520.914790852261;8304.70933517324;8310;8380.706675266336;8381.245687888118;8415.3267738582;7354.411647068328;7388.778336649909;7402.777916662509;7485.962570187115;7584.924150758642;7482.738104166328;7493.43799215072;7529.096508418806;7605.6577454015805;7627.694892204249;7060;7109.537880037781;7117;7125.287471252833;7184.353408193288;4858.732769697559;4866.0024694938165;4871.853844384674;4888.7311197884455;5005.649604527648;4934.284528743384;4999.850004499871;5002.924956125588;5046.823361182341;5098.133317336136 20:37:16 INFO - PROCESS | 1663 | |4;prototype.html;259.4823327461714;312.1960950552327;314.9732272756815;319.6611591712785;322.6563709649222;5123.641345105844;5423.945760542393;5426.565874730022;5435.293411856463;5446.727663616818;4425.181341451834;4496.61778748806;5343.465653434664;5395.649282796616;5476.5355589984465;3168.4930411134224;3876.7480113792653;3918.6473217410426;4069.491313585802;4113.958860411402;4054.2702313583545;4104.220198162339;4121.711480196387;4135.648469880064;4138.896527586804;3456.8962931112105;3999.2401443725744;4066.8169932353117;4071.5724848890886;4098;3479.495473156378;3848.672208088205;3943.3043791169785;4015.8594449194284;4106.917861642781;3302.85137168828;3444.9655503444897;3546.4325707886615;3552.609212986569;3564.376234159012;4271.572842715735;4368.716033457815;4757.548032936866;4764.8332308369045;5315.574754019708;4063.6139566741113;4079.8980025499304;4368.584984426506;4688.405941979743;4704.200285951362;4545.431821022372;5091.389033316026;5618.887622247573;5659.236003139565;5666.54667626593;3246.1722260823576;3268.4116858965376;3881.961180388188;3901.6878649707955;3905.902352441183;5194.818181363634;5202.375714914197;5534.308211473566;5694.946434909555;5969.253843269591;3273.738100951918;3597.892063238107;3639.909002274964;3906.460800479654;3935.665468435215;3990.042389826479;3995.7402768819934;4000.3999400089638;4000.959990400059;4011.338129208648;4678.929816052762;4688.835890743876;4704.553067458586;4713.2458806590785;4715.811367545329;4734.834280800155;5086.92369614456;5752.309722833287;5757.481826635623;5779.33537643168;1161.8373427720126;1329.2091205732575;1357.0839683213792;1362.2779926638898;1365.6995460998564;791.7189397763826;810.2707563193173;828.7154909889647;837.6146972392768;856.9185927336893;5128.333316668809;5263.684178949199;5274.129768588216;5276.3932147802725;5278.155495120763;4715.811367545329;4715.929261061086;5515.669059856422;5783.306003279633;5915.290165180206;4706.3411122442885;4882.974575339147;5348.7000589746;5370.812021579304;5390.97304513475;2882.769378449719;3037.2103253154337;3089.7837151399635;3099.178717639827;3131.264152924061;6038.365971573009;6091.299500557404;6106.923645960394;6152.354487570387;6153.353897840751;5268;5331.520163185254;5526.58550608706;6079.483243924227;6108.75564977396;6031;6091.939080609137;6102.267727872683;6118.235220597426;6124.693765311717;4603.838865639686;5667.574931880043;5907.409259074058;5953.851153721192;5974.984252677143;5063;5762.596618236683;5779.5611611091335;5841.883162336644;5873.298282789964;5057.393112826484;5590.049691552527;6069.393060693896;6110;6128.571000029955;2862.728040836117;2982.4482470742983;3212.903612891617;3442.1050526862696;3469.826508674607;4186.623203911662;4999.950000499948;5047.899042019066;5054.949450505448;5068.543831055223;4363.912721745611;4687.718736875799;4893.9021219576125;4907.2393778964315;4930.531599498042;4435.800388982568;4530.1007355293295;4531.320301954602;4567.145534041224;4574.634029277717;4515.638748900145;4589.862304130881;4655.44042745684;4840.8789780254365;4852.490488498657;4975.900481990412;5394.921015796778;5436.103042997861;5520.702634880719;5595.440455954372;4994.625403094855;5638;5656.577770448819;5659.603827732019;5664.376918538875 20:37:16 INFO - PROCESS | 1663 | |5;yui.html;698.87070891885;784.3372350363944;796.1242633103583;796.569852279769;848.3976376772491;15339.539813805575;15858.762118568216;16745;16757;16761.7485737714;15049.097054176757;15241.31414086366;15244.009139405931;15255.466058687949;15267.083974961482;690.4717890813532;716.5521549031855;865.273170536749;874.6894852327428;892.7187935800234;889.1375365895071;898.3846065445158;901.179926267097;903.661127077346;903.9096090390974;957.5786653872309;958.3531116496337;958.8369977103874;959.764857609883;960.4861399151455;735.3675838778646;907.4872696926216;928.5774972387547;953.0564740906522;958.1376760915232;709.0109297529968;709.2375696126633;710.2719712294887;711.2531841566387;711.2958171410319;15348.386064557404;15356.462523811724;15367.846321536754;15379.769303460456;15390.846091539053;14008.29958502081;14065.859341406558;14096.50662226817;14153;14224.502142424966;12848.743025139445;12910.289934053624;13025.609231723063;13131;13299.734005319839;4601.700889442175;4622;4700.130475861943;4790.353302304179;4793.496682848286;79250.6037469809;109553;109880;110199.44900275447;110400;11009.339439633648;11175.385353805455;11240.718982025515;11437.199396042364;11610.6516804496;22417;22429;22432.88783556072;22439.990200441018;22467.438314041952;7975.401844861659;8027.598620068973;8111.634976426075;8233.670653173926;8249.422540422112;4422.977885110554;4460.643148548108;4471.597556219956;4556.749378784132;4628.375169352162;3452.9654703453148;3529.936116476027;3557.2351944332095;3567.2687099144614;3573.1781690211396;641.0928536121429;652.1391762873056;652.422605993699;662.0929326822285;667.9398854103154;574.5030548575452;586.4575267877196;620.4951116248961;632.2602555010649;644.1207751419279;8685.956570217108;8769.693060742844;8850.20348168655;8882;8959.507227102442;609.9939000609937;623.3735096228262;625.9687015649199;632.424493710721;634.5399585300712;4217.304144816071;4269.978650106729;4275.786210689453;4278.251306021434;4338.674599405057;154424;156010.65984010248;157454;162023;164284.17857910634;131690;135572;138608.30695846456;140559;141785.29107354398;68212;100670;101763;101982;102301.74680784959;8077.959610201911;8222.712205072794;8232.464889782144;8316.6673333066;8510.148985101441;63590;65314;65444.67277663581;66109.00836487552;66772.66613666901;99101;100121.49939250258;100839;101761.49119254356;103464;10535;11600;11759.235649682743;11836.467358968695;12259.69350766238;10714.946425267824;12338.629841104781;12381.938090309492;12490.750184996068;12820.743585128059;10293.176545876462;10380.221483388625;10455;10584.735381615214;10651.840222396826;11297.322160670386;11614.883851161718;11619.302841829518;11984.700382490508;12122.393880306126;11706.414679265832;11756.764864702487;12133.817992729939;12228.633141005785;12264.938675306566;7884.093329266978;9657.46883921391;9833.213342932691;9915.157211637092;10106.039926206999;8051.275385215359;9197.448153110834;9240.95379523098;9646.228301735704;9669.274804389559 20:37:16 INFO - PROCESS | 1663 | __end_tp_report 20:37:16 INFO - PROCESS | 1663 | __start_cc_report 20:37:16 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,1500 20:37:16 INFO - PROCESS | 1663 | __end_cc_report 20:37:16 INFO - PROCESS | 1663 | __startTimestamp1468381036324__endTimestamp 20:37:16 INFO - PROCESS | 1663 | 20:37:16 INFO - PROCESS | 1663 | ------- Summary: start ------- 20:37:16 INFO - PROCESS | 1663 | Number of tests: 6 20:37:16 INFO - PROCESS | 1663 | 20:37:16 INFO - PROCESS | 1663 | [#0] dojo.html Cycles:165 Average:5757.24 Median:6000.00 stddev:629.67 (10.5%) stddev-sans-first:603.04 20:37:16 INFO - PROCESS | 1663 | Values: 3367.2 3373.9 3397.1 3415.8 3455.7 5607.1 5705.6 5738.6 5754.7 5787.7 5673.3 5728.9 5734.1 5739.1 5742.6 5168.1 5195.2 5205.0 5247.6 5303.4 5230.2 5247.9 5255.0 5257.4 5259.0 5211.9 5213.4 5238.9 5247.2 5260.6 5311.6 5316.9 5319.8 5323.0 5342.7 5137.7 5138.0 5142.4 5252.5 5261.8 5694.9 5725.5 5747.7 5769.9 5774.2 6291.8 6297.4 6309.4 6322.2 6325.0 6115.9 6205.9 6245.1 6255.4 6289.2 5858.6 5883.9 5896.0 5917.3 5923.9 5530.7 6273.7 6278.4 6280.5 6281.2 6060.5 6084.6 6084.8 6115.4 6240.6 6190.4 6193.3 6259.0 6262.8 6281.2 6289.7 6300.4 6301.3 6304.1 6319.1 6233.6 6267.2 6291.3 6315.1 6326.9 4897.3 4938.9 4942.6 4955.5 4994.6 4443.9 4458.1 4462.5 4474.0 4492.8 5651.1 5757.8 5790.4 5795.4 5855.1 5165.8 6230.1 6275.1 6276.5 6280.8 5766.1 5780.3 5833.3 5834.7 5900.7 5436.6 5457.1 5458.6 5464.3 5497.1 5414.6 6224.6 6295.6 6297.7 6325.7 6126.8 6173.5 6181.8 6186.9 6229.7 6167.2 6174.6 6176.9 6215.8 6230.9 6191.1 6205.9 6206.4 6206.6 6227.3 5098.6 6154.1 6290.9 6296.8 6300.6 6020.5 6102.3 6120.4 6149.3 6155.3 6171.5 6190.8 6201.6 6205.1 6207.1 5973.9 6000.0 6029.1 6054.7 6110.8 6011.9 6066.6 6088.3 6097.2 6100.8 5995.6 5995.7 6015.8 6088.0 6100.4 20:37:16 INFO - PROCESS | 1663 | 20:37:16 INFO - PROCESS | 1663 | [#1] ext.html Cycles:180 Average:81132.72 Median:36712.27 stddev:192845.47 (525.3%) stddev-sans-first:193291.40 20:37:16 INFO - PROCESS | 1663 | Values: 486.9 512.6 515.1 518.4 569.3 30165.2 31617.1 31627.8 31712.5 40660.8 33275.2 43340.0 43406.6 43495.8 43497.3 9672.7 9854.7 9866.1 9868.1 9873.0 8522.6 8719.5 8723.7 9704.9 9813.9 8903.1 8952.8 11757.8 11960.3 12081.6 12008.9 12046.3 12055.6 12064.2 12094.5 11947.5 12032.6 12037.6 12041.3 12044.2 31363.7 40046.6 40702.0 40833.6 42740.8 3540.7 3594.1 3604.2 3738.3 3937.2 32004.5 32723.5 32979.7 32993.0 33048.0 3277.1 3302.0 3304.8 3322.3 3446.2 548478.0 550101.0 551043.0 551615.0 552890.0 53343.2 61734.7 63330.7 63372.0 63639.7 66747.7 67113.7 67176.3 67251.0 67261.0 16850.2 17027.6 17030.7 17042.6 17058.4 11918.0 12211.2 12837.2 12975.2 13133.3 14056.9 18034.9 19398.2 19566.9 19684.1 6772.0 7026.7 8061.8 8099.4 8218.9 879.9 942.0 976.3 1034.6 1121.5 30434.4 30692.5 31487.4 31578.5 31648.0 1015.1 1061.9 1081.1 1083.9 1094.7 15417.7 15502.8 15565.6 15640.5 15870.0 694465.0 705739.0 711806.0 712242.0 713940.0 49055.8 49915.0 56698.4 57918.1 58102.0 1425.1 1440.6 1448.3 1450.4 1456.5 29256.0 30819.4 30843.8 30879.0 31597.4 51196.0 51351.0 52083.0 52167.5 52167.5 552211.0 827781.0 939194.0 939442.0 952630.0 25891.9 26150.7 26157.1 26167.7 26180.1 45083.0 46280.3 46747.8 46776.0 46798.5 35959.6 37521.8 37924.1 38135.3 38792.6 37638.4 37667.4 37791.8 38426.8 38487.0 36502.3 36922.3 37318.3 37344.4 37533.0 26144.6 31307.5 33232.8 33628.5 33916.8 24698.1 24754.0 24765.6 24780.6 24961.9 20:37:16 INFO - PROCESS | 1663 | 20:37:16 INFO - PROCESS | 1663 | [#2] jquery.html Cycles:180 Average:35182.80 Median:12839.47 stddev:95203.87 (741.5%) stddev-sans-first:95434.98 20:37:16 INFO - PROCESS | 1663 | Values: 328.8 360.9 387.8 393.6 410.3 12755.9 15965.8 21373.0 21786.9 21825.3 17051.6 21377.3 21381.3 21515.0 21761.6 5359.9 5872.5 6131.6 6149.6 6153.7 5212.2 6013.7 6077.6 6117.7 6127.6 5808.2 6087.0 6098.8 6141.6 6150.1 6076.2 6089.2 6116.9 6125.2 6136.7 5794.8 5966.3 5966.8 5967.9 5994.3 16226.0 21805.6 23277.4 26311.5 26352.7 2239.7 2401.5 2468.2 2508.3 2554.1 10040.3 10088.2 10194.5 10565.7 10586.2 1900.7 1904.6 1905.9 1931.9 1939.7 122024.4 128555.0 132911.3 133214.0 133670.3 11539.7 11602.6 11771.2 11800.7 12001.8 14550.0 14726.5 14749.2 14755.4 14778.8 8602.9 8722.5 8742.2 8798.6 8834.1 8743.0 8747.5 8761.6 8873.9 8881.3 4525.3 4583.2 4604.5 4612.3 4634.8 1812.1 1909.7 1954.5 1954.7 1994.2 721.5 892.6 946.3 990.6 1020.4 18654.3 21722.0 21796.7 21850.5 21906.7 833.2 930.6 963.7 970.2 972.6 9116.0 10963.5 11514.3 11542.4 11563.6 516976.0 521926.0 523575.0 614906.0 623859.0 136035.0 145889.0 146753.0 148179.0 151275.0 976.4 991.9 1015.9 1030.4 1035.5 19529.4 19787.9 19852.1 19874.5 19884.9 58075.7 58774.8 61241.4 61424.4 61692.8 80601.0 83851.6 84914.6 85032.1 86260.0 4265.4 5941.0 6271.5 7472.3 7729.4 10866.3 11927.6 12544.6 12767.9 12904.7 11054.0 11331.8 11624.7 11720.2 11983.2 7935.7 11404.9 11670.9 11784.2 12020.5 8069.1 8249.8 8271.2 8354.0 8519.7 11566.7 12505.3 12742.9 12798.4 12965.9 11853.8 11884.6 12036.7 12090.8 12124.8 20:37:16 INFO - PROCESS | 1663 | 20:37:16 INFO - PROCESS | 1663 | [#3] mootools.html Cycles:180 Average:5710.28 Median:4716.10 stddev:3234.46 (68.6%) stddev-sans-first:3228.28 20:37:16 INFO - PROCESS | 1663 | Values: 1530.4 1568.5 1798.3 1934.6 1956.1 8505.6 8853.8 9014.3 9031.0 9042.3 7840.6 8058.6 8480.0 8695.5 8812.5 2360.5 2387.9 2391.6 2393.2 2404.4 2364.5 2369.0 2402.7 2403.8 2406.6 2080.9 2154.4 2299.0 2354.8 2370.7 2111.4 2360.4 2380.3 2381.4 2384.5 2300.7 2319.6 2346.4 2347.4 2354.2 8842.0 8893.2 8906.4 8914.5 8916.8 5211.7 5377.0 5390.4 5419.4 5443.9 3528.5 3539.6 3541.3 3544.7 3590.3 1054.0 1110.8 1111.1 1784.7 1859.4 11726.4 11793.8 11803.2 11810.2 11840.4 4293.2 4319.0 4443.2 4451.3 4573.5 9162.5 9201.7 9217.6 9219.6 9220.7 5260.0 5260.5 5269.3 5271.7 5296.0 3737.0 4407.8 4547.8 4552.5 4949.7 3486.6 3653.5 3762.0 3821.1 3880.2 1137.5 1157.3 1168.2 1169.5 1174.4 833.6 891.6 925.4 936.8 946.7 5975.9 6003.2 6011.3 6023.2 6093.8 402.3 431.8 437.2 450.9 456.6 3514.1 3628.0 3925.2 3955.6 4091.5 10353.1 10834.1 10850.1 10864.4 10878.8 10465.3 10822.7 10907.4 10910.0 10910.9 7904.6 8317.5 8334.6 8403.2 8412.6 6010.9 6046.8 6048.8 6130.0 6160.9 9839.9 10165.2 10179.2 10202.6 10239.3 9155.1 9720.4 10251.2 10268.9 10315.3 6707.3 8371.8 8405.8 8519.3 8520.9 8304.7 8310.0 8380.7 8381.2 8415.3 7354.4 7388.8 7402.8 7486.0 7584.9 7482.7 7493.4 7529.1 7605.7 7627.7 7060.0 7109.5 7117.0 7125.3 7184.4 4858.7 4866.0 4871.9 4888.7 5005.6 4934.3 4999.9 5002.9 5046.8 5098.1 20:37:16 INFO - PROCESS | 1663 | 20:37:16 INFO - PROCESS | 1663 | [#4] prototype.html Cycles:180 Average:4446.71 Median:4746.19 stddev:1396.67 (29.4%) stddev-sans-first:1364.77 20:37:16 INFO - PROCESS | 1663 | Values: 259.5 312.2 315.0 319.7 322.7 5123.6 5423.9 5426.6 5435.3 5446.7 4425.2 4496.6 5343.5 5395.6 5476.5 3168.5 3876.7 3918.6 4069.5 4114.0 4054.3 4104.2 4121.7 4135.6 4138.9 3456.9 3999.2 4066.8 4071.6 4098.0 3479.5 3848.7 3943.3 4015.9 4106.9 3302.9 3445.0 3546.4 3552.6 3564.4 4271.6 4368.7 4757.5 4764.8 5315.6 4063.6 4079.9 4368.6 4688.4 4704.2 4545.4 5091.4 5618.9 5659.2 5666.5 3246.2 3268.4 3882.0 3901.7 3905.9 5194.8 5202.4 5534.3 5694.9 5969.3 3273.7 3597.9 3639.9 3906.5 3935.7 3990.0 3995.7 4000.4 4001.0 4011.3 4678.9 4688.8 4704.6 4713.2 4715.8 4734.8 5086.9 5752.3 5757.5 5779.3 1161.8 1329.2 1357.1 1362.3 1365.7 791.7 810.3 828.7 837.6 856.9 5128.3 5263.7 5274.1 5276.4 5278.2 4715.8 4715.9 5515.7 5783.3 5915.3 4706.3 4883.0 5348.7 5370.8 5391.0 2882.8 3037.2 3089.8 3099.2 3131.3 6038.4 6091.3 6106.9 6152.4 6153.4 5268.0 5331.5 5526.6 6079.5 6108.8 6031.0 6091.9 6102.3 6118.2 6124.7 4603.8 5667.6 5907.4 5953.9 5975.0 5063.0 5762.6 5779.6 5841.9 5873.3 5057.4 5590.0 6069.4 6110.0 6128.6 2862.7 2982.4 3212.9 3442.1 3469.8 4186.6 5000.0 5047.9 5054.9 5068.5 4363.9 4687.7 4893.9 4907.2 4930.5 4435.8 4530.1 4531.3 4567.1 4574.6 4515.6 4589.9 4655.4 4840.9 4852.5 4975.9 5394.9 5436.1 5520.7 5595.4 4994.6 5638.0 5656.6 5659.6 5664.4 20:37:16 INFO - PROCESS | 1663 | 20:37:16 INFO - PROCESS | 1663 | [#5] yui.html Cycles:180 Average:24871.78 Median:4277.02 stddev:40749.16 (952.7%) stddev-sans-first:40823.05 20:37:16 INFO - PROCESS | 1663 | Values: 698.9 784.3 796.1 796.6 848.4 15339.5 15858.8 16745.0 16757.0 16761.7 15049.1 15241.3 15244.0 15255.5 15267.1 690.5 716.6 865.3 874.7 892.7 889.1 898.4 901.2 903.7 903.9 957.6 958.4 958.8 959.8 960.5 735.4 907.5 928.6 953.1 958.1 709.0 709.2 710.3 711.3 711.3 15348.4 15356.5 15367.8 15379.8 15390.8 14008.3 14065.9 14096.5 14153.0 14224.5 12848.7 12910.3 13025.6 13131.0 13299.7 4601.7 4622.0 4700.1 4790.4 4793.5 79250.6 109553.0 109880.0 110199.4 110400.0 11009.3 11175.4 11240.7 11437.2 11610.7 22417.0 22429.0 22432.9 22440.0 22467.4 7975.4 8027.6 8111.6 8233.7 8249.4 4423.0 4460.6 4471.6 4556.7 4628.4 3453.0 3529.9 3557.2 3567.3 3573.2 641.1 652.1 652.4 662.1 667.9 574.5 586.5 620.5 632.3 644.1 8686.0 8769.7 8850.2 8882.0 8959.5 610.0 623.4 626.0 632.4 634.5 4217.3 4270.0 4275.8 4278.3 4338.7 154424.0 156010.7 157454.0 162023.0 164284.2 131690.0 135572.0 138608.3 140559.0 141785.3 68212.0 100670.0 101763.0 101982.0 102301.7 8078.0 8222.7 8232.5 8316.7 8510.1 63590.0 65314.0 65444.7 66109.0 66772.7 99101.0 100121.5 100839.0 101761.5 103464.0 10535.0 11600.0 11759.2 11836.5 12259.7 10714.9 12338.6 12381.9 12490.8 12820.7 10293.2 10380.2 10455.0 10584.7 10651.8 11297.3 11614.9 11619.3 11984.7 12122.4 11706.4 11756.8 12133.8 12228.6 12264.9 7884.1 9657.5 9833.2 9915.2 10106.0 8051.3 9197.4 9241.0 9646.2 9669.3 20:37:16 INFO - PROCESS | 1663 | -------- Summary: end -------- 20:37:16 INFO - PROCESS | 1663 | 20:37:16 INFO - TEST-INFO | 1663: exit 0 20:37:16 INFO - TEST-OK | dromaeo_css | took 1118591ms 20:37:16 INFO - TEST-START | kraken 20:37:16 INFO - operating with platform_type : mac_ 20:37:16 INFO - Initialising browser for kraken test... 20:37:16 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/tmpPmdvPP/profile http://localhost:49268/getInfo.html) 20:37:19 INFO - PROCESS | 1670 | __metrics Screen width/height:1600/1200 20:37:19 INFO - PROCESS | 1670 | colorDepth:24 20:37:19 INFO - PROCESS | 1670 | Browser inner width/height: 1024/689 20:37:19 INFO - PROCESS | 1670 | __metrics 20:37:19 INFO - PROCESS | 1670 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:37:19 INFO - PROCESS | 1670 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:37:20 INFO - TEST-INFO | 1670: exit 0 20:37:20 INFO - Browser initialized. 20:37:20 INFO - Running cycle 1/1 for kraken test... 20:37:20 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/tmpPmdvPP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:37:32 INFO - PROCESS | 1671 | RSS: Main: 243859456 20:37:32 INFO - PROCESS | 1671 | 20:37:34 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-beat-detection) 20:37:35 INFO - PROCESS | 1671 | RSS: Main: 294133760 20:37:35 INFO - PROCESS | 1671 | 20:37:38 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-dft) 20:37:38 INFO - PROCESS | 1671 | RSS: Main: 304603136 20:37:38 INFO - PROCESS | 1671 | 20:37:42 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-fft) 20:37:43 INFO - PROCESS | 1671 | RSS: Main: 386428928 20:37:43 INFO - PROCESS | 1671 | 20:37:44 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-oscillator) 20:37:45 INFO - PROCESS | 1671 | RSS: Main: 289775616 20:37:45 INFO - PROCESS | 1671 | 20:37:47 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:37:48 INFO - PROCESS | 1671 | RSS: Main: 293810176 20:37:48 INFO - PROCESS | 1671 | 20:37:51 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-darkroom) 20:37:51 INFO - PROCESS | 1671 | RSS: Main: 332480512 20:37:51 INFO - PROCESS | 1671 | 20:37:54 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-desaturate) 20:37:55 INFO - PROCESS | 1671 | RSS: Main: 332140544 20:37:55 INFO - PROCESS | 1671 | 20:37:58 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49268/tests/kraken/driver.html?testName=json-parse-financial) 20:37:58 INFO - PROCESS | 1671 | RSS: Main: 331055104 20:37:58 INFO - PROCESS | 1671 | 20:38:00 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49268/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:38:00 INFO - PROCESS | 1671 | RSS: Main: 313364480 20:38:00 INFO - PROCESS | 1671 | 20:38:02 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:38:03 INFO - PROCESS | 1671 | RSS: Main: 320299008 20:38:03 INFO - PROCESS | 1671 | 20:38:05 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:38:06 INFO - PROCESS | 1671 | RSS: Main: 318029824 20:38:06 INFO - PROCESS | 1671 | 20:38:09 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:38:09 INFO - PROCESS | 1671 | RSS: Main: 327340032 20:38:09 INFO - PROCESS | 1671 | 20:38:12 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:38:13 INFO - PROCESS | 1671 | RSS: Main: 329859072 20:38:13 INFO - PROCESS | 1671 | 20:38:15 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49268/tests/kraken/driver.html?testName=ai-astar) 20:38:15 INFO - PROCESS | 1671 | RSS: Main: 373231616 20:38:15 INFO - PROCESS | 1671 | 20:38:15 INFO - PROCESS | 1671 | __start_tp_report 20:38:15 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 20:38:15 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 20:38:15 INFO - PROCESS | 1671 | |i|pagename|runs| 20:38:15 INFO - PROCESS | 1671 | |0;ai-astar;102;112;113;114;114;112;114;112;112;113 20:38:15 INFO - PROCESS | 1671 | |1;audio-beat-detection;141;107;105;155;106;101;129;130;156;105 20:38:15 INFO - PROCESS | 1671 | |2;audio-dft;183;183;183;194;254;188;184;182;184;180 20:38:15 INFO - PROCESS | 1671 | |3;audio-fft;78;73;58;106;56;57;62;59;97;56 20:38:15 INFO - PROCESS | 1671 | |4;audio-oscillator;84;95;92;100;70;68;96;69;67;101 20:38:15 INFO - PROCESS | 1671 | |5;imaging-gaussian-blur;86;123;94;95;86;71;131;94;86;83 20:38:15 INFO - PROCESS | 1671 | |6;imaging-darkroom;93;93;93;93;105;148;94;94;95;92 20:38:15 INFO - PROCESS | 1671 | |7;imaging-desaturate;86;83;85;86;86;84;86;84;86;84 20:38:15 INFO - PROCESS | 1671 | |8;json-parse-financial;57;56;58;55;54;54;56;54;53;54 20:38:15 INFO - PROCESS | 1671 | |9;json-stringify-tinderbox;65;73;72;79;72;71;72;72;72;73 20:38:15 INFO - PROCESS | 1671 | |10;stanford-crypto-aes;80;82;82;85;82;84;84;80;83;84 20:38:15 INFO - PROCESS | 1671 | |11;stanford-crypto-ccm;134;143;148;152;141;129;136;147;240;136 20:38:15 INFO - PROCESS | 1671 | |12;stanford-crypto-pbkdf2;162;162;159;162;159;165;162;164;162;159 20:38:15 INFO - PROCESS | 1671 | |13;stanford-crypto-sha256-iterative;68;85;84;83;85;84;66;65;65;66 20:38:15 INFO - PROCESS | 1671 | __end_tp_report 20:38:15 INFO - PROCESS | 1671 | __start_cc_report 20:38:15 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,1988 20:38:15 INFO - PROCESS | 1671 | __end_cc_report 20:38:15 INFO - PROCESS | 1671 | __startTimestamp1468381095302__endTimestamp 20:38:15 INFO - PROCESS | 1671 | 20:38:15 INFO - PROCESS | 1671 | ------- Summary: start ------- 20:38:15 INFO - PROCESS | 1671 | Number of tests: 14 20:38:15 INFO - PROCESS | 1671 | 20:38:15 INFO - PROCESS | 1671 | [#0] ai-astar Cycles:10 Average:111.80 Median:113.00 stddev:3.55 (3.1%) stddev-sans-first:0.93 20:38:15 INFO - PROCESS | 1671 | Values: 102.0 112.0 113.0 114.0 114.0 112.0 114.0 112.0 112.0 113.0 20:38:15 INFO - PROCESS | 1671 | 20:38:15 INFO - PROCESS | 1671 | [#1] audio-beat-detection Cycles:10 Average:123.50 Median:129.50 stddev:21.59 (16.7%) stddev-sans-first:21.96 20:38:15 INFO - PROCESS | 1671 | Values: 141.0 107.0 105.0 155.0 106.0 101.0 129.0 130.0 156.0 105.0 20:38:15 INFO - PROCESS | 1671 | 20:38:15 INFO - PROCESS | 1671 | [#2] audio-dft Cycles:10 Average:191.50 Median:184.00 stddev:22.30 (12.1%) stddev-sans-first:23.44 20:38:15 INFO - PROCESS | 1671 | Values: 183.0 183.0 183.0 194.0 254.0 188.0 184.0 182.0 184.0 180.0 20:38:15 INFO - PROCESS | 1671 | 20:38:15 INFO - PROCESS | 1671 | [#3] audio-fft Cycles:10 Average:70.20 Median:60.50 stddev:18.22 (30.1%) stddev-sans-first:19.10 20:38:15 INFO - PROCESS | 1671 | Values: 78.0 73.0 58.0 106.0 56.0 57.0 62.0 59.0 97.0 56.0 20:38:15 INFO - PROCESS | 1671 | 20:38:15 INFO - PROCESS | 1671 | [#4] audio-oscillator Cycles:10 Average:84.20 Median:77.00 stddev:14.30 (18.6%) stddev-sans-first:15.16 20:38:15 INFO - PROCESS | 1671 | Values: 84.0 95.0 92.0 100.0 70.0 68.0 96.0 69.0 67.0 101.0 20:38:15 INFO - PROCESS | 1671 | 20:38:15 INFO - PROCESS | 1671 | [#5] imaging-gaussian-blur Cycles:10 Average:94.90 Median:86.00 stddev:18.39 (21.4%) stddev-sans-first:19.23 20:38:15 INFO - PROCESS | 1671 | Values: 86.0 123.0 94.0 95.0 86.0 71.0 131.0 94.0 86.0 83.0 20:38:15 INFO - PROCESS | 1671 | 20:38:15 INFO - PROCESS | 1671 | [#6] imaging-darkroom Cycles:10 Average:100.00 Median:93.00 stddev:17.28 (18.6%) stddev-sans-first:18.14 20:38:15 INFO - PROCESS | 1671 | Values: 93.0 93.0 93.0 93.0 105.0 148.0 94.0 94.0 95.0 92.0 20:38:15 INFO - PROCESS | 1671 | 20:38:15 INFO - PROCESS | 1671 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:86.00 stddev:1.15 (1.3%) stddev-sans-first:1.17 20:38:15 INFO - PROCESS | 1671 | Values: 86.0 83.0 85.0 86.0 86.0 84.0 86.0 84.0 86.0 84.0 20:38:15 INFO - PROCESS | 1671 | 20:38:15 INFO - PROCESS | 1671 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:55.50 stddev:1.60 (2.9%) stddev-sans-first:1.54 20:38:15 INFO - PROCESS | 1671 | Values: 57.0 56.0 58.0 55.0 54.0 54.0 56.0 54.0 53.0 54.0 20:38:15 INFO - PROCESS | 1671 | 20:38:15 INFO - PROCESS | 1671 | [#9] json-stringify-tinderbox Cycles:10 Average:72.10 Median:72.00 stddev:3.35 (4.7%) stddev-sans-first:2.37 20:38:15 INFO - PROCESS | 1671 | Values: 65.0 73.0 72.0 79.0 72.0 71.0 72.0 72.0 72.0 73.0 20:38:15 INFO - PROCESS | 1671 | 20:38:15 INFO - PROCESS | 1671 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:83.50 stddev:1.71 (2.1%) stddev-sans-first:1.54 20:38:15 INFO - PROCESS | 1671 | Values: 80.0 82.0 82.0 85.0 82.0 84.0 84.0 80.0 83.0 84.0 20:38:15 INFO - PROCESS | 1671 | 20:38:15 INFO - PROCESS | 1671 | [#11] stanford-crypto-ccm Cycles:10 Average:150.60 Median:145.00 stddev:32.20 (22.2%) stddev-sans-first:33.59 20:38:15 INFO - PROCESS | 1671 | Values: 134.0 143.0 148.0 152.0 141.0 129.0 136.0 147.0 240.0 136.0 20:38:15 INFO - PROCESS | 1671 | 20:38:15 INFO - PROCESS | 1671 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.60 Median:162.00 stddev:2.07 (1.3%) stddev-sans-first:2.19 20:38:15 INFO - PROCESS | 1671 | Values: 162.0 162.0 159.0 162.0 159.0 165.0 162.0 164.0 162.0 159.0 20:38:15 INFO - PROCESS | 1671 | 20:38:15 INFO - PROCESS | 1671 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.10 Median:83.50 stddev:9.64 (11.5%) stddev-sans-first:9.88 20:38:15 INFO - PROCESS | 1671 | Values: 68.0 85.0 84.0 83.0 85.0 84.0 66.0 65.0 65.0 66.0 20:38:15 INFO - PROCESS | 1671 | -------- Summary: end -------- 20:38:15 INFO - PROCESS | 1671 | 20:38:16 INFO - TEST-INFO | 1671: exit 0 20:38:16 INFO - TEST-OK | kraken | took 59262ms 20:38:16 INFO - SUITE-END | took 1177s 20:38:16 INFO - Completed test suite (00:19:38) 20:38:16 INFO - javascript benchmark 20:38:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3367.158210447388, 3373.881914133006, 3397.116749645093, 3415.7608967372294, 3455.688987991082, 5607.102863541834, 5705.5720820938495, 5738.598298119134, 5754.683492407916, 5787.739551720178, 5673.290838645169, 5728.942710572893, 5734.139879018139, 5739.139129130633, 5742.569307301948, 5168.121419358718, 5195.168772996321, 5204.985027919557, 5247.606429517801, 5303.390110137326, 5230.21546767984, 5247.86880327991, 5255.027819853321, 5257.421683614799, 5259.0, 5211.947880521203, 5213.4004589472315, 5238.869028274305, 5247.23915032322, 5260.631755777097, 5311.62818602698, 5316.946830531703, 5319.780938450104, 5322.988632159916, 5342.706151161685, 5137.666051706665, 5137.974310128463, 5142.357205349332, 5252.527272545451, 5261.789528418859, 5694.9430505695245, 5725.484706376405, 5747.655140691572, 5769.884602307972, 5774.249347584829, 6291.7797877074545, 6297.4017468340435, 6309.400606942333, 6322.241331040259, 6324.968375158141, 6115.908261376083, 6205.906911396332, 6245.063240513914, 6255.374462553754, 6289.182406287154, 5858.619189752652, 5883.941160588425, 5895.970520147458, 5917.289925209003, 5923.940760592425, 5530.723463826793, 6273.749050038039, 6278.372162783685, 6280.528960327993, 6281.183446151971, 6060.454559089703, 6084.6178027713395, 6084.824809662311, 6115.362036198677, 6240.563160578807, 6190.442860142519, 6193.256809182927, 6259.0, 6262.780802671885, 6281.246250449975, 6289.654069026247, 6300.369963003663, 6301.306856245809, 6304.117423560705, 6319.146915166486, 6233.563650544418, 6267.247930248308, 6291.339409362043, 6315.115883776275, 6326.905096423558, 4897.314375987365, 4938.876528086755, 4942.604591632661, 4955.5044495550155, 4994.600431965434, 4443.888902777392, 4458.063806600585, 4462.531434199363, 4473.977630111829, 4492.775361231926, 5651.12407576818, 5757.798477053283, 5790.449907258803, 5795.362510123883, 5855.092460668603, 5165.845024649267, 6230.065490176419, 6275.090111933744, 6276.466500347522, 6280.780172693934, 5766.135079737989, 5780.277465316835, 5833.329167145833, 5834.679092649945, 5900.734466948998, 5436.592255580847, 5457.099578569491, 5458.590605704588, 5464.26232458621, 5497.147942068986, 5414.648047876875, 6224.62652240867, 6295.5907865988565, 6297.748090076529, 6325.683715814099, 6126.761967422386, 6173.475254603409, 6181.81454556364, 6186.876262474815, 6229.657368844576, 6167.167432396748, 6174.629522228681, 6176.907346389898, 6215.751369945152, 6230.906536402048, 6191.102290167991, 6205.937940620536, 6206.379362063938, 6206.627602343874, 6227.346128656426, 5098.643094983316, 6154.138420621027, 6290.937090629035, 6296.842578935563, 6300.62196268207, 6020.488258498077, 6102.307478454246, 6120.387961203844, 6149.323574406722, 6155.292141403616, 6171.537134714825, 6190.845228869314, 6201.565890387629, 6205.131281620486, 6207.131001659862, 5973.910391344047, 6000.0, 6029.141349536388, 6054.697265136638, 6110.7861224856915, 6011.87976240464, 6066.636001839904, 6088.330283668704, 6097.161734506546, 6100.847478812888, 5995.640261584319, 5995.700214989321, 6015.849603759941, 6088.025915853442, 6100.389961003864], "value": 5718.2719750596625, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [486.8977514721908, 512.5668809855672, 515.1088616693121, 518.3934796288343, 569.2514343638114, 30165.24586885326, 31617.051488455356, 31627.841860790722, 31712.524312135338, 40660.79669601655, 33275.16812079693, 43340.0, 43406.565934340644, 43495.78252108735, 43497.347539786926, 9672.661456849011, 9854.655087071955, 9866.112049915506, 9868.111869931705, 9872.950635246814, 8522.616482258314, 8719.520426376546, 8723.651053957834, 9704.90295097047, 9813.90186098137, 8903.109689031078, 8952.776180595472, 11757.7648447031, 11960.342181180074, 12081.637550873444, 12008.919197272244, 12046.277223366582, 12055.57805476804, 12064.155509114365, 12094.516219351215, 11947.522099116024, 12032.639020829389, 12037.578684745991, 12041.277523348626, 12044.217125886877, 31363.686363136534, 40046.59953400487, 40702.0, 40833.59166408327, 42740.78629606863, 3540.6636369544854, 3594.0655429588232, 3604.2431089471243, 3738.3084129436143, 3937.153511994935, 32004.519932201034, 32723.50914736281, 32979.6702032979, 32993.0, 33048.0, 3277.0987978305916, 3302.0, 3304.7851889627095, 3322.335532893431, 3446.172918499542, 548478.0, 550101.0, 551043.0, 551615.0, 552890.0, 53343.19985200225, 61734.69132654308, 63330.68334658389, 63372.0, 63639.6818015907, 66747.66626166838, 67113.66443167753, 67176.328236717, 67251.0, 67261.0, 16850.15749212559, 17027.574310642332, 17030.659386812444, 17042.57393565146, 17058.402955896483, 11918.04655627565, 12211.206271592318, 12837.165584236995, 12975.156614820007, 13133.34333283332, 14056.929715351358, 18034.909825450788, 19398.224071037283, 19566.902165489082, 19684.114214860365, 6771.966140169267, 7026.718931242693, 8061.83876322482, 8099.352051835839, 8218.917810821815, 879.9032106468284, 941.9952900235455, 976.3409698453515, 1034.622362837559, 1121.472907733364, 30434.391312173633, 30692.53961190584, 31487.37025259482, 31578.526322105186, 31648.0, 1015.1219195395929, 1061.856649352343, 1081.0756802933536, 1083.9295445796, 1094.715374002765, 15417.691646167239, 15502.767458488132, 15565.610859728597, 15640.4525841595, 15870.0, 694465.0, 705739.0, 711806.0, 712242.0, 713940.0, 49055.75472122688, 49915.0, 56698.43301566932, 57918.13122803161, 58102.0, 1425.0665813891917, 1440.5822311529748, 1448.3265281644085, 1450.3980847947983, 1456.4538298138198, 29256.0, 30819.38361232718, 30843.84578077185, 30879.0, 31597.368052638358, 51196.0, 51351.0, 52083.0, 52167.47832521626, 52167.47832521626, 552211.0, 827781.0, 939194.0, 939442.0, 952630.0, 25891.870540647174, 26150.73849261483, 26157.084502042337, 26167.738322617293, 26180.08369707051, 45083.0, 46280.30579541377, 46747.76626116984, 46776.0, 46798.53201467942, 35959.64040359668, 37521.81239093896, 37924.05189870275, 38135.279708044014, 38792.6120738789, 37638.43542346812, 37667.43498847465, 37791.811040944616, 38426.80786596161, 38487.0, 36502.26995460129, 36922.261554768214, 37318.25363492661, 37344.43983340198, 37533.0, 26144.60783088217, 31307.53038704467, 33232.833835830665, 33628.49557256692, 33916.83041584776, 24698.13556525585, 24754.009839606213, 24765.62851557264, 24780.628290576016, 24961.875190624658], "value": 20610.682080332415, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.8306522141097, 360.9133807886105, 387.7692772800184, 393.64571885303206, 410.2717676124878, 12755.936220318898, 15965.84034159658, 21373.0, 21786.910654467254, 21825.345239642797, 17051.57371065724, 21377.251796187098, 21381.251656192035, 21515.0, 21761.564768704615, 5359.892802143955, 5872.471477567018, 6131.570790044699, 6149.600275982069, 6153.692315384235, 5212.1660534314515, 6013.699315034252, 6077.574569780095, 6117.66352850593, 6127.601705889125, 5808.186853840466, 6086.969565152168, 6098.786542471014, 6141.570090093695, 6150.077488376734, 6076.179715738407, 6089.208402907616, 6116.908246376286, 6125.234345706786, 6136.693165341738, 5794.797182098649, 5966.254218222723, 5966.761329546813, 5967.910481342783, 5994.340622531518, 16226.026438413734, 21805.563888722296, 23277.418064548354, 26311.47377052448, 26352.73647263522, 2239.73123225214, 2401.5317013182434, 2468.2471846086937, 2508.325303430483, 2554.1443616388533, 10040.29717919746, 10088.243381746399, 10194.541245643964, 10565.683029509128, 10586.20603454744, 1900.7148927660962, 1904.628597423489, 1905.876118052336, 1931.874428162165, 1939.679952807785, 122024.38987805093, 128555.0, 132911.33544332313, 133214.0, 133670.33164834115, 11539.711507212387, 11602.593909213307, 11771.176017678852, 11800.701922788487, 12001.759964800654, 14550.0, 14726.484573039892, 14749.188794616399, 14755.40978360875, 14778.778318325234, 8602.87095693565, 8722.520261385558, 8742.213200811957, 8798.560071996375, 8834.116588341114, 8743.038265790758, 8747.51888646118, 8761.605727742266, 8873.866891996626, 8881.333899957399, 4525.253333199985, 4583.243764778841, 4604.493505714368, 4612.331211974245, 4634.814607415733, 1812.1392338639305, 1909.6562618728485, 1954.5309125809704, 1954.6677064899002, 1994.1524851937868, 721.4949535325188, 892.5983307511646, 946.2666433513945, 990.6186118344489, 1020.3622735790132, 18654.34709785151, 21722.0, 21796.673049904264, 21850.453738656342, 21906.671399929015, 833.2251006563954, 930.5998420679038, 963.6819849449665, 970.1753509516855, 972.6206779356057, 9115.951665558414, 10963.50664220112, 11514.30914145154, 11542.422878856023, 11563.595274165533, 516976.0, 521926.0, 523575.0, 614906.0, 623859.0, 136035.0, 145889.0, 146753.0, 148179.0, 151275.0, 976.3653625143571, 991.8561808537721, 1015.8831734350497, 1030.4332617060586, 1035.4563853976722, 19529.414117576496, 19787.901060494605, 19852.106655200263, 19874.50313742168, 19884.90057549703, 58075.70962145162, 58774.82450351054, 61241.38758612357, 61424.38575614187, 61692.76614467775, 80601.0, 83851.5807420959, 84914.57542712247, 85032.14967850242, 86260.0, 4265.42416773744, 5941.0197317442135, 6271.4669253114, 7472.29013243741, 7729.381649467917, 10866.348019118877, 11927.582534611247, 12544.560940367044, 12767.93616031914, 12904.677383065124, 11053.984575835528, 11331.773364532828, 11624.6512604622, 11720.238184517979, 11983.161178717755, 7935.682572697027, 11404.94297528507, 11670.88329116732, 11784.175107742376, 12020.459079341275, 8069.112397636372, 8249.79375515617, 8271.172882711922, 8354.039285482248, 8519.74440766778, 11566.65300041, 12505.312207828656, 12742.87257127454, 12798.360081996048, 12965.935170324088, 11853.76292474163, 11884.584039558575, 12036.699082522657, 12090.758184836079, 12124.818127728267], "value": 9731.793419182752, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1530.3725472556248, 1568.4667213147532, 1798.343604584327, 1934.5840644261482, 1956.1001939108, 8505.574721263934, 8853.778655533615, 9014.278857691384, 9030.954845225773, 9042.276617870571, 7840.568768717718, 8058.5567793771315, 8480.0, 8695.521746303952, 8812.4712517249, 2360.5396947595227, 2387.880605969703, 2391.6173412254043, 2393.150431596784, 2404.362843846382, 2364.4679947011955, 2369.016858003935, 2402.7356990731005, 2403.8437501562344, 2406.5547873643345, 2080.8959552022416, 2154.396768904709, 2299.034405549673, 2354.81161507079, 2370.691810064689, 2111.3502554294414, 2360.409897525619, 2380.321608341614, 2381.3570336009266, 2384.487335222918, 2300.6779050932882, 2319.5592837361014, 2346.4368551547677, 2347.3779448446003, 2354.1642716835618, 8842.0, 8893.244074253696, 8906.376553641248, 8914.465132092031, 8916.821663566758, 5211.739413029333, 5377.0321342158395, 5390.380106287788, 5419.376771671229, 5443.863903402407, 3528.453089771064, 3539.557555305587, 3541.2533268812, 3544.6987006104514, 3590.317839610492, 1053.952572134256, 1110.7500812317164, 1111.1000089927104, 1784.687679656068, 1859.3771086685977, 11726.413679316085, 11793.82309265353, 11803.173777835555, 11810.232334898204, 11840.407979601072, 4293.162833247487, 4319.028218650778, 4443.2224360736745, 4451.287793952952, 4573.47405048417, 9162.496062716615, 9201.677941272157, 9217.631294748135, 9219.585118669676, 9220.723378298662, 5260.0, 5260.526552610283, 5269.288646032813, 5271.71005594696, 5296.0, 3736.981315093407, 4407.801648925806, 4547.795349209227, 4552.521985191507, 4949.65352425334, 3486.633903440153, 3653.488511608377, 3762.0, 3821.1402434452025, 3880.243352546283, 1137.4824454873012, 1157.311399717167, 1168.2348062019391, 1169.4503583315827, 1174.3599738142732, 833.6332013913858, 891.6388862510694, 925.421611492817, 936.7564433247269, 946.6781294359951, 5975.880482390327, 6003.219581454383, 6011.27864656244, 6023.156758053876, 6093.786717464867, 402.3120464006582, 431.7927394850489, 437.1693781814578, 450.86248694147946, 456.58678895599536, 3514.0687717754818, 3627.9841644339626, 3925.2149570085526, 3955.624215699504, 4091.529474110456, 10353.119984801226, 10834.133269338434, 10850.131989440826, 10864.402457864735, 10878.782424351626, 10465.319754216103, 10822.67531974042, 10907.400092994803, 10910.0, 10910.945445272722, 7904.6442910068035, 8317.542535160503, 8334.583270836434, 8403.243708066304, 8412.621432035574, 6010.909836352371, 6046.788362407295, 6048.788292409745, 6129.969350153221, 6160.9383906160365, 9839.85240221383, 10165.186785057325, 10179.185665146919, 10202.642907498202, 10239.283250172417, 9155.130262625307, 9720.368176068532, 10251.231157663056, 10268.897311026794, 10315.27793054479, 6707.262201157966, 8371.790705232417, 8405.831883362422, 8519.318454523747, 8520.914790852261, 8304.70933517324, 8310.0, 8380.706675266336, 8381.245687888118, 8415.3267738582, 7354.411647068328, 7388.778336649909, 7402.777916662509, 7485.962570187115, 7584.924150758642, 7482.738104166328, 7493.43799215072, 7529.096508418806, 7605.6577454015805, 7627.694892204249, 7060.0, 7109.537880037781, 7117.0, 7125.287471252833, 7184.353408193288, 4858.732769697559, 4866.0024694938165, 4871.853844384674, 4888.7311197884455, 5005.649604527648, 4934.284528743384, 4999.850004499871, 5002.924956125588, 5046.823361182341, 5098.133317336136], "value": 4515.414859997902, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [259.4823327461714, 312.1960950552327, 314.9732272756815, 319.6611591712785, 322.6563709649222, 5123.641345105844, 5423.945760542393, 5426.565874730022, 5435.293411856463, 5446.727663616818, 4425.181341451834, 4496.61778748806, 5343.465653434664, 5395.649282796616, 5476.5355589984465, 3168.4930411134224, 3876.7480113792653, 3918.6473217410426, 4069.491313585802, 4113.958860411402, 4054.2702313583545, 4104.220198162339, 4121.711480196387, 4135.648469880064, 4138.896527586804, 3456.8962931112105, 3999.2401443725744, 4066.8169932353117, 4071.5724848890886, 4098.0, 3479.495473156378, 3848.672208088205, 3943.3043791169785, 4015.8594449194284, 4106.917861642781, 3302.85137168828, 3444.9655503444897, 3546.4325707886615, 3552.609212986569, 3564.376234159012, 4271.572842715735, 4368.716033457815, 4757.548032936866, 4764.8332308369045, 5315.574754019708, 4063.6139566741113, 4079.8980025499304, 4368.584984426506, 4688.405941979743, 4704.200285951362, 4545.431821022372, 5091.389033316026, 5618.887622247573, 5659.236003139565, 5666.54667626593, 3246.1722260823576, 3268.4116858965376, 3881.961180388188, 3901.6878649707955, 3905.902352441183, 5194.818181363634, 5202.375714914197, 5534.308211473566, 5694.946434909555, 5969.253843269591, 3273.738100951918, 3597.892063238107, 3639.909002274964, 3906.460800479654, 3935.665468435215, 3990.042389826479, 3995.7402768819934, 4000.3999400089638, 4000.959990400059, 4011.338129208648, 4678.929816052762, 4688.835890743876, 4704.553067458586, 4713.2458806590785, 4715.811367545329, 4734.834280800155, 5086.92369614456, 5752.309722833287, 5757.481826635623, 5779.33537643168, 1161.8373427720126, 1329.2091205732575, 1357.0839683213792, 1362.2779926638898, 1365.6995460998564, 791.7189397763826, 810.2707563193173, 828.7154909889647, 837.6146972392768, 856.9185927336893, 5128.333316668809, 5263.684178949199, 5274.129768588216, 5276.3932147802725, 5278.155495120763, 4715.811367545329, 4715.929261061086, 5515.669059856422, 5783.306003279633, 5915.290165180206, 4706.3411122442885, 4882.974575339147, 5348.7000589746, 5370.812021579304, 5390.97304513475, 2882.769378449719, 3037.2103253154337, 3089.7837151399635, 3099.178717639827, 3131.264152924061, 6038.365971573009, 6091.299500557404, 6106.923645960394, 6152.354487570387, 6153.353897840751, 5268.0, 5331.520163185254, 5526.58550608706, 6079.483243924227, 6108.75564977396, 6031.0, 6091.939080609137, 6102.267727872683, 6118.235220597426, 6124.693765311717, 4603.838865639686, 5667.574931880043, 5907.409259074058, 5953.851153721192, 5974.984252677143, 5063.0, 5762.596618236683, 5779.5611611091335, 5841.883162336644, 5873.298282789964, 5057.393112826484, 5590.049691552527, 6069.393060693896, 6110.0, 6128.571000029955, 2862.728040836117, 2982.4482470742983, 3212.903612891617, 3442.1050526862696, 3469.826508674607, 4186.623203911662, 4999.950000499948, 5047.899042019066, 5054.949450505448, 5068.543831055223, 4363.912721745611, 4687.718736875799, 4893.9021219576125, 4907.2393778964315, 4930.531599498042, 4435.800388982568, 4530.1007355293295, 4531.320301954602, 4567.145534041224, 4574.634029277717, 4515.638748900145, 4589.862304130881, 4655.44042745684, 4840.8789780254365, 4852.490488498657, 4975.900481990412, 5394.921015796778, 5436.103042997861, 5520.702634880719, 5595.440455954372, 4994.625403094855, 5638.0, 5656.577770448819, 5659.603827732019, 5664.376918538875], "value": 4004.68419131484, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [698.87070891885, 784.3372350363944, 796.1242633103583, 796.569852279769, 848.3976376772491, 15339.539813805575, 15858.762118568216, 16745.0, 16757.0, 16761.7485737714, 15049.097054176757, 15241.31414086366, 15244.009139405931, 15255.466058687949, 15267.083974961482, 690.4717890813532, 716.5521549031855, 865.273170536749, 874.6894852327428, 892.7187935800234, 889.1375365895071, 898.3846065445158, 901.179926267097, 903.661127077346, 903.9096090390974, 957.5786653872309, 958.3531116496337, 958.8369977103874, 959.764857609883, 960.4861399151455, 735.3675838778646, 907.4872696926216, 928.5774972387547, 953.0564740906522, 958.1376760915232, 709.0109297529968, 709.2375696126633, 710.2719712294887, 711.2531841566387, 711.2958171410319, 15348.386064557404, 15356.462523811724, 15367.846321536754, 15379.769303460456, 15390.846091539053, 14008.29958502081, 14065.859341406558, 14096.50662226817, 14153.0, 14224.502142424966, 12848.743025139445, 12910.289934053624, 13025.609231723063, 13131.0, 13299.734005319839, 4601.700889442175, 4622.0, 4700.130475861943, 4790.353302304179, 4793.496682848286, 79250.6037469809, 109553.0, 109880.0, 110199.44900275447, 110400.0, 11009.339439633648, 11175.385353805455, 11240.718982025515, 11437.199396042364, 11610.6516804496, 22417.0, 22429.0, 22432.88783556072, 22439.990200441018, 22467.438314041952, 7975.401844861659, 8027.598620068973, 8111.634976426075, 8233.670653173926, 8249.422540422112, 4422.977885110554, 4460.643148548108, 4471.597556219956, 4556.749378784132, 4628.375169352162, 3452.9654703453148, 3529.936116476027, 3557.2351944332095, 3567.2687099144614, 3573.1781690211396, 641.0928536121429, 652.1391762873056, 652.422605993699, 662.0929326822285, 667.9398854103154, 574.5030548575452, 586.4575267877196, 620.4951116248961, 632.2602555010649, 644.1207751419279, 8685.956570217108, 8769.693060742844, 8850.20348168655, 8882.0, 8959.507227102442, 609.9939000609937, 623.3735096228262, 625.9687015649199, 632.424493710721, 634.5399585300712, 4217.304144816071, 4269.978650106729, 4275.786210689453, 4278.251306021434, 4338.674599405057, 154424.0, 156010.65984010248, 157454.0, 162023.0, 164284.17857910634, 131690.0, 135572.0, 138608.30695846456, 140559.0, 141785.29107354398, 68212.0, 100670.0, 101763.0, 101982.0, 102301.74680784959, 8077.959610201911, 8222.712205072794, 8232.464889782144, 8316.6673333066, 8510.148985101441, 63590.0, 65314.0, 65444.67277663581, 66109.00836487552, 66772.66613666901, 99101.0, 100121.49939250258, 100839.0, 101761.49119254356, 103464.0, 10535.0, 11600.0, 11759.235649682743, 11836.467358968695, 12259.69350766238, 10714.946425267824, 12338.629841104781, 12381.938090309492, 12490.750184996068, 12820.743585128059, 10293.176545876462, 10380.221483388625, 10455.0, 10584.735381615214, 10651.840222396826, 11297.322160670386, 11614.883851161718, 11619.302841829518, 11984.700382490508, 12122.393880306126, 11706.414679265832, 11756.764864702487, 12133.817992729939, 12228.633141005785, 12264.938675306566, 7884.093329266978, 9657.46883921391, 9833.213342932691, 9915.157211637092, 10106.039926206999, 8051.275385215359, 9197.448153110834, 9240.95379523098, 9646.228301735704, 9669.274804389559], "value": 7685.565836769778, "unit": "score"}], "name": "dromaeo_css", "value": 7363.598852676264, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 113.0, 114.0, 114.0, 112.0, 114.0, 112.0, 112.0, 113.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 107.0, 105.0, 155.0, 106.0, 101.0, 129.0, 130.0, 156.0, 105.0], "value": 123.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 183.0, 183.0, 194.0, 254.0, 188.0, 184.0, 182.0, 184.0, 180.0], "value": 191.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 73.0, 58.0, 106.0, 56.0, 57.0, 62.0, 59.0, 97.0, 56.0], "value": 70.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 95.0, 92.0, 100.0, 70.0, 68.0, 96.0, 69.0, 67.0, 101.0], "value": 84.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 123.0, 94.0, 95.0, 86.0, 71.0, 131.0, 94.0, 86.0, 83.0], "value": 94.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 93.0, 93.0, 105.0, 148.0, 94.0, 94.0, 95.0, 92.0], "value": 100.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 85.0, 86.0, 86.0, 84.0, 86.0, 84.0, 86.0, 84.0], "value": 85.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 58.0, 55.0, 54.0, 54.0, 56.0, 54.0, 53.0, 54.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 73.0, 72.0, 79.0, 72.0, 71.0, 72.0, 72.0, 72.0, 73.0], "value": 72.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 82.0, 82.0, 85.0, 82.0, 84.0, 84.0, 80.0, 83.0, 84.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 143.0, 148.0, 152.0, 141.0, 129.0, 136.0, 147.0, 240.0, 136.0], "value": 150.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 159.0, 162.0, 159.0, 165.0, 162.0, 164.0, 162.0, 159.0], "value": 161.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 85.0, 84.0, 83.0, 85.0, 84.0, 66.0, 65.0, 65.0, 66.0], "value": 75.1, "unit": "score"}], "name": "kraken", "value": 1458.1999999999998, "alertThreshold": 2.0}]} 20:38:16 INFO - Return code: 0 20:38:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:38:16 INFO - # TBPL SUCCESS # 20:38:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:38:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:38:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:38:16 INFO - 2016-07-12 20:38:16.629 screenresolution[1675:10946] starting screenresolution argv=screenresolution get 20:38:16 INFO - 2016-07-12 20:38:16.631 screenresolution[1675:10946] Display 0: 1600x1200x32@60 20:38:16 INFO - 2016-07-12 20:38:16.638 screenresolution[1676:10949] starting screenresolution argv=screenresolution list 20:38:16 INFO - Available Modes on Display 0 20:38:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:38:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:38:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:38:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:38:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:38:16 INFO - Intel Iris: 20:38:16 INFO - Chipset Model: Intel Iris 20:38:16 INFO - Type: GPU 20:38:16 INFO - Bus: Built-In 20:38:16 INFO - VRAM (Dynamic, Max): 1536 MB 20:38:16 INFO - Vendor: Intel (0x8086) 20:38:16 INFO - Device ID: 0x0a2e 20:38:16 INFO - Revision ID: 0x0009 20:38:16 INFO - Displays: 20:38:16 INFO - Display: 20:38:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:38:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:38:16 INFO - Display Serial Number: 1600x1200 60 20:38:16 INFO - Main Display: Yes 20:38:16 INFO - Mirror: Off 20:38:16 INFO - Online: Yes 20:38:16 INFO - Rotation: Supported 20:38:16 INFO - Return code: 0 20:38:16 INFO - Running post-action listener: _resource_record_post_action 20:38:16 INFO - ##### 20:38:16 INFO - ##### Finished run-tests step (success) 20:38:16 INFO - ##### 20:38:16 INFO - Running post-run listener: _resource_record_post_run 20:38:16 INFO - Total resource usage - Wall time: 1213s; CPU: 53.0%; Read bytes: 31432192; Write bytes: 708367360; Read time: 196; Write time: 1975 20:38:16 INFO - TinderboxPrint: CPU usage
53.5% 20:38:16 INFO - TinderboxPrint: I/O read bytes / time
31,432,192 / 196 20:38:16 INFO - TinderboxPrint: I/O write bytes / time
708,367,360 / 1,975 20:38:16 INFO - TinderboxPrint: CPU idle
2,257.4 (46.5%) 20:38:16 INFO - TinderboxPrint: CPU system
965.3 (19.9%) 20:38:16 INFO - TinderboxPrint: CPU user
1,630.9 (33.6%) 20:38:16 INFO - TinderboxPrint: Swap in / out
435,171,328 / 0 20:38:16 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 396630528; Write bytes: 391792640; Read time: 29424; Write time: 824 20:38:16 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 29416960; Write bytes: 296844288; Read time: 177; Write time: 1100 20:38:17 INFO - Running post-run listener: _upload_blobber_files 20:38:17 INFO - Blob upload gear active. 20:38:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:38:17 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 20:38:17 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:38:17 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:38:17 INFO - (blobuploader) - INFO - Open directory for files ... 20:38:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:38:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:38:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:38:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:38:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:38:18 INFO - (blobuploader) - INFO - Done attempting. 20:38:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:38:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:38:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:38:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:38:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:38:19 INFO - (blobuploader) - INFO - Done attempting. 20:38:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:38:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:38:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:38:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:38:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:38:22 INFO - (blobuploader) - INFO - Done attempting. 20:38:22 INFO - (blobuploader) - INFO - Iteration through files over. 20:38:22 INFO - Return code: 0 20:38:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:38:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:38:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0ef7bb8d4a570acc45bd95ddaf0e772f50dd29b67eee8f036b885a586e31a504a46ca4414cdd6c226fd9c11591d0d8fa0000609c4142230d0eb8644a74bc073e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c6838966bcaf39ea869c85cea1a5c4e9eaf8e48440d3151f543f3e11aa7efd81075a11ca53f209cad0bc6f9f718baf5e07328958ad3f43279bd7bb9aba4fbb34", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4f7ea3ec93b18c23dbf3986fb4434f4330039c6d401719c40176fa17580f8375b94d549f65bdd9872907409912f4c8efc8de99994014a13e23943cd014d4b9e5"} 20:38:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:38:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:38:22 INFO - Contents: 20:38:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0ef7bb8d4a570acc45bd95ddaf0e772f50dd29b67eee8f036b885a586e31a504a46ca4414cdd6c226fd9c11591d0d8fa0000609c4142230d0eb8644a74bc073e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c6838966bcaf39ea869c85cea1a5c4e9eaf8e48440d3151f543f3e11aa7efd81075a11ca53f209cad0bc6f9f718baf5e07328958ad3f43279bd7bb9aba4fbb34", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4f7ea3ec93b18c23dbf3986fb4434f4330039c6d401719c40176fa17580f8375b94d549f65bdd9872907409912f4c8efc8de99994014a13e23943cd014d4b9e5"} 20:38:22 INFO - Running post-run listener: copy_logs_to_upload_dir 20:38:22 INFO - Copying logs to upload dir... 20:38:22 INFO - mkdir: /builds/slave/test/build/upload/logs 20:38:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.024482 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-07-12 20:38:22.135918) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 20:38:22.139218) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.AsW9qm8mEJ/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.jfe3kFXymC/Listeners TMPDIR=/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0ef7bb8d4a570acc45bd95ddaf0e772f50dd29b67eee8f036b885a586e31a504a46ca4414cdd6c226fd9c11591d0d8fa0000609c4142230d0eb8644a74bc073e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c6838966bcaf39ea869c85cea1a5c4e9eaf8e48440d3151f543f3e11aa7efd81075a11ca53f209cad0bc6f9f718baf5e07328958ad3f43279bd7bb9aba4fbb34", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4f7ea3ec93b18c23dbf3986fb4434f4330039c6d401719c40176fa17580f8375b94d549f65bdd9872907409912f4c8efc8de99994014a13e23943cd014d4b9e5"} build_url:https://queue.taskcluster.net/v1/task/TGPgJZp5TaiQfdZAEa6u2Q/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010478 build_url: 'https://queue.taskcluster.net/v1/task/TGPgJZp5TaiQfdZAEa6u2Q/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0ef7bb8d4a570acc45bd95ddaf0e772f50dd29b67eee8f036b885a586e31a504a46ca4414cdd6c226fd9c11591d0d8fa0000609c4142230d0eb8644a74bc073e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c6838966bcaf39ea869c85cea1a5c4e9eaf8e48440d3151f543f3e11aa7efd81075a11ca53f209cad0bc6f9f718baf5e07328958ad3f43279bd7bb9aba4fbb34", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4f7ea3ec93b18c23dbf3986fb4434f4330039c6d401719c40176fa17580f8375b94d549f65bdd9872907409912f4c8efc8de99994014a13e23943cd014d4b9e5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 20:38:22.171013) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 20:38:22.171372) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.AsW9qm8mEJ/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.jfe3kFXymC/Listeners TMPDIR=/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005258 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 20:38:22.220246) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 20:38:22.220613) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 20:38:22.221000) ========= ========= Total master_lag: 0.17 =========