builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0027 starttime: 1476886894.14 results: success (0) buildid: 20161019062522 builduid: dadb80f45ecd4c918c5f8ce866da617c revision: 698191832c6455f5060c300fa069e6e94d79948c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 07:21:34.139598) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 07:21:34.140106) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 07:21:34.140403) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 07:21:34.164845) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 07:21:34.165221) ========= 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.a9ZKCohQtp/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.nSoRpypBhb/Listeners TMPDIR=/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/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-10-19 07:21:34-- 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: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 16.1M=0.001s 2016-10-19 07:21:34 (16.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.111596 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 07:21:34.302024) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 07:21:34.302348) ========= 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.a9ZKCohQtp/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.nSoRpypBhb/Listeners TMPDIR=/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/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.026025 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 07:21:34.353825) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-19 07:21:34.354185) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 698191832c6455f5060c300fa069e6e94d79948c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 698191832c6455f5060c300fa069e6e94d79948c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.a9ZKCohQtp/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.nSoRpypBhb/Listeners TMPDIR=/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/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-10-19 07:21:34,436 truncating revision to first 12 chars 2016-10-19 07:21:34,436 Setting DEBUG logging. 2016-10-19 07:21:34,436 attempt 1/10 2016-10-19 07:21:34,436 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/698191832c64?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-19 07:21:35,495 unpacking tar archive at: mozilla-aurora-698191832c64/testing/mozharness/ program finished with exit code 0 elapsedTime=1.319182 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-19 07:21:35.698585) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 07:21:35.698975) ========= script_repo_revision: 698191832c6455f5060c300fa069e6e94d79948c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 07:21:35.699388) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 07:21:35.699684) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 07:21:35.718084) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-10-19 07:21:35.718496) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.a9ZKCohQtp/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.nSoRpypBhb/Listeners TMPDIR=/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/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 07:21:35 INFO - MultiFileLogger online at 20161019 07:21:35 in /builds/slave/test 07:21:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 07:21:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:21:35 INFO - {'append_to_log': False, 07:21:35 INFO - 'base_work_dir': '/builds/slave/test', 07:21:35 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:21:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:21:35 INFO - 'branch': 'Mozilla-Aurora', 07:21:35 INFO - 'buildbot_json_path': 'buildprops.json', 07:21:35 INFO - 'config_files': ('talos/mac_config.py',), 07:21:35 INFO - 'default_actions': ('clobber', 07:21:35 INFO - 'read-buildbot-config', 07:21:35 INFO - 'download-and-extract', 07:21:35 INFO - 'populate-webroot', 07:21:35 INFO - 'create-virtualenv', 07:21:35 INFO - 'install', 07:21:35 INFO - 'run-tests'), 07:21:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:21:35 INFO - 'download_minidump_stackwalk': True, 07:21:35 INFO - 'download_symbols': 'ondemand', 07:21:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:21:35 INFO - 'tooltool.py': '/tools/tooltool.py', 07:21:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:21:35 INFO - '/tools/misc-python/virtualenv.py')}, 07:21:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:21:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:21:35 INFO - 'installer_path': 'installer.exe', 07:21:35 INFO - 'log_level': 'info', 07:21:35 INFO - 'log_name': 'talos', 07:21:35 INFO - 'log_to_console': True, 07:21:35 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:21:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:21:35 INFO - 'opt_config_files': (), 07:21:35 INFO - 'pip_index': False, 07:21:35 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:21:35 INFO - 'cmd': ('bash', 07:21:35 INFO - '-c', 07:21:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:21:35 INFO - 'enabled': True, 07:21:35 INFO - 'halt_on_failure': False, 07:21:35 INFO - 'name': 'check_screen_resolution'},), 07:21:35 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:21:35 INFO - 'cmd': ('bash', 07:21:35 INFO - '-c', 07:21:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:21:35 INFO - 'enabled': True, 07:21:35 INFO - 'halt_on_failure': False, 07:21:35 INFO - 'name': 'check_screen_resolution'},), 07:21:35 INFO - 'run_cmd_checks_enabled': True, 07:21:35 INFO - 'sps_profile': False, 07:21:35 INFO - 'sps_profile_interval': 0, 07:21:35 INFO - 'suite': 'dromaeojs', 07:21:35 INFO - 'system_bits': '32', 07:21:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:21:35 INFO - 'title': 't-yosemite-r7-0027', 07:21:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:21:35 INFO - 'use_talos_json': True, 07:21:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:21:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:21:35 INFO - 'work_dir': 'build'} 07:21:35 INFO - [mozharness: 2016-10-19 14:21:35.921206Z] Running clobber step. 07:21:35 INFO - Running pre-action listener: _resource_record_pre_action 07:21:35 INFO - Running main action method: clobber 07:21:35 INFO - rmtree: /builds/slave/test/build 07:21:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:21:38 INFO - Running post-action listener: _resource_record_post_action 07:21:38 INFO - [mozharness: 2016-10-19 14:21:38.712496Z] Finished clobber step (success) 07:21:38 INFO - [mozharness: 2016-10-19 14:21:38.712668Z] Running read-buildbot-config step. 07:21:38 INFO - Running pre-action listener: _resource_record_pre_action 07:21:38 INFO - Running main action method: read_buildbot_config 07:21:38 INFO - Using buildbot properties: 07:21:38 INFO - { 07:21:38 INFO - "project": "", 07:21:38 INFO - "product": "firefox", 07:21:38 INFO - "script_repo_revision": "production", 07:21:38 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 07:21:38 INFO - "repository": "", 07:21:38 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 07:21:38 INFO - "buildid": "20161019062522", 07:21:38 INFO - "pgo_build": "False", 07:21:38 INFO - "basedir": "/builds/slave/test", 07:21:38 INFO - "buildnumber": 13, 07:21:38 INFO - "slavename": "t-yosemite-r7-0027", 07:21:38 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 07:21:38 INFO - "platform": "yosemite_r7", 07:21:38 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 07:21:38 INFO - "branch": "mozilla-aurora", 07:21:38 INFO - "repo_path": "releases/mozilla-aurora", 07:21:38 INFO - "revision": "698191832c6455f5060c300fa069e6e94d79948c", 07:21:38 INFO - "stage_platform": "macosx64", 07:21:38 INFO - "builduid": "dadb80f45ecd4c918c5f8ce866da617c", 07:21:38 INFO - "slavebuilddir": "test" 07:21:38 INFO - } 07:21:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/U50hLkAbSXe58QmMAydCHw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 07:21:38 INFO - Running post-action listener: _resource_record_post_action 07:21:38 INFO - [mozharness: 2016-10-19 14:21:38.716671Z] Finished read-buildbot-config step (success) 07:21:38 INFO - [mozharness: 2016-10-19 14:21:38.716808Z] Running download-and-extract step. 07:21:38 INFO - Running pre-action listener: _resource_record_pre_action 07:21:38 INFO - Running main action method: download_and_extract 07:21:38 INFO - mkdir: /builds/slave/test/build/tests 07:21: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:21:38 INFO - trying https://queue.taskcluster.net/v1/task/U50hLkAbSXe58QmMAydCHw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 07:21:38 INFO - Downloading https://queue.taskcluster.net/v1/task/U50hLkAbSXe58QmMAydCHw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 07:21:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U50hLkAbSXe58QmMAydCHw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 07:21:40 INFO - Downloaded 1199 bytes. 07:21:40 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 07:21:40 INFO - Using the following test package requirements: 07:21:40 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 07:21:40 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:21:40 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 07:21:40 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:21:40 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 07:21:40 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:21:40 INFO - u'jsshell-mac.zip'], 07:21:40 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:21:40 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 07:21:40 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 07:21:40 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:21:40 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 07:21:40 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:21:40 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 07:21:40 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:21:40 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 07:21:40 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:21:40 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 07:21:40 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 07:21:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U50hLkAbSXe58QmMAydCHw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 07:21:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U50hLkAbSXe58QmMAydCHw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:21:40 INFO - Fetch https://queue.taskcluster.net/v1/task/U50hLkAbSXe58QmMAydCHw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 07:21:40 INFO - Expected file size: 16436114 07:21:47 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 07:21:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U50hLkAbSXe58QmMAydCHw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 07:21:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U50hLkAbSXe58QmMAydCHw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:21:47 INFO - Fetch https://queue.taskcluster.net/v1/task/U50hLkAbSXe58QmMAydCHw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 07:21:48 INFO - Expected file size: 16436114 07:21:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U50hLkAbSXe58QmMAydCHw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 07:21:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U50hLkAbSXe58QmMAydCHw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 07:21:54 INFO - Fetch https://queue.taskcluster.net/v1/task/U50hLkAbSXe58QmMAydCHw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 07:21:55 INFO - Expected file size: 14414081 07:21:56 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:21:56 INFO - trying https://queue.taskcluster.net/v1/task/U50hLkAbSXe58QmMAydCHw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 07:21:56 INFO - Downloading https://queue.taskcluster.net/v1/task/U50hLkAbSXe58QmMAydCHw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 07:21:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U50hLkAbSXe58QmMAydCHw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 07:21:59 INFO - Downloaded 115406784 bytes. 07:21:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/U50hLkAbSXe58QmMAydCHw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 07:21:59 INFO - mkdir: /builds/slave/test/properties 07:21:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:21:59 INFO - Writing to file /builds/slave/test/properties/build_url 07:21:59 INFO - Contents: 07:21:59 INFO - build_url:https://queue.taskcluster.net/v1/task/U50hLkAbSXe58QmMAydCHw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 07:22:00 INFO - Running post-action listener: _resource_record_post_action 07:22:00 INFO - Running post-action listener: set_extra_try_arguments 07:22:00 INFO - [mozharness: 2016-10-19 14:22:00.115040Z] Finished download-and-extract step (success) 07:22:00 INFO - [mozharness: 2016-10-19 14:22:00.115160Z] Running populate-webroot step. 07:22:00 INFO - Running pre-action listener: _resource_record_pre_action 07:22:00 INFO - Running main action method: populate_webroot 07:22:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:22:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:22:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:22:00 INFO - '--tppagecycles', 07:22:00 INFO - '7'], 07:22:00 INFO - 'tests': ['tsvgm']}}, 07:22:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:22:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:22:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:22:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:22:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:22:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:22:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:22:00 INFO - 'talos_options': ['--disable-e10s'], 07:22:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:22:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:22:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:22:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:22:00 INFO - 'talos_options': ['--disable-e10s'], 07:22:00 INFO - 'tests': ['damp', 'tps']}, 07:22:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:22:00 INFO - 'tests': ['damp', 'tps']}, 07:22:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:22:00 INFO - 'tests': ['dromaeo_dom']}, 07:22:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:22:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:22:00 INFO - 'tests': ['basic_compositor_video']}, 07:22:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:22:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:22:00 INFO - 'tests': ['a11yr', 07:22:00 INFO - 'ts_paint', 07:22:00 INFO - 'tpaint', 07:22:00 INFO - 'sessionrestore', 07:22:00 INFO - 'sessionrestore_no_auto_restore', 07:22:00 INFO - 'tabpaint']}, 07:22:00 INFO - 'other-e10s': {'tests': ['a11yr', 07:22:00 INFO - 'ts_paint', 07:22:00 INFO - 'tpaint', 07:22:00 INFO - 'sessionrestore', 07:22:00 INFO - 'sessionrestore_no_auto_restore', 07:22:00 INFO - 'tabpaint']}, 07:22:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:22:00 INFO - 'ts_paint', 07:22:00 INFO - 'tpaint', 07:22:00 INFO - 'sessionrestore', 07:22:00 INFO - 'sessionrestore_no_auto_restore', 07:22:00 INFO - 'tabpaint']}, 07:22:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:22:00 INFO - 'ts_paint', 07:22:00 INFO - 'tpaint', 07:22:00 INFO - 'sessionrestore', 07:22:00 INFO - 'sessionrestore_no_auto_restore', 07:22:00 INFO - 'tabpaint']}, 07:22:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:22:00 INFO - 'tests': ['a11yr', 07:22:00 INFO - 'ts_paint', 07:22:00 INFO - 'tpaint', 07:22:00 INFO - 'sessionrestore', 07:22:00 INFO - 'sessionrestore_no_auto_restore', 07:22:00 INFO - 'tabpaint']}, 07:22:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:22:00 INFO - 'tests': ['a11yr', 07:22:00 INFO - 'ts_paint', 07:22:00 INFO - 'tpaint', 07:22:00 INFO - 'sessionrestore', 07:22:00 INFO - 'sessionrestore_no_auto_restore', 07:22:00 INFO - 'tabpaint']}, 07:22:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:22:00 INFO - 'tests': ['tsvgx', 07:22:00 INFO - 'tsvgr_opacity', 07:22:00 INFO - 'tart', 07:22:00 INFO - 'tscrollx', 07:22:00 INFO - 'cart']}, 07:22:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:22:00 INFO - 'tsvgr_opacity', 07:22:00 INFO - 'tart', 07:22:00 INFO - 'tscrollx', 07:22:00 INFO - 'cart']}, 07:22:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:22:00 INFO - 'talos_options': ['--disable-e10s'], 07:22:00 INFO - 'tests': ['tp5o']}, 07:22:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:22:00 INFO - 'tests': ['tp5o']}, 07:22:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:22:00 INFO - 'talos_options': ['--disable-e10s', 07:22:00 INFO - '--xperf_path', 07:22:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:22:00 INFO - 'tests': ['tp5n']}, 07:22:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:22:00 INFO - 'talos_options': ['--xperf_path', 07:22:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:22:00 INFO - 'tests': ['tp5n']}}, 07:22:00 INFO - 'talos.zip': {'path': '', 07:22:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:22:00 INFO - Running post-action listener: _resource_record_post_action 07:22:00 INFO - [mozharness: 2016-10-19 14:22:00.133722Z] Finished populate-webroot step (success) 07:22:00 INFO - [mozharness: 2016-10-19 14:22:00.133840Z] Running create-virtualenv step. 07:22:00 INFO - Running pre-action listener: _resource_record_pre_action 07:22:00 INFO - Running main action method: create_virtualenv 07:22:00 INFO - Creating virtualenv /builds/slave/test/build/venv 07:22:00 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 07:22:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:22:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:22:00 INFO - Using real prefix '/tools/python27' 07:22:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:22:00 INFO - Installing distribute.............................................................................................................................................................................................done. 07:22:03 INFO - Installing pip.................done. 07:22:03 INFO - Return code: 0 07:22:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:22:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:22:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:22:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:22:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:03 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 0x10ce6c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cde2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0605a7fc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc80d30>, '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 0x10cae6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc78b20>, '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.a9ZKCohQtp/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.nSoRpypBhb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/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 07:22:03 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 07:22:03 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 07:22:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a9ZKCohQtp/Render', 07:22:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:22:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:22:03 INFO - 'HOME': '/Users/cltbld', 07:22:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:22:03 INFO - 'LOGNAME': 'cltbld', 07:22:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:22:03 INFO - 'MOZ_NO_REMOTE': '1', 07:22:03 INFO - 'NO_EM_RESTART': '1', 07:22:03 INFO - 'PAGER': '/bin/cat', 07:22:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:22:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:22:03 INFO - 'PWD': '/builds/slave/test', 07:22:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:22:03 INFO - 'SHELL': '/bin/bash', 07:22:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nSoRpypBhb/Listeners', 07:22:03 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 07:22:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:22:03 INFO - 'USER': 'cltbld', 07:22:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:22:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:22:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:22:03 INFO - 'XPC_FLAGS': '0x0', 07:22:03 INFO - 'XPC_SERVICE_NAME': '0', 07:22:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:22:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:22:04 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 07:22:04 INFO - Cleaning up... 07:22:04 INFO - Return code: 0 07:22:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:22:04 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:22:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:22:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:04 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:22:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:22:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:04 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 0x10ce6c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cde2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0605a7fc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc80d30>, '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 0x10cae6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc78b20>, '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.a9ZKCohQtp/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.nSoRpypBhb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/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 07:22:04 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 07:22:04 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 07:22:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a9ZKCohQtp/Render', 07:22:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:22:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:22:04 INFO - 'HOME': '/Users/cltbld', 07:22:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:22:04 INFO - 'LOGNAME': 'cltbld', 07:22:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:22:04 INFO - 'MOZ_NO_REMOTE': '1', 07:22:04 INFO - 'NO_EM_RESTART': '1', 07:22:04 INFO - 'PAGER': '/bin/cat', 07:22:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:22:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:22:04 INFO - 'PWD': '/builds/slave/test', 07:22:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:22:04 INFO - 'SHELL': '/bin/bash', 07:22:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nSoRpypBhb/Listeners', 07:22:04 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 07:22:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:22:04 INFO - 'USER': 'cltbld', 07:22:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:22:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:22:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:22:04 INFO - 'XPC_FLAGS': '0x0', 07:22:04 INFO - 'XPC_SERVICE_NAME': '0', 07:22:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:22:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:22:04 INFO - Downloading/unpacking psutil>=3.1.1 07:22:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:22:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:22:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:22:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:22:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:22:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:22:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:22:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:22:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:22:07 INFO - Installing collected packages: psutil 07:22:07 INFO - Running setup.py install for psutil 07:22:07 INFO - building 'psutil._psutil_osx' extension 07:22:07 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 07:22:07 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 07:22:07 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 07:22:07 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 07:22:08 INFO - building 'psutil._psutil_posix' extension 07:22:08 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 07:22:08 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:22:08 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:22:08 INFO - ^ 07:22:08 INFO - 1 warning generated. 07:22:08 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 07:22:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:22:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:22:08 INFO - Successfully installed psutil 07:22:08 INFO - Cleaning up... 07:22:08 INFO - Return code: 0 07:22:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:22:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:22:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:22:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:22:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:22:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:08 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 0x10ce6c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cde2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0605a7fc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc80d30>, '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 0x10cae6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc78b20>, '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.a9ZKCohQtp/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.nSoRpypBhb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/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 07:22:08 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 07:22:08 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 07:22:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a9ZKCohQtp/Render', 07:22:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:22:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:22:08 INFO - 'HOME': '/Users/cltbld', 07:22:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:22:08 INFO - 'LOGNAME': 'cltbld', 07:22:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:22:08 INFO - 'MOZ_NO_REMOTE': '1', 07:22:08 INFO - 'NO_EM_RESTART': '1', 07:22:08 INFO - 'PAGER': '/bin/cat', 07:22:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:22:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:22:08 INFO - 'PWD': '/builds/slave/test', 07:22:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:22:08 INFO - 'SHELL': '/bin/bash', 07:22:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nSoRpypBhb/Listeners', 07:22:08 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 07:22:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:22:08 INFO - 'USER': 'cltbld', 07:22:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:22:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:22:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:22:08 INFO - 'XPC_FLAGS': '0x0', 07:22:08 INFO - 'XPC_SERVICE_NAME': '0', 07:22:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:22:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:22:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:22:08 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 07:22:08 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 07:22:08 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 07:22:08 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 07:22:08 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 07:22:08 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 07:22:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:22:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:22:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:22:11 INFO - Installing collected packages: mozsystemmonitor 07:22:11 INFO - Running setup.py install for mozsystemmonitor 07:22:11 INFO - Successfully installed mozsystemmonitor 07:22:11 INFO - Cleaning up... 07:22:11 INFO - Return code: 0 07:22:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:22:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:22:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:22:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:22:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:22:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:11 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 0x10ce6c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cde2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0605a7fc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc80d30>, '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 0x10cae6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc78b20>, '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.a9ZKCohQtp/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.nSoRpypBhb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/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 07:22:11 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 07:22:11 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 07:22:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a9ZKCohQtp/Render', 07:22:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:22:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:22:11 INFO - 'HOME': '/Users/cltbld', 07:22:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:22:11 INFO - 'LOGNAME': 'cltbld', 07:22:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:22:11 INFO - 'MOZ_NO_REMOTE': '1', 07:22:11 INFO - 'NO_EM_RESTART': '1', 07:22:11 INFO - 'PAGER': '/bin/cat', 07:22:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:22:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:22:11 INFO - 'PWD': '/builds/slave/test', 07:22:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:22:11 INFO - 'SHELL': '/bin/bash', 07:22:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nSoRpypBhb/Listeners', 07:22:11 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 07:22:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:22:11 INFO - 'USER': 'cltbld', 07:22:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:22:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:22:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:22:11 INFO - 'XPC_FLAGS': '0x0', 07:22:11 INFO - 'XPC_SERVICE_NAME': '0', 07:22:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:22:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:22:11 INFO - Downloading/unpacking jsonschema==2.5.1 07:22:11 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 07:22:11 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 07:22:11 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 07:22:11 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 07:22:11 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 07:22:11 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 07:22:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:22:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:22:14 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 07:22:14 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 07:22:14 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 07:22:14 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 07:22:14 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 07:22:14 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 07:22:14 INFO - Downloading functools32-3.2.3-2.tar.gz 07:22:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:22:14 INFO - warning: no files found matching '*.txt' 07:22:14 INFO - no previously-included directories found matching 'build' 07:22:14 INFO - no previously-included directories found matching 'dist' 07:22:14 INFO - no previously-included directories found matching '.git*' 07:22:14 INFO - Installing collected packages: jsonschema, functools32 07:22:14 INFO - Running setup.py install for functools32 07:22:14 INFO - warning: no files found matching '*.txt' 07:22:14 INFO - no previously-included directories found matching 'build' 07:22:14 INFO - no previously-included directories found matching 'dist' 07:22:14 INFO - no previously-included directories found matching '.git*' 07:22:14 INFO - Successfully installed jsonschema functools32 07:22:14 INFO - Cleaning up... 07:22:14 INFO - Return code: 0 07:22:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:22:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:22:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:22:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:22:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:22:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:14 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ce6c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cde2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0605a7fc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc80d30>, '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 0x10cae6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc78b20>, '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.a9ZKCohQtp/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.nSoRpypBhb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/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 07:22:14 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:22:14 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 functools32==3.2.3-2 07:22:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a9ZKCohQtp/Render', 07:22:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:22:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:22:14 INFO - 'HOME': '/Users/cltbld', 07:22:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:22:14 INFO - 'LOGNAME': 'cltbld', 07:22:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:22:14 INFO - 'MOZ_NO_REMOTE': '1', 07:22:14 INFO - 'NO_EM_RESTART': '1', 07:22:14 INFO - 'PAGER': '/bin/cat', 07:22:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:22:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:22:14 INFO - 'PWD': '/builds/slave/test', 07:22:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:22:14 INFO - 'SHELL': '/bin/bash', 07:22:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nSoRpypBhb/Listeners', 07:22:14 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 07:22:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:22:14 INFO - 'USER': 'cltbld', 07:22:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:22:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:22:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:22:14 INFO - 'XPC_FLAGS': '0x0', 07:22:14 INFO - 'XPC_SERVICE_NAME': '0', 07:22:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:22:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:22:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:22:15 INFO - Cleaning up... 07:22:15 INFO - Return code: 0 07:22:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:22:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:22:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:22:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:22:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:22:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:15 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 0x10ce6c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cde2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0605a7fc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc80d30>, '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 0x10cae6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc78b20>, '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.a9ZKCohQtp/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.nSoRpypBhb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/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 07:22:15 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 07:22:15 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 07:22:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a9ZKCohQtp/Render', 07:22:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:22:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:22:15 INFO - 'HOME': '/Users/cltbld', 07:22:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:22:15 INFO - 'LOGNAME': 'cltbld', 07:22:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:22:15 INFO - 'MOZ_NO_REMOTE': '1', 07:22:15 INFO - 'NO_EM_RESTART': '1', 07:22:15 INFO - 'PAGER': '/bin/cat', 07:22:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:22:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:22:15 INFO - 'PWD': '/builds/slave/test', 07:22:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:22:15 INFO - 'SHELL': '/bin/bash', 07:22:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nSoRpypBhb/Listeners', 07:22:15 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 07:22:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:22:15 INFO - 'USER': 'cltbld', 07:22:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:22:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:22:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:22:15 INFO - 'XPC_FLAGS': '0x0', 07:22:15 INFO - 'XPC_SERVICE_NAME': '0', 07:22:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:22:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:22:15 INFO - Downloading/unpacking blobuploader==1.2.4 07:22:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:22:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:22:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:22:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:22:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:22:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:22:17 INFO - Downloading blobuploader-1.2.4.tar.gz 07:22:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:22:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:22:18 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 07:22:18 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 07:22:18 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 07:22:18 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 07:22:18 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 07:22:18 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 07:22:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:22:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:22:18 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 07:22:18 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 07:22:18 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 07:22:18 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 07:22:18 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 07:22:18 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 07:22:19 INFO - Downloading docopt-0.6.1.tar.gz 07:22:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:22:19 INFO - Installing collected packages: blobuploader, requests, docopt 07:22:19 INFO - Running setup.py install for blobuploader 07:22:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:22:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:22:19 INFO - Running setup.py install for requests 07:22:19 INFO - Running setup.py install for docopt 07:22:19 INFO - Successfully installed blobuploader requests docopt 07:22:19 INFO - Cleaning up... 07:22:20 INFO - Return code: 0 07:22:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:22:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:22:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:22:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:22:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:22:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:20 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 0x10ce6c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cde2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0605a7fc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc80d30>, '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 0x10cae6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc78b20>, '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.a9ZKCohQtp/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.nSoRpypBhb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/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 07:22:20 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 07:22:20 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 07:22:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a9ZKCohQtp/Render', 07:22:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:22:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:22:20 INFO - 'HOME': '/Users/cltbld', 07:22:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:22:20 INFO - 'LOGNAME': 'cltbld', 07:22:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:22:20 INFO - 'MOZ_NO_REMOTE': '1', 07:22:20 INFO - 'NO_EM_RESTART': '1', 07:22:20 INFO - 'PAGER': '/bin/cat', 07:22:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:22:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:22:20 INFO - 'PWD': '/builds/slave/test', 07:22:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:22:20 INFO - 'SHELL': '/bin/bash', 07:22:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nSoRpypBhb/Listeners', 07:22:20 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 07:22:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:22:20 INFO - 'USER': 'cltbld', 07:22:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:22:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:22:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:22:20 INFO - 'XPC_FLAGS': '0x0', 07:22:20 INFO - 'XPC_SERVICE_NAME': '0', 07:22:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:22:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:22:20 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-OEW7uL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:22:20 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-VPVHpb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:22:20 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-UhfFCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:22:20 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-tEECyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:22:20 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-KimXfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:22:20 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-1gOmqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:22:20 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-_zcw2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:22:21 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-KF_8bh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:22:21 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-jjXnpO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:22:21 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-Bu00M2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:22:21 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-m4ZGwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:22:21 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-ONDb53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:22:21 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-Y8DH_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:22:21 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-2iyFpK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:22:21 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-_heyuB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:22:21 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-vLXQ11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:22:21 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-uHE42B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:22:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:22:22 INFO - Running setup.py install for manifestparser 07:22:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:22:22 INFO - Running setup.py install for mozcrash 07:22:22 INFO - Running setup.py install for mozdebug 07:22:22 INFO - Running setup.py install for mozdevice 07:22:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:22:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:22:22 INFO - Running setup.py install for mozfile 07:22:22 INFO - Running setup.py install for mozhttpd 07:22:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:22:22 INFO - Running setup.py install for mozinfo 07:22:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:22:23 INFO - Running setup.py install for mozInstall 07:22:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:22:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:22:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:22:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:22:23 INFO - Running setup.py install for mozleak 07:22:23 INFO - Running setup.py install for mozlog 07:22:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:22:23 INFO - Running setup.py install for moznetwork 07:22:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:22:23 INFO - Running setup.py install for mozprocess 07:22:23 INFO - Running setup.py install for mozprofile 07:22:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:22:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:22:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:22:24 INFO - Running setup.py install for mozrunner 07:22:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:22:24 INFO - Running setup.py install for mozscreenshot 07:22:24 INFO - Running setup.py install for moztest 07:22:24 INFO - Running setup.py install for mozversion 07:22:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:22:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:22:24 INFO - Cleaning up... 07:22:24 INFO - Return code: 0 07:22:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:22:24 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:22:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:22:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:24 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:22:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:22:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:24 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 0x10ce6c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cde2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0605a7fc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc80d30>, '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 0x10cae6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc78b20>, '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.a9ZKCohQtp/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.nSoRpypBhb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/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 07:22:24 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 07:22:24 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 07:22:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a9ZKCohQtp/Render', 07:22:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:22:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:22:24 INFO - 'HOME': '/Users/cltbld', 07:22:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:22:24 INFO - 'LOGNAME': 'cltbld', 07:22:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:22:24 INFO - 'MOZ_NO_REMOTE': '1', 07:22:24 INFO - 'NO_EM_RESTART': '1', 07:22:24 INFO - 'PAGER': '/bin/cat', 07:22:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:22:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:22:24 INFO - 'PWD': '/builds/slave/test', 07:22:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:22:24 INFO - 'SHELL': '/bin/bash', 07:22:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nSoRpypBhb/Listeners', 07:22:24 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 07:22:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:22:24 INFO - 'USER': 'cltbld', 07:22:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:22:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:22:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:22:24 INFO - 'XPC_FLAGS': '0x0', 07:22:24 INFO - 'XPC_SERVICE_NAME': '0', 07:22:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:22:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:22:24 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-G42gAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:22:25 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)) 07:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:22:25 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-lci2bw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:22:25 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)) 07:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:22:25 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-Opqwyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:22:25 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)) 07:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:22:25 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-Ewvg6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:22:25 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)) 07:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:22:25 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-Wy06vQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:22:25 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)) 07:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:22:25 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-9AGiMc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:22:25 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)) 07:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:22:25 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-winIw4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:22:25 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)) 07:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:22:25 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-4mbqsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:22:25 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)) 07:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:22:25 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-jsfCG7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:22:25 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)) 07:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:22:25 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-Zx91mv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:22:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 07:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:22:25 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-LdUh4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:22:26 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)) 07:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:22:26 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-KnP479-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:22:26 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)) 07:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:22:26 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-_V3mXN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:22:26 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)) 07:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:22:26 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-kQdDyr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:22:26 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)) 07:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:22:26 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-zUn2_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:22:26 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)) 07:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:22:26 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-2TsO00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:22:26 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)) 07:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:22:26 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-0OizzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:22:26 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)) 07:22:26 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)) 07:22:26 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)) 07:22:26 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)) 07:22:26 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)) 07:22:26 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)) 07:22:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:22:26 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 07:22:26 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 07:22:26 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 07:22:26 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 07:22:26 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 07:22:26 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 07:22:29 INFO - Downloading blessings-1.6.tar.gz 07:22:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:22:29 INFO - Installing collected packages: blessings 07:22:29 INFO - Running setup.py install for blessings 07:22:29 INFO - Successfully installed blessings 07:22:29 INFO - Cleaning up... 07:22:29 INFO - Return code: 0 07:22:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:22:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:22:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:22:29 INFO - Reading from file tmpfile_stdout 07:22:29 INFO - Current package versions: 07:22:29 INFO - blessings == 1.6 07:22:29 INFO - blobuploader == 1.2.4 07:22:29 INFO - docopt == 0.6.1 07:22:29 INFO - functools32 == 3.2.3-2 07:22:29 INFO - jsonschema == 2.5.1 07:22:29 INFO - manifestparser == 1.1 07:22:29 INFO - mozInstall == 1.12 07:22:29 INFO - mozcrash == 0.17 07:22:29 INFO - mozdebug == 0.1 07:22:29 INFO - mozdevice == 0.48 07:22:29 INFO - mozfile == 1.2 07:22:29 INFO - mozhttpd == 0.7 07:22:29 INFO - mozinfo == 0.9 07:22:29 INFO - mozleak == 0.1 07:22:29 INFO - mozlog == 3.4 07:22:29 INFO - moznetwork == 0.27 07:22:29 INFO - mozprocess == 0.23 07:22:29 INFO - mozprofile == 0.28 07:22:29 INFO - mozrunner == 6.12 07:22:29 INFO - mozscreenshot == 0.1 07:22:29 INFO - mozsystemmonitor == 0.3 07:22:29 INFO - moztest == 0.7 07:22:29 INFO - mozversion == 1.4 07:22:29 INFO - psutil == 3.1.1 07:22:29 INFO - requests == 1.2.3 07:22:29 INFO - wsgiref == 0.1.2 07:22:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:22:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:22:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:22:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:30 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:22:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:22:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:30 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 0x10ce6c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cde2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0605a7fc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc80d30>, '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 0x10cae6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc78b20>, '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.a9ZKCohQtp/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.nSoRpypBhb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/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 07:22:30 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 07:22:30 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 07:22:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a9ZKCohQtp/Render', 07:22:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:22:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:22:30 INFO - 'HOME': '/Users/cltbld', 07:22:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:22:30 INFO - 'LOGNAME': 'cltbld', 07:22:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:22:30 INFO - 'MOZ_NO_REMOTE': '1', 07:22:30 INFO - 'NO_EM_RESTART': '1', 07:22:30 INFO - 'PAGER': '/bin/cat', 07:22:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:22:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:22:30 INFO - 'PWD': '/builds/slave/test', 07:22:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:22:30 INFO - 'SHELL': '/bin/bash', 07:22:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nSoRpypBhb/Listeners', 07:22:30 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 07:22:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:22:30 INFO - 'USER': 'cltbld', 07:22:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:22:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:22:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:22:30 INFO - 'XPC_FLAGS': '0x0', 07:22:30 INFO - 'XPC_SERVICE_NAME': '0', 07:22:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:22:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:22:30 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)) 07:22:30 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)) 07:22:30 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)) 07:22:30 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)) 07:22:30 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)) 07:22:30 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)) 07:22:30 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)) 07:22:30 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)) 07:22:30 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)) 07:22:30 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)) 07:22:30 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)) 07:22:30 INFO - Cleaning up... 07:22:30 INFO - Return code: 0 07:22:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:22:30 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:22:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:22:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:30 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:22:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:22:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:30 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 0x10ce6c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cde2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0605a7fc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc80d30>, '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 0x10cae6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc78b20>, '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.a9ZKCohQtp/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.nSoRpypBhb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/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 07:22:30 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 07:22:30 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 07:22:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a9ZKCohQtp/Render', 07:22:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:22:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:22:30 INFO - 'HOME': '/Users/cltbld', 07:22:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:22:30 INFO - 'LOGNAME': 'cltbld', 07:22:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:22:30 INFO - 'MOZ_NO_REMOTE': '1', 07:22:30 INFO - 'NO_EM_RESTART': '1', 07:22:30 INFO - 'PAGER': '/bin/cat', 07:22:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:22:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:22:30 INFO - 'PWD': '/builds/slave/test', 07:22:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:22:30 INFO - 'SHELL': '/bin/bash', 07:22:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nSoRpypBhb/Listeners', 07:22:30 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 07:22:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:22:30 INFO - 'USER': 'cltbld', 07:22:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:22:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:22:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:22:30 INFO - 'XPC_FLAGS': '0x0', 07:22:30 INFO - 'XPC_SERVICE_NAME': '0', 07:22:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:22:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:22:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:22:31 INFO - Cleaning up... 07:22:31 INFO - Return code: 0 07:22:31 INFO - Running post-action listener: _resource_record_post_action 07:22:31 INFO - Running post-action listener: _start_resource_monitoring 07:22:31 INFO - Starting resource monitoring. 07:22:31 INFO - [mozharness: 2016-10-19 14:22:31.166148Z] Finished create-virtualenv step (success) 07:22:31 INFO - [mozharness: 2016-10-19 14:22:31.167172Z] Running install step. 07:22:31 INFO - Running pre-action listener: _resource_record_pre_action 07:22:31 INFO - Running main action method: install 07:22:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:22:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:22:31 INFO - Reading from file tmpfile_stdout 07:22:31 INFO - Detecting whether we're running mozinstall >=1.0... 07:22:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:22:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:22:31 INFO - Reading from file tmpfile_stdout 07:22:31 INFO - Output received: 07:22:31 INFO - Usage: mozinstall [options] installer 07:22:31 INFO - Options: 07:22:31 INFO - -h, --help show this help message and exit 07:22:31 INFO - -d DEST, --destination=DEST 07:22:31 INFO - Directory to install application into. [default: 07:22:31 INFO - "/builds/slave/test"] 07:22:31 INFO - --app=APP Application being installed. [default: firefox] 07:22:31 INFO - mkdir: /builds/slave/test/build/application 07:22:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:22:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 07:23:04 INFO - Reading from file tmpfile_stdout 07:23:04 INFO - Output received: 07:23:04 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 07:23:04 INFO - Running post-action listener: _resource_record_post_action 07:23:04 INFO - [mozharness: 2016-10-19 14:23:04.670254Z] Finished install step (success) 07:23:04 INFO - [mozharness: 2016-10-19 14:23:04.670402Z] Running run-tests step. 07:23:04 INFO - Running pre-action listener: _resource_record_pre_action 07:23:04 INFO - Running main action method: run_tests 07:23:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:23:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:23:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:23:04 INFO - 2016-10-19 07:23:04.684 screenresolution[1640:7661] starting screenresolution argv=screenresolution get 07:23:04 INFO - 2016-10-19 07:23:04.687 screenresolution[1640:7661] Display 0: 1600x1200x32@60 07:23:04 INFO - 2016-10-19 07:23:04.693 screenresolution[1641:7663] starting screenresolution argv=screenresolution list 07:23:04 INFO - Available Modes on Display 0 07:23:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:23:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:23:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:23:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:23:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:23:04 INFO - Intel Iris: 07:23:04 INFO - Chipset Model: Intel Iris 07:23:04 INFO - Type: GPU 07:23:04 INFO - Bus: Built-In 07:23:04 INFO - VRAM (Dynamic, Max): 1536 MB 07:23:04 INFO - Vendor: Intel (0x8086) 07:23:04 INFO - Device ID: 0x0a2e 07:23:04 INFO - Revision ID: 0x0009 07:23:04 INFO - Displays: 07:23:04 INFO - Display: 07:23:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:23:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:23:04 INFO - Display Serial Number: 1600x1200 60 07:23:04 INFO - Main Display: Yes 07:23:04 INFO - Mirror: Off 07:23:04 INFO - Online: Yes 07:23:04 INFO - Rotation: Supported 07:23:04 INFO - Return code: 0 07:23:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:23:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:23:04 INFO - Python 2.7.3 07:23:04 INFO - Return code: 0 07:23:04 INFO - grabbing minidump binary from tooltool 07:23:04 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:04 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 0x10cc80d30>, '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 0x10cae6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc78b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:23:04 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 07:23:04 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 07:23:04 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 07:23:05 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:23:05 INFO - Return code: 0 07:23:05 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:23:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:23:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:23:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:23:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:23:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U50hLkAbSXe58QmMAydCHw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0027', '--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 07:23:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/U50hLkAbSXe58QmMAydCHw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0027 --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 07:23:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a9ZKCohQtp/Render', 07:23:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:23:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:23:05 INFO - 'HOME': '/Users/cltbld', 07:23:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:23:05 INFO - 'LOGNAME': 'cltbld', 07:23:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:23:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:23:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:05 INFO - 'MOZ_NO_REMOTE': '1', 07:23:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:23:05 INFO - 'NO_EM_RESTART': '1', 07:23:05 INFO - 'PAGER': '/bin/cat', 07:23:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:23:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:05 INFO - 'PWD': '/builds/slave/test', 07:23:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:23:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:23:05 INFO - 'SHELL': '/bin/bash', 07:23:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nSoRpypBhb/Listeners', 07:23:05 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 07:23:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:23:05 INFO - 'USER': 'cltbld', 07:23:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:23:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:23:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:05 INFO - 'XPC_FLAGS': '0x0', 07:23:05 INFO - 'XPC_SERVICE_NAME': '0', 07:23:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:23:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U50hLkAbSXe58QmMAydCHw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0027', '--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 07:23:05 INFO - mozversion application_buildid: 20161019062522 07:23:05 INFO - mozversion application_changeset: 698191832c6455f5060c300fa069e6e94d79948c 07:23:05 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:23:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:23:05 INFO - mozversion application_name: Firefox 07:23:05 INFO - mozversion application_remotingname: firefox-dev 07:23:05 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:23:05 INFO - mozversion application_vendor: Mozilla 07:23:05 INFO - mozversion application_version: 51.0a2 07:23:05 INFO - mozversion platform_buildid: 20161019062522 07:23:05 INFO - mozversion platform_changeset: 698191832c6455f5060c300fa069e6e94d79948c 07:23:05 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:23:05 INFO - mozversion platform_version: 51.0a2 07:23:05 INFO - using testdate: 1476886985 07:23:05 INFO - actual date: 1476886985 07:23:05 INFO - starting webserver on 'localhost:49272' 07:23:05 INFO - SUITE-START | Running 2 tests 07:23:05 INFO - TEST-START | dromaeo_css 07:23:05 INFO - operating with platform_type : mac_ 07:23:05 INFO - Initialising browser for dromaeo_css test... 07:23:05 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/tmpACZNYN/profile http://localhost:49272/getInfo.html) 07:23:07 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 07:23:07 INFO - PROCESS | 1651 | colorDepth:24 07:23:07 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 07:23:07 INFO - PROCESS | 1651 | __metrics 07:23:07 INFO - PROCESS | 1651 | 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" 07:23:07 INFO - PROCESS | 1651 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:23:08 INFO - TEST-INFO | 1651: exit 0 07:23:08 INFO - Browser initialized. 07:23:08 INFO - Running cycle 1/1 for dromaeo_css test... 07:23:08 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/tmpACZNYN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:23:20 INFO - PROCESS | 1653 | RSS: Main: 219705344 07:23:20 INFO - PROCESS | 1653 | 07:24:11 INFO - PROCESS | 1653 | 1476887051350 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] 07:26:22 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 07:26:24 INFO - PROCESS | 1653 | RSS: Main: 376942592 07:26:24 INFO - PROCESS | 1653 | 07:29:27 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 07:29:28 INFO - PROCESS | 1653 | RSS: Main: 349560832 07:29:28 INFO - PROCESS | 1653 | 07:32:30 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 07:32:30 INFO - PROCESS | 1653 | RSS: Main: 321978368 07:32:30 INFO - PROCESS | 1653 | 07:35:33 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 07:35:33 INFO - PROCESS | 1653 | RSS: Main: 335765504 07:35:33 INFO - PROCESS | 1653 | 07:38:37 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 07:38:37 INFO - PROCESS | 1653 | RSS: Main: 310665216 07:38:37 INFO - PROCESS | 1653 | 07:41:40 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 07:41:41 INFO - PROCESS | 1653 | RSS: Main: 374886400 07:41:41 INFO - PROCESS | 1653 | 07:41:41 INFO - PROCESS | 1653 | __start_tp_report 07:41:41 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 07:41:41 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 07:41:41 INFO - PROCESS | 1653 | |i|pagename|runs| 07:41:41 INFO - PROCESS | 1653 | |0;dojo.html;3314.90055298341;3317.784344017639;3355.9764271897075;3371.578552680915;3398.8300584970743;5654.8586285342835;5688.061469857468;5714.942850571493;5737.856553586163;5752.7123643817795;5680.772769089242;5734.397888221739;5757.453041961017;5772.653640781546;5774.6535207887555;5237.423883372845;5240.109181439165;5240.737963101848;5278.6568873023325;5289.3123893893935;5193.350831146106;5210.973945130269;5214.452482489341;5328.946710532884;5350.491703288201;5249.1338929076655;5252.290940722992;5256;5261.210818377236;5279.604029697769;5226.137687281594;5250.396204436501;5278.736063196825;5299.277734736226;5311.867203319909;5058.317127187819;5158.561522270612;5241.79032838686;5248.396434410015;5288.947110528884;4755.643326750473;5542.251796007527;5614.2701448811395;5680.176374425685;5770.336411312711;6204.3795620437595;6277.87444251117;6283.654399008053;6346.809595712136;6349.396807303298;5512.173174023888;6341.04884267359;6360.968195159041;6381.744730210786;6394.232692076934;5614.214010038598;5718.885622287573;5753.223314852525;5779.450952159538;5787.074068149076;6275.466585340206;6278.246610406781;6278.968605156945;6279.937200627935;6287.46556542699;6083.756649733961;6206.596571222856;6209.348018457997;6214.285357183981;6218.19163508741;6161.969190154021;6222.564420490522;6327.651979141099;6330.746770129143;6331.0819931110655;6167.814965551041;6229.3770622937345;6243.906341404882;6299.6535190564955;6323.873522529524;4973.850784476472;6295.716692748837;6303.401176888188;6312.747490100436;6318.399752023551;4865.829695960695;4932.383452068491;4942.085714142895;4969.875753106201;4974.751262436864;4398.428204333416;4405.9559404405545;4438.134563760101;4447.688661793643;4455.1980643484485;5790.247267855236;5791.855203619859;5808.912866307009;5815.011448053841;5840.59115861894;6350.0792385103905;6354.332795056545;6358.491320694333;6364.522660800459;6365;5631.380548139701;5640.661560306395;5690.9146362804595;5740.770369185269;5787.363390027093;5395.379531353866;5421.186821976735;5446.346438427414;5491.203775452617;5493.835184944458;6292.433680968735;6302.023186406114;6315.957866951901;6319.273283572448;6321.936780632227;6142.560166306883;6253.405926436982;6342.8731425370315;6358.173437453286;6373;6224.62652240867;6261.123442717932;6298.275698294755;6310.968445157929;6327.082573026793;6232.470240029648;6265.843353916189;6281.089242059785;6282.277538083179;6296;6175.197224360804;6299.464545513682;6370.681465926593;6371.649559274284;6382.266039405527;5848.970755146197;5989.490893274121;6118.938810612015;6136.079588061648;6199.225096862892;6163.9383606163365;6164.6917654118015;6174.104754810437;6177.4749146323065;6182.227221597301;5925.377835327228;5981.132735753378;5998.25021872266;6018.097285407224;6045.969770151121;6003.8198854034445;6090.269167699905;6119.136988619874;6127.509799215963;6134.099846298167;6002.429769171922;6013.398660133952;6014.548908831943;6037.335893051849;6062.484688801324 07:41:41 INFO - PROCESS | 1653 | |1;ext.html;472.8699607607907;475.20166120916844;497.8605990322709;506.0789363358688;513.8797421620867;30565;41312.793436032814;42315.57684423151;42518.787406063006;42554.574454255446;44472.77763611185;44795.32807007898;44827.77586112073;44893;44928;8486.15138486151;9974.052465015811;9976.750581235454;9987.55056022477;9990.000999900025;9815.460149691764;9906.009399060109;9913.256505762061;9917.801643967116;9924.305298629099;9825.410475371466;9866.703998880044;9915.454649994248;9916.950415247913;9919.950400248024;9838.458884761336;9890.15933645641;9892.752681182992;9892.752681183028;9912;9519.666811661627;9574.569144388519;9585.664501742474;9588.66439674615;9592.08875156859;41899.58100418987;42235.57764422347;42283;42318.78840605808;42481;3290.07877794218;3316.436205845012;3329.217633856042;3456.861725530976;3510.736694747904;29474.85262573695;30267.69732302693;30292.394152117056;32273;32589.6741032589;3179.952300715468;3246.610406751205;3317.502374643823;3390.1016230698883;3391.5251864738957;525817;526115;530043;530347.3482632601;533514;30725.23186920345;62481;62972;63003.73992520124;63094;32170;33169.50245746316;33348.3330333392;33373.16567085794;33485;14911.95616306848;15038.924805375904;15042.398304067934;15056.698866022618;15063.924680376747;12663.113582049167;12727.10910236293;12751.362431878555;12755;12773.936130319475;7620.1998790127345;7794.259545343183;7806.180351063056;7808.22668466702;7886.0536735592095;3250.934981300361;3254.739620830328;3267.122167775678;3269.7711160219033;3275.8034517929;889.7330800759746;925.3707478914403;1017.811704834608;1102.448775612194;1144.2848219862585;29988.850055749583;30939.84530077335;31765.52351714726;32335.35329293448;32516.512252316235;1018.3482571154467;1055.720234137954;1080.8486811846349;1090.3512410115968;1101.6970333158445;15328.846711532966;15881.364745410285;15987.960782549097;16004.351123707738;16226.513204603882;702385;705132;705628;709968;710375;58972.7051364749;59423.70288148532;59538.404615954154;59619.403805962254;59697.70151149217;1187.940602969848;1214.8056310990198;1292.1988367212389;1309.781902830358;1323.6955500235192;31006.844965775028;31228.219294517818;32249.838750806095;32259.838700806347;32677.673223268415;51989.7400512995;52704.736476317375;52742;52933.7353313231;52962.47037529575;586004;589723;591022;591294;592414;23921.52156956886;24482.265532034067;26655;27342.5898611517;27392.17823465299;47335.28997065116;47409.762951185025;47848;48198.518014819405;48544;32187.839060804545;38309.42535861908;39466.802665986484;39652.603473966046;39694;38033.61966380301;40691;40791.7960410196;40892.79553602213;42708.93227669333;38703.80648096742;39204;39229.01927451837;39244.41133382944;39657;31031.68968310288;31725.682743172274;35062.82468587641;35680;35830.46254306135;22919.281053921357;25248.495030099664;25880.22359329223;26279;26768.59847102334 07:41:41 INFO - PROCESS | 1653 | |2;jquery.html;326.88722390775183;378.977261364318;386.2506736930356;391.6905644540813;406.3843277434687;18741.62516749664;19200.711989320152;20271.59456810863;20517.38447846567;20550.58898822023;16693;19819.60360792783;19993.700094498596;20501.589968200664;20720.585588288264;5928.614640048405;5930.318013428447;6090.360512146227;6176.81469555914;6209.689515524228;6059.18201042858;6073.696315184246;6135.141080248769;6136.110264011716;6151.477124444427;5756.971215143939;5993.970030149843;6036.788712395067;6062.545309101813;6081.331053584102;5996.760129594811;6006.729697163594;6045.637261764308;6050.546209034318;6057.545684073712;5040.1179793535985;5144.202648589475;5267.078261304295;5272.736363181825;5294.841154765363;21065.5786884263;23834.523309533713;24496.387590310205;24504.754952450425;24954.001839926383;2075.6782698681727;2297.4945511987335;2360.5514952159206;2366.432056306491;2588.145911849085;12248;12986;15291.08253504782;15382.461613843461;15579.298931548108;1842.4288470574165;1842.7420161177447;1850.047225678763;1926.7687877454796;1954.1694779718705;102240.48879755627;103549.48225258825;103710.48144759303;103858;104585.47707261491;8652.826943461221;10356.948215258875;10512.053915147673;10609.84085238722;11005.504752286166;13576.796348054788;13583.660408489866;13598.728025439435;13601.115927464683;13614;8226.753197404087;8445.95777021111;8479.491230526188;8611.268042216356;8651.740447786577;6872.931270687329;8418.494890306602;8436.40945133847;8589.26991205742;8680.088590697886;6270;6396.584222025646;6454.419102280817;6474.935250647527;6608.603483790988;1462.283481094256;1569.4506922577007;1729.6281299520413;1888.9905550472436;1899.7340372347883;810.4003037752021;874.0210963720674;925.6019911438146;989.5744829723288;989.6239429016928;20445.693314600292;21587.784122158577;21598;21651.242206522697;21711.565768684854;873.8077622922947;904.4844438670026;940.8400571902793;965.0783501755807;980.578351308944;8829.426087304304;9547.2839537035;10140.239482038876;11187.440627968568;11462;490091;497230;536386;582959;592201;88003.79990500289;88056;89544.20911581731;103086;103952;915.8305713443034;1003.5132960514145;1004.4877112672443;1007.1137399088755;1007.450939238117;13437.529686460926;18854.24583016664;20124.082008109035;20138.295159669342;20165.991700414626;35532.82233588919;40320;50234;50961.7451912738;53298.46701532935;69255;71791.56416871528;72198.27801722125;72367;72424.63787681238;7699.538027718355;7876.369890408639;7957.323627491496;8079.232472915063;8079.676812927417;12874.485020599072;12903.290319032543;12906.290154041619;12989.480420783062;13333.066685331934;11207.43962801873;11350.375729334966;11628.302301861915;11642.24325418879;11643.068554515448;11000.009999100119;11170.776584468427;11211.103111751203;11340.6030788922;11810.114241432098;11402.48688808989;11412.144089193509;11511.021563166889;11537.88462115368;11703.590374336858;6624.304448032887;6625.569337993015;7809.648565814438;7950.363970882431;8198.016238051472;10819.459027048773;10847.40339281347;10918.945405272923;11087.72280692989;11092.389918554558 07:41:41 INFO - PROCESS | 1653 | |3;mootools.html;1341.9463221471142;1513.409770189626;1622.6998005369007;1850.8426783723382;1862.4133397979626;8524.616392262347;9061.954690226548;9069.546522673872;9117.997020327759;9130.269578433727;7934.682612695486;8181.5909204539685;8558.186972237627;8816.77958051049;8829.072947340534;2354.5879471092576;2364.7162340519117;2369.2892132360307;2398.46034642205;2403.435192729707;2368.1356304948654;2385.7017872765905;2413.1674572272536;2413.456972181254;2414.468816860288;2388.5103553771523;2391.7369089400154;2409.204962362416;2416.299273210767;2421.6730741349957;2360.5986982213067;2375.6555299481565;2382.130522359335;2383.7258715247794;2395.077895010416;2364.645303204516;2375.9881200593886;2381.2499062795337;2383.785459308653;2386.4511162432564;8727.738167854974;8909.599068041955;8919.018907920123;8928.15182557656;8939.463632182025;5266.34170728659;5428.61999660024;5443.292371991655;5447.291852059207;5454.318210223722;2869;3478.704310133616;3485.1809824691177;3496.370653282408;3658.798766067865;1084.6366467233408;1089.5478376473754;1090.5637744902024;1114.7213196700825;1117.987622279893;11757;11806.527738890434;11809.23239989398;11823.408829558488;11832.585859494962;4545.977270113628;4657.441107067174;4824.155772739757;4829.13075646387;4830.3237546743485;9824.705258842247;9884.901150988399;9904.752381190528;9906.504674766233;9915.900840991499;5359.758810853521;5372.543333816591;5374.704391258519;5374.91937620936;5383.757730902119;4406.515283318832;4508.391367165456;4556.954430455719;4856.441509226484;4904.803807847647;3860.517435320585;3913.3934240192816;3981.960180398217;4008.8797336079965;4009.4386785850006;1278.213898452445;1285.6850071732486;1291.5156816193928;1302.3293004102895;1308.476609356265;751.6842925971105;806.3589446390017;915.3135148638521;919.3013309884402;930.418488444722;5590.692511911802;5657.377688454267;5726.226959360433;5864.67744274069;6059.333473317932;881.8350948421737;933.9719808405758;943.7923656795494;947.6920000999703;964.5466630683568;3759.4548790425233;3895.3183192941124;3912.4326972588815;3927.2930872443235;4059;10609.734756631146;10798.892011079946;10922.235443519035;10926.836097458545;10991.505382257817;10737.248392612599;10843.728906777395;10850.348979061282;10868.510917008754;10879.782404351869;7862.135165131831;8184.304334131665;8205.71280005197;8218.547979861045;8282.25459708617;5974.2233509643465;5996.340402555628;6042.1843051187525;6044.546659000504;6066.636001839904;10108.646197383056;10244.846327304947;10254.6410875619;10259.94870025675;10286.434246116536;9753.122219000325;10156.746081348025;10175.7456063599;10286.382817031003;10365.222608304559;6934.618595977269;7155;7157.57054576727;7442.06974128234;7639.121501027453;8064.314533264738;8178.713745018896;8332.541710205996;8455.985281765981;8459.492430454193;7392.149902761252;7465.29079737424;7504;7519.172890982097;7675.616219188906;7356.816079598053;7423.294786995227;7430.554166750012;7463.626818659154;7604.961975190088;6910.170779506491;7054.470914681522;7059.541129826544;7072.5402848814665;7074.469414793808;4833.709977401367;4901.14230009754;4926.729029903389;4956.330895329084;4957.950420495749;4825.758712064313;4851.878703032452;4870.610351171968;5016.824411145738;5050.873728156826 07:41:41 INFO - PROCESS | 1653 | |4;prototype.html;288.40012773431266;297.3057909780662;305.7859498351154;311.83005262132133;311.9204602826282;4343.609075183237;5486.7902277167905;5508.118701007839;5548.361938377083;5548.889022219553;4344.804483798229;4515.39042229299;5044.419891712454;5362.812301569436;5424.267723857278;4130.327217476926;4132.132252227036;4142.357934520139;4151.252774500589;4177.657873701042;3600.037979301274;3996.340603800384;4125.154343359604;4151.730137541065;4182.247195504808;3914.5498267699295;4053.695972802037;4067;4078.2455245779624;4102.958970410303;3736.4021756518828;4063.5326937402283;4070.3080476319096;4103.425520427142;4122.587741225883;3519.8592056317716;3523.3305671922253;3523.9295214095573;3524.594671612772;3537.363274610569;4168.478940132483;4782.321899736124;5229.947700522984;5273.2617433559335;5310.389305229909;3842.7886466244345;4538.7503687297185;4691.091523255569;4706.599939005188;4711.552402521755;5712.485876271156;5726.713664316768;5734.4265573442735;5740.54075673945;5751.539876809845;3381.205416727067;3901.590333015021;3902.4731661225655;3911.647951684362;3913.726039177259;5138.948610513884;5207.864775442088;5428.61999660024;5569.969555632221;5981.760729570812;3363.9327213455595;3464.7747896386654;3673.7244706647107;3964.861229856941;3973.3113426794075;4013.2174226025645;4015.1768887378016;4025.456563363967;4028.576999415078;4047.514298284225;4399.956000440018;4500.414946057057;4547.545245475492;4741.383620129361;4744.501827308152;5036.722980236123;5727.828165155052;5747.568932330092;5761.423857614205;5773.711314434346;1306.1118439461256;1319.7162610038888;1352.6888815572474;1358.7825947848296;1358.8233529641084;648.6043513456788;730.6967608442437;734.1997223026926;771.8807728793272;823.6615499812805;4431.623312018514;4483.820647174077;4504.932426013613;4515.916180116748;4539.6368290536675;4200.991761977103;4321.805518751664;4506.654153729465;4747.667663263538;4917.139500587383;3865.845366185321;3900.6790959379123;3965.4138344661787;4423.690341676116;4449.933251001237;2473.727889932106;2738.3427977285705;3034.924126896801;3062.632484101922;3070.5240687693445;4985.750712464363;5750.211147593413;6012.518998480111;6059.969700151471;6078.483328917092;5607.7476513556985;5676.205331253628;5908.497777688945;6036.909446358308;6059.394060593993;4867.7322747249245;6002.369751176151;6053.273607167168;6059.818205453844;6094.695265236721;5107.719075450886;5808.896309701143;5878;5886.23478947734;5893.410658934073;5535.280413546213;5815.5929084963645;5839.824805255849;5857.389217965094;5904.468597826216;5032.421271553671;5119.74401279927;5825.281541945221;6152.384761523812;6169.074638804036;3483.4774783782636;3974.4038394241097;4001.639852413297;4093.63157315843;4111.93089796661;4999.325091112653;5777.075667893117;5854.824355269348;5904.52763778888;5934.258217722785;5332.786688532416;5396.030448886207;5482.369527504388;5786.334571524329;5824.854378640398;5694.501343938243;5711.658679672438;5725.139329717775;5736.71316434185;5834.649921004753;4639.35049093134;4833.975830120827;4964.00719856023;5677.489025987516;5682.232898558807;4775.283707443911;4818.927716084191;4924.606031517542;5422.376426710979;5515;5594.188842617879;5657.811859509549;5661.773529058792;5670.574706897081;5676.637606974214 07:41:41 INFO - PROCESS | 1653 | |5;yui.html;677.5223467455442;696.2793508718476;759.8670232709275;812.6140083460353;814.3444527155638;12417.627471175869;15792.289346979385;15984.200789960514;15985.920070399647;16074.115923624197;14409.279536023208;14450.710985780279;14457.277136143177;14475.855241447582;14497.63755906103;650.8503044299814;677.8813707601174;682.2529330383247;786.8504984053012;813.5891374855689;819.635262308273;827.9586020698971;829.4691397505601;831.7255305749088;835.3567752830317;884.4958373726978;885.7342797160858;885.8981217160044;886.7251152142857;887.0863011098579;880.075920283706;880.4805164952645;880.7886107334258;882.1090698394604;882.32942963348;508.61091265182165;527.5199568392783;622.7758007117434;637.9840503987391;643.0579201469869;14573.052751571115;14589.854101459061;14602.707945841024;14604.12375257488;14604.561863144123;13435;13797.310134493335;13938.790918136236;14025.158490490501;14284;10295.588176472933;12283.508659653604;12390.75218495625;12551.811722824164;12660.17708848922;4500.879310858739;4504.527024662429;4592.586667199935;4649.535046495357;4663.27719203524;120727;122286.38856805747;122902.38548807288;123156;123541;10601.84097238542;10933.343999360064;10946.288491248044;11017.779644407066;11287.49206285719;18087.73385862977;21198;21522.031508582153;21636.78363216379;21727.34817955464;7805.960970195113;7810.453268271166;7846.8430631387055;7868.960655196687;8084.878726819103;4285.764282964405;4286.442762440863;4322.308430651081;4415.955840441618;4606.262997920317;3380.2056516718553;3490.930181396358;3493.3537295600395;3498.1429549760473;3499.1951851074396;648.4293821437105;656.3698849104912;657.4740207833714;671.0069097735379;712.056525104239;607.3592360060179;620.4385031546458;644.44899610833;644.5520363347429;655.4134050025201;9248.722538323862;9682.467464289392;9833;9872.802543949225;9876.901230987742;633.2174927578851;643.9678016099176;661.5170925224517;680.2653134614604;687.1788213085415;4518.390017347681;4672.229082201467;4702.177119004161;4709.058188362341;4751.263554149113;156667.43332566528;170674.14662926606;172550;175148;176117;138932;145618.81571776432;146503.6048918534;147545.26227369008;153039;123782;126476;127741.3612931948;128675;129171;8974.685885993958;8997.550122493718;9018.729438116867;9027.277817774431;9206.815863682823;53012.73493632507;55297.72351138219;58688.82622347444;60366.69816650889;63905;79081.60459197668;93596.59605105793;99700;99960.50019749855;102217;11534.59628912984;11772.882271177521;11861.76276474483;11927.880721192678;12299;10791.6222932197;12728.68178295513;13557.728845422838;13990.510332138327;14105.94205434576;10748.570057197625;11712.648620541397;11939.641810745692;12440.937795310965;12517.436715347649;13201.339933003503;13203.405846737112;13722.313884305546;13990.440382384997;14401.279936003368;13472.86527134716;13910.51313204033;13986.020978531405;14609.634759131106;14610.342534586182;11316.303733950319;11325.207235493437;11377.943110284396;11809.940950295193;12066.818997714865;11578.478968446272;11619.244749091282;11734.647960561197;11767.76464470723;11894.762104758029 07:41:41 INFO - PROCESS | 1653 | __end_tp_report 07:41:41 INFO - PROCESS | 1653 | __start_cc_report 07:41:41 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,1545 07:41:41 INFO - PROCESS | 1653 | __end_cc_report 07:41:41 INFO - PROCESS | 1653 | __startTimestamp1476888101216__endTimestamp 07:41:41 INFO - PROCESS | 1653 | 07:41:41 INFO - PROCESS | 1653 | ------- Summary: start ------- 07:41:41 INFO - PROCESS | 1653 | Number of tests: 6 07:41:41 INFO - PROCESS | 1653 | 07:41:41 INFO - PROCESS | 1653 | [#0] dojo.html Cycles:165 Average:5766.38 Median:6002.43 stddev:657.08 (10.9%) stddev-sans-first:630.32 07:41:41 INFO - PROCESS | 1653 | Values: 3314.9 3317.8 3356.0 3371.6 3398.8 5654.9 5688.1 5714.9 5737.9 5752.7 5680.8 5734.4 5757.5 5772.7 5774.7 5237.4 5240.1 5240.7 5278.7 5289.3 5193.4 5211.0 5214.5 5328.9 5350.5 5249.1 5252.3 5256.0 5261.2 5279.6 5226.1 5250.4 5278.7 5299.3 5311.9 5058.3 5158.6 5241.8 5248.4 5288.9 4755.6 5542.3 5614.3 5680.2 5770.3 6204.4 6277.9 6283.7 6346.8 6349.4 5512.2 6341.0 6361.0 6381.7 6394.2 5614.2 5718.9 5753.2 5779.5 5787.1 6275.5 6278.2 6279.0 6279.9 6287.5 6083.8 6206.6 6209.3 6214.3 6218.2 6162.0 6222.6 6327.7 6330.7 6331.1 6167.8 6229.4 6243.9 6299.7 6323.9 4973.9 6295.7 6303.4 6312.7 6318.4 4865.8 4932.4 4942.1 4969.9 4974.8 4398.4 4406.0 4438.1 4447.7 4455.2 5790.2 5791.9 5808.9 5815.0 5840.6 6350.1 6354.3 6358.5 6364.5 6365.0 5631.4 5640.7 5690.9 5740.8 5787.4 5395.4 5421.2 5446.3 5491.2 5493.8 6292.4 6302.0 6316.0 6319.3 6321.9 6142.6 6253.4 6342.9 6358.2 6373.0 6224.6 6261.1 6298.3 6311.0 6327.1 6232.5 6265.8 6281.1 6282.3 6296.0 6175.2 6299.5 6370.7 6371.6 6382.3 5849.0 5989.5 6118.9 6136.1 6199.2 6163.9 6164.7 6174.1 6177.5 6182.2 5925.4 5981.1 5998.3 6018.1 6046.0 6003.8 6090.3 6119.1 6127.5 6134.1 6002.4 6013.4 6014.5 6037.3 6062.5 07:41:41 INFO - PROCESS | 1653 | 07:41:41 INFO - PROCESS | 1653 | [#1] ext.html Cycles:180 Average:72606.65 Median:40192.50 stddev:164404.53 (409.0%) stddev-sans-first:164776.52 07:41:41 INFO - PROCESS | 1653 | Values: 472.9 475.2 497.9 506.1 513.9 30565.0 41312.8 42315.6 42518.8 42554.6 44472.8 44795.3 44827.8 44893.0 44928.0 8486.2 9974.1 9976.8 9987.6 9990.0 9815.5 9906.0 9913.3 9917.8 9924.3 9825.4 9866.7 9915.5 9917.0 9920.0 9838.5 9890.2 9892.8 9892.8 9912.0 9519.7 9574.6 9585.7 9588.7 9592.1 41899.6 42235.6 42283.0 42318.8 42481.0 3290.1 3316.4 3329.2 3456.9 3510.7 29474.9 30267.7 30292.4 32273.0 32589.7 3180.0 3246.6 3317.5 3390.1 3391.5 525817.0 526115.0 530043.0 530347.3 533514.0 30725.2 62481.0 62972.0 63003.7 63094.0 32170.0 33169.5 33348.3 33373.2 33485.0 14912.0 15038.9 15042.4 15056.7 15063.9 12663.1 12727.1 12751.4 12755.0 12773.9 7620.2 7794.3 7806.2 7808.2 7886.1 3250.9 3254.7 3267.1 3269.8 3275.8 889.7 925.4 1017.8 1102.4 1144.3 29988.9 30939.8 31765.5 32335.4 32516.5 1018.3 1055.7 1080.8 1090.4 1101.7 15328.8 15881.4 15988.0 16004.4 16226.5 702385.0 705132.0 705628.0 709968.0 710375.0 58972.7 59423.7 59538.4 59619.4 59697.7 1187.9 1214.8 1292.2 1309.8 1323.7 31006.8 31228.2 32249.8 32259.8 32677.7 51989.7 52704.7 52742.0 52933.7 52962.5 586004.0 589723.0 591022.0 591294.0 592414.0 23921.5 24482.3 26655.0 27342.6 27392.2 47335.3 47409.8 47848.0 48198.5 48544.0 32187.8 38309.4 39466.8 39652.6 39694.0 38033.6 40691.0 40791.8 40892.8 42708.9 38703.8 39204.0 39229.0 39244.4 39657.0 31031.7 31725.7 35062.8 35680.0 35830.5 22919.3 25248.5 25880.2 26279.0 26768.6 07:41:41 INFO - PROCESS | 1653 | 07:41:41 INFO - PROCESS | 1653 | [#2] jquery.html Cycles:180 Average:31732.10 Median:24729.38 stddev:89666.31 (362.6%) stddev-sans-first:89886.84 07:41:41 INFO - PROCESS | 1653 | Values: 326.9 379.0 386.3 391.7 406.4 18741.6 19200.7 20271.6 20517.4 20550.6 16693.0 19819.6 19993.7 20501.6 20720.6 5928.6 5930.3 6090.4 6176.8 6209.7 6059.2 6073.7 6135.1 6136.1 6151.5 5757.0 5994.0 6036.8 6062.5 6081.3 5996.8 6006.7 6045.6 6050.5 6057.5 5040.1 5144.2 5267.1 5272.7 5294.8 21065.6 23834.5 24496.4 24504.8 24954.0 2075.7 2297.5 2360.6 2366.4 2588.1 12248.0 12986.0 15291.1 15382.5 15579.3 1842.4 1842.7 1850.0 1926.8 1954.2 102240.5 103549.5 103710.5 103858.0 104585.5 8652.8 10356.9 10512.1 10609.8 11005.5 13576.8 13583.7 13598.7 13601.1 13614.0 8226.8 8446.0 8479.5 8611.3 8651.7 6872.9 8418.5 8436.4 8589.3 8680.1 6270.0 6396.6 6454.4 6474.9 6608.6 1462.3 1569.5 1729.6 1889.0 1899.7 810.4 874.0 925.6 989.6 989.6 20445.7 21587.8 21598.0 21651.2 21711.6 873.8 904.5 940.8 965.1 980.6 8829.4 9547.3 10140.2 11187.4 11462.0 490091.0 497230.0 536386.0 582959.0 592201.0 88003.8 88056.0 89544.2 103086.0 103952.0 915.8 1003.5 1004.5 1007.1 1007.5 13437.5 18854.2 20124.1 20138.3 20166.0 35532.8 40320.0 50234.0 50961.7 53298.5 69255.0 71791.6 72198.3 72367.0 72424.6 7699.5 7876.4 7957.3 8079.2 8079.7 12874.5 12903.3 12906.3 12989.5 13333.1 11207.4 11350.4 11628.3 11642.2 11643.1 11000.0 11170.8 11211.1 11340.6 11810.1 11402.5 11412.1 11511.0 11537.9 11703.6 6624.3 6625.6 7809.6 7950.4 8198.0 10819.5 10847.4 10918.9 11087.7 11092.4 07:41:41 INFO - PROCESS | 1653 | 07:41:41 INFO - PROCESS | 1653 | [#3] mootools.html Cycles:180 Average:5740.12 Median:4863.53 stddev:3230.45 (66.4%) stddev-sans-first:3222.60 07:41:41 INFO - PROCESS | 1653 | Values: 1341.9 1513.4 1622.7 1850.8 1862.4 8524.6 9062.0 9069.5 9118.0 9130.3 7934.7 8181.6 8558.2 8816.8 8829.1 2354.6 2364.7 2369.3 2398.5 2403.4 2368.1 2385.7 2413.2 2413.5 2414.5 2388.5 2391.7 2409.2 2416.3 2421.7 2360.6 2375.7 2382.1 2383.7 2395.1 2364.6 2376.0 2381.2 2383.8 2386.5 8727.7 8909.6 8919.0 8928.2 8939.5 5266.3 5428.6 5443.3 5447.3 5454.3 2869.0 3478.7 3485.2 3496.4 3658.8 1084.6 1089.5 1090.6 1114.7 1118.0 11757.0 11806.5 11809.2 11823.4 11832.6 4546.0 4657.4 4824.2 4829.1 4830.3 9824.7 9884.9 9904.8 9906.5 9915.9 5359.8 5372.5 5374.7 5374.9 5383.8 4406.5 4508.4 4557.0 4856.4 4904.8 3860.5 3913.4 3982.0 4008.9 4009.4 1278.2 1285.7 1291.5 1302.3 1308.5 751.7 806.4 915.3 919.3 930.4 5590.7 5657.4 5726.2 5864.7 6059.3 881.8 934.0 943.8 947.7 964.5 3759.5 3895.3 3912.4 3927.3 4059.0 10609.7 10798.9 10922.2 10926.8 10991.5 10737.2 10843.7 10850.3 10868.5 10879.8 7862.1 8184.3 8205.7 8218.5 8282.3 5974.2 5996.3 6042.2 6044.5 6066.6 10108.6 10244.8 10254.6 10259.9 10286.4 9753.1 10156.7 10175.7 10286.4 10365.2 6934.6 7155.0 7157.6 7442.1 7639.1 8064.3 8178.7 8332.5 8456.0 8459.5 7392.1 7465.3 7504.0 7519.2 7675.6 7356.8 7423.3 7430.6 7463.6 7605.0 6910.2 7054.5 7059.5 7072.5 7074.5 4833.7 4901.1 4926.7 4956.3 4958.0 4825.8 4851.9 4870.6 5016.8 5050.9 07:41:41 INFO - PROCESS | 1653 | 07:41:41 INFO - PROCESS | 1653 | [#4] prototype.html Cycles:180 Average:4505.55 Median:4800.62 stddev:1409.70 (29.4%) stddev-sans-first:1377.66 07:41:41 INFO - PROCESS | 1653 | Values: 288.4 297.3 305.8 311.8 311.9 4343.6 5486.8 5508.1 5548.4 5548.9 4344.8 4515.4 5044.4 5362.8 5424.3 4130.3 4132.1 4142.4 4151.3 4177.7 3600.0 3996.3 4125.2 4151.7 4182.2 3914.5 4053.7 4067.0 4078.2 4103.0 3736.4 4063.5 4070.3 4103.4 4122.6 3519.9 3523.3 3523.9 3524.6 3537.4 4168.5 4782.3 5229.9 5273.3 5310.4 3842.8 4538.8 4691.1 4706.6 4711.6 5712.5 5726.7 5734.4 5740.5 5751.5 3381.2 3901.6 3902.5 3911.6 3913.7 5138.9 5207.9 5428.6 5570.0 5981.8 3363.9 3464.8 3673.7 3964.9 3973.3 4013.2 4015.2 4025.5 4028.6 4047.5 4400.0 4500.4 4547.5 4741.4 4744.5 5036.7 5727.8 5747.6 5761.4 5773.7 1306.1 1319.7 1352.7 1358.8 1358.8 648.6 730.7 734.2 771.9 823.7 4431.6 4483.8 4504.9 4515.9 4539.6 4201.0 4321.8 4506.7 4747.7 4917.1 3865.8 3900.7 3965.4 4423.7 4449.9 2473.7 2738.3 3034.9 3062.6 3070.5 4985.8 5750.2 6012.5 6060.0 6078.5 5607.7 5676.2 5908.5 6036.9 6059.4 4867.7 6002.4 6053.3 6059.8 6094.7 5107.7 5808.9 5878.0 5886.2 5893.4 5535.3 5815.6 5839.8 5857.4 5904.5 5032.4 5119.7 5825.3 6152.4 6169.1 3483.5 3974.4 4001.6 4093.6 4111.9 4999.3 5777.1 5854.8 5904.5 5934.3 5332.8 5396.0 5482.4 5786.3 5824.9 5694.5 5711.7 5725.1 5736.7 5834.6 4639.4 4834.0 4964.0 5677.5 5682.2 4775.3 4818.9 4924.6 5422.4 5515.0 5594.2 5657.8 5661.8 5670.6 5676.6 07:41:41 INFO - PROCESS | 1653 | 07:41:41 INFO - PROCESS | 1653 | [#5] yui.html Cycles:180 Average:26658.68 Median:12553.78 stddev:44700.48 (356.1%) stddev-sans-first:44783.31 07:41:41 INFO - PROCESS | 1653 | Values: 677.5 696.3 759.9 812.6 814.3 12417.6 15792.3 15984.2 15985.9 16074.1 14409.3 14450.7 14457.3 14475.9 14497.6 650.9 677.9 682.3 786.9 813.6 819.6 828.0 829.5 831.7 835.4 884.5 885.7 885.9 886.7 887.1 880.1 880.5 880.8 882.1 882.3 508.6 527.5 622.8 638.0 643.1 14573.1 14589.9 14602.7 14604.1 14604.6 13435.0 13797.3 13938.8 14025.2 14284.0 10295.6 12283.5 12390.8 12551.8 12660.2 4500.9 4504.5 4592.6 4649.5 4663.3 120727.0 122286.4 122902.4 123156.0 123541.0 10601.8 10933.3 10946.3 11017.8 11287.5 18087.7 21198.0 21522.0 21636.8 21727.3 7806.0 7810.5 7846.8 7869.0 8084.9 4285.8 4286.4 4322.3 4416.0 4606.3 3380.2 3490.9 3493.4 3498.1 3499.2 648.4 656.4 657.5 671.0 712.1 607.4 620.4 644.4 644.6 655.4 9248.7 9682.5 9833.0 9872.8 9876.9 633.2 644.0 661.5 680.3 687.2 4518.4 4672.2 4702.2 4709.1 4751.3 156667.4 170674.1 172550.0 175148.0 176117.0 138932.0 145618.8 146503.6 147545.3 153039.0 123782.0 126476.0 127741.4 128675.0 129171.0 8974.7 8997.6 9018.7 9027.3 9206.8 53012.7 55297.7 58688.8 60366.7 63905.0 79081.6 93596.6 99700.0 99960.5 102217.0 11534.6 11772.9 11861.8 11927.9 12299.0 10791.6 12728.7 13557.7 13990.5 14105.9 10748.6 11712.6 11939.6 12440.9 12517.4 13201.3 13203.4 13722.3 13990.4 14401.3 13472.9 13910.5 13986.0 14609.6 14610.3 11316.3 11325.2 11377.9 11809.9 12066.8 11578.5 11619.2 11734.6 11767.8 11894.8 07:41:41 INFO - PROCESS | 1653 | -------- Summary: end -------- 07:41:41 INFO - PROCESS | 1653 | 07:41:41 INFO - TEST-INFO | 1653: exit 0 07:41:41 INFO - TEST-OK | dromaeo_css | took 1116540ms 07:41:41 INFO - TEST-START | kraken 07:41:41 INFO - operating with platform_type : mac_ 07:41:41 INFO - Initialising browser for kraken test... 07:41:41 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/tmpO31wqI/profile http://localhost:49272/getInfo.html) 07:41:44 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 07:41:44 INFO - PROCESS | 1660 | colorDepth:24 07:41:44 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 07:41:44 INFO - PROCESS | 1660 | __metrics 07:41:44 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" 07:41:44 INFO - PROCESS | 1660 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:41:44 INFO - TEST-INFO | 1660: exit 0 07:41:44 INFO - Browser initialized. 07:41:44 INFO - Running cycle 1/1 for kraken test... 07:41:44 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/tmpO31wqI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:41:56 INFO - PROCESS | 1661 | RSS: Main: 219652096 07:41:56 INFO - PROCESS | 1661 | 07:41:59 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 07:42:00 INFO - PROCESS | 1661 | RSS: Main: 269238272 07:42:00 INFO - PROCESS | 1661 | 07:42:02 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 07:42:03 INFO - PROCESS | 1661 | RSS: Main: 279842816 07:42:03 INFO - PROCESS | 1661 | 07:42:06 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 07:42:07 INFO - PROCESS | 1661 | RSS: Main: 375865344 07:42:07 INFO - PROCESS | 1661 | 07:42:09 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 07:42:09 INFO - PROCESS | 1661 | RSS: Main: 279871488 07:42:09 INFO - PROCESS | 1661 | 07:42:11 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:42:12 INFO - PROCESS | 1661 | RSS: Main: 281006080 07:42:12 INFO - PROCESS | 1661 | 07:42:15 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 07:42:15 INFO - PROCESS | 1661 | RSS: Main: 318214144 07:42:15 INFO - PROCESS | 1661 | 07:42:18 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 07:42:19 INFO - PROCESS | 1661 | RSS: Main: 318808064 07:42:19 INFO - PROCESS | 1661 | 07:42:22 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 07:42:22 INFO - PROCESS | 1661 | RSS: Main: 316256256 07:42:22 INFO - PROCESS | 1661 | 07:42:24 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:42:25 INFO - PROCESS | 1661 | RSS: Main: 289681408 07:42:25 INFO - PROCESS | 1661 | 07:42:26 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:42:27 INFO - PROCESS | 1661 | RSS: Main: 294916096 07:42:27 INFO - PROCESS | 1661 | 07:42:29 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:42:30 INFO - PROCESS | 1661 | RSS: Main: 296620032 07:42:30 INFO - PROCESS | 1661 | 07:42:33 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:42:34 INFO - PROCESS | 1661 | RSS: Main: 314216448 07:42:34 INFO - PROCESS | 1661 | 07:42:36 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:42:37 INFO - PROCESS | 1661 | RSS: Main: 307814400 07:42:37 INFO - PROCESS | 1661 | 07:42:39 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 07:42:39 INFO - PROCESS | 1661 | RSS: Main: 351375360 07:42:39 INFO - PROCESS | 1661 | 07:42:39 INFO - PROCESS | 1661 | __start_tp_report 07:42:39 INFO - PROCESS | 1661 | _x_x_mozilla_page_load 07:42:39 INFO - PROCESS | 1661 | _x_x_mozilla_page_load_details 07:42:39 INFO - PROCESS | 1661 | |i|pagename|runs| 07:42:39 INFO - PROCESS | 1661 | |0;ai-astar;114;116;115;114;112;114;113;114;114;113 07:42:39 INFO - PROCESS | 1661 | |1;audio-beat-detection;140;104;108;143;108;109;108;108;138;109 07:42:39 INFO - PROCESS | 1661 | |2;audio-dft;182;183;186;185;182;184;183;184;182;183 07:42:39 INFO - PROCESS | 1661 | |3;audio-fft;80;60;59;87;62;59;57;58;81;57 07:42:39 INFO - PROCESS | 1661 | |4;audio-oscillator;88;70;94;69;68;69;93;68;68;90 07:42:39 INFO - PROCESS | 1661 | |5;imaging-gaussian-blur;91;88;92;86;134;130;94;89;91;88 07:42:39 INFO - PROCESS | 1661 | |6;imaging-darkroom;100;100;101;101;100;101;101;101;100;100 07:42:39 INFO - PROCESS | 1661 | |7;imaging-desaturate;86;85;86;83;84;98;140;133;86;85 07:42:39 INFO - PROCESS | 1661 | |8;json-parse-financial;57;55;55;54;54;57;56;85;57;57 07:42:39 INFO - PROCESS | 1661 | |9;json-stringify-tinderbox;62;67;77;76;73;70;69;70;70;77 07:42:39 INFO - PROCESS | 1661 | |10;stanford-crypto-aes;83;82;82;82;83;82;84;80;94;103 07:42:39 INFO - PROCESS | 1661 | |11;stanford-crypto-ccm;140;135;138;139;128;148;156;156;180;137 07:42:39 INFO - PROCESS | 1661 | |12;stanford-crypto-pbkdf2;165;163;163;163;151;199;210;162;166;163 07:42:39 INFO - PROCESS | 1661 | |13;stanford-crypto-sha256-iterative;67;67;66;67;67;67;79;71;85;85 07:42:39 INFO - PROCESS | 1661 | __end_tp_report 07:42:39 INFO - PROCESS | 1661 | __start_cc_report 07:42:39 INFO - PROCESS | 1661 | _x_x_mozilla_cycle_collect,2036 07:42:39 INFO - PROCESS | 1661 | __end_cc_report 07:42:39 INFO - PROCESS | 1661 | __startTimestamp1476888159635__endTimestamp 07:42:39 INFO - PROCESS | 1661 | 07:42:39 INFO - PROCESS | 1661 | ------- Summary: start ------- 07:42:39 INFO - PROCESS | 1661 | Number of tests: 14 07:42:39 INFO - PROCESS | 1661 | 07:42:39 INFO - PROCESS | 1661 | [#0] ai-astar Cycles:10 Average:113.90 Median:114.00 stddev:1.10 (1.0%) stddev-sans-first:1.17 07:42:39 INFO - PROCESS | 1661 | Values: 114.0 116.0 115.0 114.0 112.0 114.0 113.0 114.0 114.0 113.0 07:42:39 INFO - PROCESS | 1661 | 07:42:39 INFO - PROCESS | 1661 | [#1] audio-beat-detection Cycles:10 Average:117.50 Median:109.00 stddev:15.86 (14.6%) stddev-sans-first:14.59 07:42:39 INFO - PROCESS | 1661 | Values: 140.0 104.0 108.0 143.0 108.0 109.0 108.0 108.0 138.0 109.0 07:42:39 INFO - PROCESS | 1661 | 07:42:39 INFO - PROCESS | 1661 | [#2] audio-dft Cycles:10 Average:183.40 Median:183.50 stddev:1.35 (0.7%) stddev-sans-first:1.33 07:42:39 INFO - PROCESS | 1661 | Values: 182.0 183.0 186.0 185.0 182.0 184.0 183.0 184.0 182.0 183.0 07:42:39 INFO - PROCESS | 1661 | 07:42:39 INFO - PROCESS | 1661 | [#3] audio-fft Cycles:10 Average:66.00 Median:61.00 stddev:11.73 (19.2%) stddev-sans-first:11.29 07:42:39 INFO - PROCESS | 1661 | Values: 80.0 60.0 59.0 87.0 62.0 59.0 57.0 58.0 81.0 57.0 07:42:39 INFO - PROCESS | 1661 | 07:42:39 INFO - PROCESS | 1661 | [#4] audio-oscillator Cycles:10 Average:77.70 Median:79.00 stddev:11.79 (14.9%) stddev-sans-first:11.90 07:42:39 INFO - PROCESS | 1661 | Values: 88.0 70.0 94.0 69.0 68.0 69.0 93.0 68.0 68.0 90.0 07:42:39 INFO - PROCESS | 1661 | 07:42:39 INFO - PROCESS | 1661 | [#5] imaging-gaussian-blur Cycles:10 Average:98.30 Median:90.00 stddev:17.93 (19.9%) stddev-sans-first:18.82 07:42:39 INFO - PROCESS | 1661 | Values: 91.0 88.0 92.0 86.0 134.0 130.0 94.0 89.0 91.0 88.0 07:42:39 INFO - PROCESS | 1661 | 07:42:39 INFO - PROCESS | 1661 | [#6] imaging-darkroom Cycles:10 Average:100.50 Median:101.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 07:42:39 INFO - PROCESS | 1661 | Values: 100.0 100.0 101.0 101.0 100.0 101.0 101.0 101.0 100.0 100.0 07:42:39 INFO - PROCESS | 1661 | 07:42:39 INFO - PROCESS | 1661 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:85.50 stddev:21.50 (25.1%) stddev-sans-first:22.46 07:42:39 INFO - PROCESS | 1661 | Values: 86.0 85.0 86.0 83.0 84.0 98.0 140.0 133.0 86.0 85.0 07:42:39 INFO - PROCESS | 1661 | 07:42:39 INFO - PROCESS | 1661 | [#8] json-parse-financial Cycles:10 Average:58.70 Median:57.00 stddev:9.32 (16.4%) stddev-sans-first:9.87 07:42:39 INFO - PROCESS | 1661 | Values: 57.0 55.0 55.0 54.0 54.0 57.0 56.0 85.0 57.0 57.0 07:42:39 INFO - PROCESS | 1661 | 07:42:39 INFO - PROCESS | 1661 | [#9] json-stringify-tinderbox Cycles:10 Average:71.10 Median:71.50 stddev:4.77 (6.7%) stddev-sans-first:3.76 07:42:39 INFO - PROCESS | 1661 | Values: 62.0 67.0 77.0 76.0 73.0 70.0 69.0 70.0 70.0 77.0 07:42:39 INFO - PROCESS | 1661 | 07:42:39 INFO - PROCESS | 1661 | [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:82.50 stddev:7.25 (8.8%) stddev-sans-first:7.63 07:42:39 INFO - PROCESS | 1661 | Values: 83.0 82.0 82.0 82.0 83.0 82.0 84.0 80.0 94.0 103.0 07:42:39 INFO - PROCESS | 1661 | 07:42:39 INFO - PROCESS | 1661 | [#11] stanford-crypto-ccm Cycles:10 Average:145.70 Median:144.00 stddev:15.03 (10.4%) stddev-sans-first:15.80 07:42:39 INFO - PROCESS | 1661 | Values: 140.0 135.0 138.0 139.0 128.0 148.0 156.0 156.0 180.0 137.0 07:42:39 INFO - PROCESS | 1661 | 07:42:39 INFO - PROCESS | 1661 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.50 Median:164.00 stddev:18.56 (11.3%) stddev-sans-first:19.58 07:42:39 INFO - PROCESS | 1661 | Values: 165.0 163.0 163.0 163.0 151.0 199.0 210.0 162.0 166.0 163.0 07:42:39 INFO - PROCESS | 1661 | 07:42:39 INFO - PROCESS | 1661 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.10 Median:69.00 stddev:7.81 (11.3%) stddev-sans-first:8.06 07:42:39 INFO - PROCESS | 1661 | Values: 67.0 67.0 66.0 67.0 67.0 67.0 79.0 71.0 85.0 85.0 07:42:39 INFO - PROCESS | 1661 | -------- Summary: end -------- 07:42:39 INFO - PROCESS | 1661 | 07:42:40 INFO - TEST-INFO | 1661: exit 0 07:42:40 INFO - TEST-OK | kraken | took 58720ms 07:42:40 INFO - SUITE-END | took 1175s 07:42:40 INFO - Completed test suite (00:19:35) 07:42:40 INFO - javascript benchmark 07:42:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3314.90055298341, 3317.784344017639, 3355.9764271897075, 3371.578552680915, 3398.8300584970743, 5654.8586285342835, 5688.061469857468, 5714.942850571493, 5737.856553586163, 5752.7123643817795, 5680.772769089242, 5734.397888221739, 5757.453041961017, 5772.653640781546, 5774.6535207887555, 5237.423883372845, 5240.109181439165, 5240.737963101848, 5278.6568873023325, 5289.3123893893935, 5193.350831146106, 5210.973945130269, 5214.452482489341, 5328.946710532884, 5350.491703288201, 5249.1338929076655, 5252.290940722992, 5256.0, 5261.210818377236, 5279.604029697769, 5226.137687281594, 5250.396204436501, 5278.736063196825, 5299.277734736226, 5311.867203319909, 5058.317127187819, 5158.561522270612, 5241.79032838686, 5248.396434410015, 5288.947110528884, 4755.643326750473, 5542.251796007527, 5614.2701448811395, 5680.176374425685, 5770.336411312711, 6204.3795620437595, 6277.87444251117, 6283.654399008053, 6346.809595712136, 6349.396807303298, 5512.173174023888, 6341.04884267359, 6360.968195159041, 6381.744730210786, 6394.232692076934, 5614.214010038598, 5718.885622287573, 5753.223314852525, 5779.450952159538, 5787.074068149076, 6275.466585340206, 6278.246610406781, 6278.968605156945, 6279.937200627935, 6287.46556542699, 6083.756649733961, 6206.596571222856, 6209.348018457997, 6214.285357183981, 6218.19163508741, 6161.969190154021, 6222.564420490522, 6327.651979141099, 6330.746770129143, 6331.0819931110655, 6167.814965551041, 6229.3770622937345, 6243.906341404882, 6299.6535190564955, 6323.873522529524, 4973.850784476472, 6295.716692748837, 6303.401176888188, 6312.747490100436, 6318.399752023551, 4865.829695960695, 4932.383452068491, 4942.085714142895, 4969.875753106201, 4974.751262436864, 4398.428204333416, 4405.9559404405545, 4438.134563760101, 4447.688661793643, 4455.1980643484485, 5790.247267855236, 5791.855203619859, 5808.912866307009, 5815.011448053841, 5840.59115861894, 6350.0792385103905, 6354.332795056545, 6358.491320694333, 6364.522660800459, 6365.0, 5631.380548139701, 5640.661560306395, 5690.9146362804595, 5740.770369185269, 5787.363390027093, 5395.379531353866, 5421.186821976735, 5446.346438427414, 5491.203775452617, 5493.835184944458, 6292.433680968735, 6302.023186406114, 6315.957866951901, 6319.273283572448, 6321.936780632227, 6142.560166306883, 6253.405926436982, 6342.8731425370315, 6358.173437453286, 6373.0, 6224.62652240867, 6261.123442717932, 6298.275698294755, 6310.968445157929, 6327.082573026793, 6232.470240029648, 6265.843353916189, 6281.089242059785, 6282.277538083179, 6296.0, 6175.197224360804, 6299.464545513682, 6370.681465926593, 6371.649559274284, 6382.266039405527, 5848.970755146197, 5989.490893274121, 6118.938810612015, 6136.079588061648, 6199.225096862892, 6163.9383606163365, 6164.6917654118015, 6174.104754810437, 6177.4749146323065, 6182.227221597301, 5925.377835327228, 5981.132735753378, 5998.25021872266, 6018.097285407224, 6045.969770151121, 6003.8198854034445, 6090.269167699905, 6119.136988619874, 6127.509799215963, 6134.099846298167, 6002.429769171922, 6013.398660133952, 6014.548908831943, 6037.335893051849, 6062.484688801324], "value": 5723.833175527856, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [472.8699607607907, 475.20166120916844, 497.8605990322709, 506.0789363358688, 513.8797421620867, 30565.0, 41312.793436032814, 42315.57684423151, 42518.787406063006, 42554.574454255446, 44472.77763611185, 44795.32807007898, 44827.77586112073, 44893.0, 44928.0, 8486.15138486151, 9974.052465015811, 9976.750581235454, 9987.55056022477, 9990.000999900025, 9815.460149691764, 9906.009399060109, 9913.256505762061, 9917.801643967116, 9924.305298629099, 9825.410475371466, 9866.703998880044, 9915.454649994248, 9916.950415247913, 9919.950400248024, 9838.458884761336, 9890.15933645641, 9892.752681182992, 9892.752681183028, 9912.0, 9519.666811661627, 9574.569144388519, 9585.664501742474, 9588.66439674615, 9592.08875156859, 41899.58100418987, 42235.57764422347, 42283.0, 42318.78840605808, 42481.0, 3290.07877794218, 3316.436205845012, 3329.217633856042, 3456.861725530976, 3510.736694747904, 29474.85262573695, 30267.69732302693, 30292.394152117056, 32273.0, 32589.6741032589, 3179.952300715468, 3246.610406751205, 3317.502374643823, 3390.1016230698883, 3391.5251864738957, 525817.0, 526115.0, 530043.0, 530347.3482632601, 533514.0, 30725.23186920345, 62481.0, 62972.0, 63003.73992520124, 63094.0, 32170.0, 33169.50245746316, 33348.3330333392, 33373.16567085794, 33485.0, 14911.95616306848, 15038.924805375904, 15042.398304067934, 15056.698866022618, 15063.924680376747, 12663.113582049167, 12727.10910236293, 12751.362431878555, 12755.0, 12773.936130319475, 7620.1998790127345, 7794.259545343183, 7806.180351063056, 7808.22668466702, 7886.0536735592095, 3250.934981300361, 3254.739620830328, 3267.122167775678, 3269.7711160219033, 3275.8034517929, 889.7330800759746, 925.3707478914403, 1017.811704834608, 1102.448775612194, 1144.2848219862585, 29988.850055749583, 30939.84530077335, 31765.52351714726, 32335.35329293448, 32516.512252316235, 1018.3482571154467, 1055.720234137954, 1080.8486811846349, 1090.3512410115968, 1101.6970333158445, 15328.846711532966, 15881.364745410285, 15987.960782549097, 16004.351123707738, 16226.513204603882, 702385.0, 705132.0, 705628.0, 709968.0, 710375.0, 58972.7051364749, 59423.70288148532, 59538.404615954154, 59619.403805962254, 59697.70151149217, 1187.940602969848, 1214.8056310990198, 1292.1988367212389, 1309.781902830358, 1323.6955500235192, 31006.844965775028, 31228.219294517818, 32249.838750806095, 32259.838700806347, 32677.673223268415, 51989.7400512995, 52704.736476317375, 52742.0, 52933.7353313231, 52962.47037529575, 586004.0, 589723.0, 591022.0, 591294.0, 592414.0, 23921.52156956886, 24482.265532034067, 26655.0, 27342.5898611517, 27392.17823465299, 47335.28997065116, 47409.762951185025, 47848.0, 48198.518014819405, 48544.0, 32187.839060804545, 38309.42535861908, 39466.802665986484, 39652.603473966046, 39694.0, 38033.61966380301, 40691.0, 40791.7960410196, 40892.79553602213, 42708.93227669333, 38703.80648096742, 39204.0, 39229.01927451837, 39244.41133382944, 39657.0, 31031.68968310288, 31725.682743172274, 35062.82468587641, 35680.0, 35830.46254306135, 22919.281053921357, 25248.495030099664, 25880.22359329223, 26279.0, 26768.59847102334], "value": 18973.125100670564, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.88722390775183, 378.977261364318, 386.2506736930356, 391.6905644540813, 406.3843277434687, 18741.62516749664, 19200.711989320152, 20271.59456810863, 20517.38447846567, 20550.58898822023, 16693.0, 19819.60360792783, 19993.700094498596, 20501.589968200664, 20720.585588288264, 5928.614640048405, 5930.318013428447, 6090.360512146227, 6176.81469555914, 6209.689515524228, 6059.18201042858, 6073.696315184246, 6135.141080248769, 6136.110264011716, 6151.477124444427, 5756.971215143939, 5993.970030149843, 6036.788712395067, 6062.545309101813, 6081.331053584102, 5996.760129594811, 6006.729697163594, 6045.637261764308, 6050.546209034318, 6057.545684073712, 5040.1179793535985, 5144.202648589475, 5267.078261304295, 5272.736363181825, 5294.841154765363, 21065.5786884263, 23834.523309533713, 24496.387590310205, 24504.754952450425, 24954.001839926383, 2075.6782698681727, 2297.4945511987335, 2360.5514952159206, 2366.432056306491, 2588.145911849085, 12248.0, 12986.0, 15291.08253504782, 15382.461613843461, 15579.298931548108, 1842.4288470574165, 1842.7420161177447, 1850.047225678763, 1926.7687877454796, 1954.1694779718705, 102240.48879755627, 103549.48225258825, 103710.48144759303, 103858.0, 104585.47707261491, 8652.826943461221, 10356.948215258875, 10512.053915147673, 10609.84085238722, 11005.504752286166, 13576.796348054788, 13583.660408489866, 13598.728025439435, 13601.115927464683, 13614.0, 8226.753197404087, 8445.95777021111, 8479.491230526188, 8611.268042216356, 8651.740447786577, 6872.931270687329, 8418.494890306602, 8436.40945133847, 8589.26991205742, 8680.088590697886, 6270.0, 6396.584222025646, 6454.419102280817, 6474.935250647527, 6608.603483790988, 1462.283481094256, 1569.4506922577007, 1729.6281299520413, 1888.9905550472436, 1899.7340372347883, 810.4003037752021, 874.0210963720674, 925.6019911438146, 989.5744829723288, 989.6239429016928, 20445.693314600292, 21587.784122158577, 21598.0, 21651.242206522697, 21711.565768684854, 873.8077622922947, 904.4844438670026, 940.8400571902793, 965.0783501755807, 980.578351308944, 8829.426087304304, 9547.2839537035, 10140.239482038876, 11187.440627968568, 11462.0, 490091.0, 497230.0, 536386.0, 582959.0, 592201.0, 88003.79990500289, 88056.0, 89544.20911581731, 103086.0, 103952.0, 915.8305713443034, 1003.5132960514145, 1004.4877112672443, 1007.1137399088755, 1007.450939238117, 13437.529686460926, 18854.24583016664, 20124.082008109035, 20138.295159669342, 20165.991700414626, 35532.82233588919, 40320.0, 50234.0, 50961.7451912738, 53298.46701532935, 69255.0, 71791.56416871528, 72198.27801722125, 72367.0, 72424.63787681238, 7699.538027718355, 7876.369890408639, 7957.323627491496, 8079.232472915063, 8079.676812927417, 12874.485020599072, 12903.290319032543, 12906.290154041619, 12989.480420783062, 13333.066685331934, 11207.43962801873, 11350.375729334966, 11628.302301861915, 11642.24325418879, 11643.068554515448, 11000.009999100119, 11170.776584468427, 11211.103111751203, 11340.6030788922, 11810.114241432098, 11402.48688808989, 11412.144089193509, 11511.021563166889, 11537.88462115368, 11703.590374336858, 6624.304448032887, 6625.569337993015, 7809.648565814438, 7950.363970882431, 8198.016238051472, 10819.459027048773, 10847.40339281347, 10918.945405272923, 11087.72280692989, 11092.389918554558], "value": 9435.67306558671, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1341.9463221471142, 1513.409770189626, 1622.6998005369007, 1850.8426783723382, 1862.4133397979626, 8524.616392262347, 9061.954690226548, 9069.546522673872, 9117.997020327759, 9130.269578433727, 7934.682612695486, 8181.5909204539685, 8558.186972237627, 8816.77958051049, 8829.072947340534, 2354.5879471092576, 2364.7162340519117, 2369.2892132360307, 2398.46034642205, 2403.435192729707, 2368.1356304948654, 2385.7017872765905, 2413.1674572272536, 2413.456972181254, 2414.468816860288, 2388.5103553771523, 2391.7369089400154, 2409.204962362416, 2416.299273210767, 2421.6730741349957, 2360.5986982213067, 2375.6555299481565, 2382.130522359335, 2383.7258715247794, 2395.077895010416, 2364.645303204516, 2375.9881200593886, 2381.2499062795337, 2383.785459308653, 2386.4511162432564, 8727.738167854974, 8909.599068041955, 8919.018907920123, 8928.15182557656, 8939.463632182025, 5266.34170728659, 5428.61999660024, 5443.292371991655, 5447.291852059207, 5454.318210223722, 2869.0, 3478.704310133616, 3485.1809824691177, 3496.370653282408, 3658.798766067865, 1084.6366467233408, 1089.5478376473754, 1090.5637744902024, 1114.7213196700825, 1117.987622279893, 11757.0, 11806.527738890434, 11809.23239989398, 11823.408829558488, 11832.585859494962, 4545.977270113628, 4657.441107067174, 4824.155772739757, 4829.13075646387, 4830.3237546743485, 9824.705258842247, 9884.901150988399, 9904.752381190528, 9906.504674766233, 9915.900840991499, 5359.758810853521, 5372.543333816591, 5374.704391258519, 5374.91937620936, 5383.757730902119, 4406.515283318832, 4508.391367165456, 4556.954430455719, 4856.441509226484, 4904.803807847647, 3860.517435320585, 3913.3934240192816, 3981.960180398217, 4008.8797336079965, 4009.4386785850006, 1278.213898452445, 1285.6850071732486, 1291.5156816193928, 1302.3293004102895, 1308.476609356265, 751.6842925971105, 806.3589446390017, 915.3135148638521, 919.3013309884402, 930.418488444722, 5590.692511911802, 5657.377688454267, 5726.226959360433, 5864.67744274069, 6059.333473317932, 881.8350948421737, 933.9719808405758, 943.7923656795494, 947.6920000999703, 964.5466630683568, 3759.4548790425233, 3895.3183192941124, 3912.4326972588815, 3927.2930872443235, 4059.0, 10609.734756631146, 10798.892011079946, 10922.235443519035, 10926.836097458545, 10991.505382257817, 10737.248392612599, 10843.728906777395, 10850.348979061282, 10868.510917008754, 10879.782404351869, 7862.135165131831, 8184.304334131665, 8205.71280005197, 8218.547979861045, 8282.25459708617, 5974.2233509643465, 5996.340402555628, 6042.1843051187525, 6044.546659000504, 6066.636001839904, 10108.646197383056, 10244.846327304947, 10254.6410875619, 10259.94870025675, 10286.434246116536, 9753.122219000325, 10156.746081348025, 10175.7456063599, 10286.382817031003, 10365.222608304559, 6934.618595977269, 7155.0, 7157.57054576727, 7442.06974128234, 7639.121501027453, 8064.314533264738, 8178.713745018896, 8332.541710205996, 8455.985281765981, 8459.492430454193, 7392.149902761252, 7465.29079737424, 7504.0, 7519.172890982097, 7675.616219188906, 7356.816079598053, 7423.294786995227, 7430.554166750012, 7463.626818659154, 7604.961975190088, 6910.170779506491, 7054.470914681522, 7059.541129826544, 7072.5402848814665, 7074.469414793808, 4833.709977401367, 4901.14230009754, 4926.729029903389, 4956.330895329084, 4957.950420495749, 4825.758712064313, 4851.878703032452, 4870.610351171968, 5016.824411145738, 5050.873728156826], "value": 4608.556354643928, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.40012773431266, 297.3057909780662, 305.7859498351154, 311.83005262132133, 311.9204602826282, 4343.609075183237, 5486.7902277167905, 5508.118701007839, 5548.361938377083, 5548.889022219553, 4344.804483798229, 4515.39042229299, 5044.419891712454, 5362.812301569436, 5424.267723857278, 4130.327217476926, 4132.132252227036, 4142.357934520139, 4151.252774500589, 4177.657873701042, 3600.037979301274, 3996.340603800384, 4125.154343359604, 4151.730137541065, 4182.247195504808, 3914.5498267699295, 4053.695972802037, 4067.0, 4078.2455245779624, 4102.958970410303, 3736.4021756518828, 4063.5326937402283, 4070.3080476319096, 4103.425520427142, 4122.587741225883, 3519.8592056317716, 3523.3305671922253, 3523.9295214095573, 3524.594671612772, 3537.363274610569, 4168.478940132483, 4782.321899736124, 5229.947700522984, 5273.2617433559335, 5310.389305229909, 3842.7886466244345, 4538.7503687297185, 4691.091523255569, 4706.599939005188, 4711.552402521755, 5712.485876271156, 5726.713664316768, 5734.4265573442735, 5740.54075673945, 5751.539876809845, 3381.205416727067, 3901.590333015021, 3902.4731661225655, 3911.647951684362, 3913.726039177259, 5138.948610513884, 5207.864775442088, 5428.61999660024, 5569.969555632221, 5981.760729570812, 3363.9327213455595, 3464.7747896386654, 3673.7244706647107, 3964.861229856941, 3973.3113426794075, 4013.2174226025645, 4015.1768887378016, 4025.456563363967, 4028.576999415078, 4047.514298284225, 4399.956000440018, 4500.414946057057, 4547.545245475492, 4741.383620129361, 4744.501827308152, 5036.722980236123, 5727.828165155052, 5747.568932330092, 5761.423857614205, 5773.711314434346, 1306.1118439461256, 1319.7162610038888, 1352.6888815572474, 1358.7825947848296, 1358.8233529641084, 648.6043513456788, 730.6967608442437, 734.1997223026926, 771.8807728793272, 823.6615499812805, 4431.623312018514, 4483.820647174077, 4504.932426013613, 4515.916180116748, 4539.6368290536675, 4200.991761977103, 4321.805518751664, 4506.654153729465, 4747.667663263538, 4917.139500587383, 3865.845366185321, 3900.6790959379123, 3965.4138344661787, 4423.690341676116, 4449.933251001237, 2473.727889932106, 2738.3427977285705, 3034.924126896801, 3062.632484101922, 3070.5240687693445, 4985.750712464363, 5750.211147593413, 6012.518998480111, 6059.969700151471, 6078.483328917092, 5607.7476513556985, 5676.205331253628, 5908.497777688945, 6036.909446358308, 6059.394060593993, 4867.7322747249245, 6002.369751176151, 6053.273607167168, 6059.818205453844, 6094.695265236721, 5107.719075450886, 5808.896309701143, 5878.0, 5886.23478947734, 5893.410658934073, 5535.280413546213, 5815.5929084963645, 5839.824805255849, 5857.389217965094, 5904.468597826216, 5032.421271553671, 5119.74401279927, 5825.281541945221, 6152.384761523812, 6169.074638804036, 3483.4774783782636, 3974.4038394241097, 4001.639852413297, 4093.63157315843, 4111.93089796661, 4999.325091112653, 5777.075667893117, 5854.824355269348, 5904.52763778888, 5934.258217722785, 5332.786688532416, 5396.030448886207, 5482.369527504388, 5786.334571524329, 5824.854378640398, 5694.501343938243, 5711.658679672438, 5725.139329717775, 5736.71316434185, 5834.649921004753, 4639.35049093134, 4833.975830120827, 4964.00719856023, 5677.489025987516, 5682.232898558807, 4775.283707443911, 4818.927716084191, 4924.606031517542, 5422.376426710979, 5515.0, 5594.188842617879, 5657.811859509549, 5661.773529058792, 5670.574706897081, 5676.637606974214], "value": 4047.4122608976736, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [677.5223467455442, 696.2793508718476, 759.8670232709275, 812.6140083460353, 814.3444527155638, 12417.627471175869, 15792.289346979385, 15984.200789960514, 15985.920070399647, 16074.115923624197, 14409.279536023208, 14450.710985780279, 14457.277136143177, 14475.855241447582, 14497.63755906103, 650.8503044299814, 677.8813707601174, 682.2529330383247, 786.8504984053012, 813.5891374855689, 819.635262308273, 827.9586020698971, 829.4691397505601, 831.7255305749088, 835.3567752830317, 884.4958373726978, 885.7342797160858, 885.8981217160044, 886.7251152142857, 887.0863011098579, 880.075920283706, 880.4805164952645, 880.7886107334258, 882.1090698394604, 882.32942963348, 508.61091265182165, 527.5199568392783, 622.7758007117434, 637.9840503987391, 643.0579201469869, 14573.052751571115, 14589.854101459061, 14602.707945841024, 14604.12375257488, 14604.561863144123, 13435.0, 13797.310134493335, 13938.790918136236, 14025.158490490501, 14284.0, 10295.588176472933, 12283.508659653604, 12390.75218495625, 12551.811722824164, 12660.17708848922, 4500.879310858739, 4504.527024662429, 4592.586667199935, 4649.535046495357, 4663.27719203524, 120727.0, 122286.38856805747, 122902.38548807288, 123156.0, 123541.0, 10601.84097238542, 10933.343999360064, 10946.288491248044, 11017.779644407066, 11287.49206285719, 18087.73385862977, 21198.0, 21522.031508582153, 21636.78363216379, 21727.34817955464, 7805.960970195113, 7810.453268271166, 7846.8430631387055, 7868.960655196687, 8084.878726819103, 4285.764282964405, 4286.442762440863, 4322.308430651081, 4415.955840441618, 4606.262997920317, 3380.2056516718553, 3490.930181396358, 3493.3537295600395, 3498.1429549760473, 3499.1951851074396, 648.4293821437105, 656.3698849104912, 657.4740207833714, 671.0069097735379, 712.056525104239, 607.3592360060179, 620.4385031546458, 644.44899610833, 644.5520363347429, 655.4134050025201, 9248.722538323862, 9682.467464289392, 9833.0, 9872.802543949225, 9876.901230987742, 633.2174927578851, 643.9678016099176, 661.5170925224517, 680.2653134614604, 687.1788213085415, 4518.390017347681, 4672.229082201467, 4702.177119004161, 4709.058188362341, 4751.263554149113, 156667.43332566528, 170674.14662926606, 172550.0, 175148.0, 176117.0, 138932.0, 145618.81571776432, 146503.6048918534, 147545.26227369008, 153039.0, 123782.0, 126476.0, 127741.3612931948, 128675.0, 129171.0, 8974.685885993958, 8997.550122493718, 9018.729438116867, 9027.277817774431, 9206.815863682823, 53012.73493632507, 55297.72351138219, 58688.82622347444, 60366.69816650889, 63905.0, 79081.60459197668, 93596.59605105793, 99700.0, 99960.50019749855, 102217.0, 11534.59628912984, 11772.882271177521, 11861.76276474483, 11927.880721192678, 12299.0, 10791.6222932197, 12728.68178295513, 13557.728845422838, 13990.510332138327, 14105.94205434576, 10748.570057197625, 11712.648620541397, 11939.641810745692, 12440.937795310965, 12517.436715347649, 13201.339933003503, 13203.405846737112, 13722.313884305546, 13990.440382384997, 14401.279936003368, 13472.86527134716, 13910.51313204033, 13986.020978531405, 14609.634759131106, 14610.342534586182, 11316.303733950319, 11325.207235493437, 11377.943110284396, 11809.940950295193, 12066.818997714865, 11578.478968446272, 11619.244749091282, 11734.647960561197, 11767.76464470723, 11894.762104758029], "value": 7855.154143143345, "unit": "score"}], "name": "dromaeo_css", "value": 7290.489031022974, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 115.0, 114.0, 112.0, 114.0, 113.0, 114.0, 114.0, 113.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 104.0, 108.0, 143.0, 108.0, 109.0, 108.0, 108.0, 138.0, 109.0], "value": 117.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 183.0, 186.0, 185.0, 182.0, 184.0, 183.0, 184.0, 182.0, 183.0], "value": 183.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 60.0, 59.0, 87.0, 62.0, 59.0, 57.0, 58.0, 81.0, 57.0], "value": 66.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 94.0, 69.0, 68.0, 69.0, 93.0, 68.0, 68.0, 90.0], "value": 77.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 88.0, 92.0, 86.0, 134.0, 130.0, 94.0, 89.0, 91.0, 88.0], "value": 98.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 100.0, 101.0, 101.0, 100.0, 101.0, 101.0, 101.0, 100.0, 100.0], "value": 100.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 86.0, 83.0, 84.0, 98.0, 140.0, 133.0, 86.0, 85.0], "value": 96.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 55.0, 54.0, 54.0, 57.0, 56.0, 85.0, 57.0, 57.0], "value": 58.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 67.0, 77.0, 76.0, 73.0, 70.0, 69.0, 70.0, 70.0, 77.0], "value": 71.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 82.0, 82.0, 83.0, 82.0, 84.0, 80.0, 94.0, 103.0], "value": 85.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 135.0, 138.0, 139.0, 128.0, 148.0, 156.0, 156.0, 180.0, 137.0], "value": 145.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 163.0, 163.0, 151.0, 199.0, 210.0, 162.0, 166.0, 163.0], "value": 170.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 67.0, 67.0, 67.0, 79.0, 71.0, 85.0, 85.0], "value": 72.1, "unit": "score"}], "name": "kraken", "value": 1457.5, "alertThreshold": 2.0}]} 07:42:40 INFO - Return code: 0 07:42:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:42:40 INFO - # TBPL SUCCESS # 07:42:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:42:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:42:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:42:40 INFO - 2016-10-19 07:42:40.925 screenresolution[1665:9942] starting screenresolution argv=screenresolution get 07:42:40 INFO - 2016-10-19 07:42:40.928 screenresolution[1665:9942] Display 0: 1600x1200x32@60 07:42:40 INFO - 2016-10-19 07:42:40.934 screenresolution[1666:9945] starting screenresolution argv=screenresolution list 07:42:40 INFO - Available Modes on Display 0 07:42:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:42:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:42:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:42:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:42:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:42:41 INFO - Intel Iris: 07:42:41 INFO - Chipset Model: Intel Iris 07:42:41 INFO - Type: GPU 07:42:41 INFO - Bus: Built-In 07:42:41 INFO - VRAM (Dynamic, Max): 1536 MB 07:42:41 INFO - Vendor: Intel (0x8086) 07:42:41 INFO - Device ID: 0x0a2e 07:42:41 INFO - Revision ID: 0x0009 07:42:41 INFO - Displays: 07:42:41 INFO - Display: 07:42:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:42:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:42:41 INFO - Display Serial Number: 1600x1200 60 07:42:41 INFO - Main Display: Yes 07:42:41 INFO - Mirror: Off 07:42:41 INFO - Online: Yes 07:42:41 INFO - Rotation: Supported 07:42:41 INFO - Return code: 0 07:42:41 INFO - Running post-action listener: _resource_record_post_action 07:42:41 INFO - [mozharness: 2016-10-19 14:42:41.175296Z] Finished run-tests step (success) 07:42:41 INFO - Running post-run listener: _resource_record_post_run 07:42:41 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 38601728; Write bytes: 662185472; Read time: 378; Write time: 1872 07:42:41 INFO - TinderboxPrint: CPU usage
53.4% 07:42:41 INFO - TinderboxPrint: I/O read bytes / time
38,601,728 / 378 07:42:41 INFO - TinderboxPrint: I/O write bytes / time
662,185,472 / 1,872 07:42:41 INFO - TinderboxPrint: CPU idle
2,253.9 (46.6%) 07:42:41 INFO - TinderboxPrint: CPU system
966.9 (20.0%) 07:42:41 INFO - TinderboxPrint: CPU user
1,616.9 (33.4%) 07:42:41 INFO - TinderboxPrint: Swap in / out
401,567,744 / 0 07:42:41 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 363899392; Write bytes: 356583424; Read time: 28523; Write time: 642 07:42:41 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 31390720; Write bytes: 294551040; Read time: 292; Write time: 1199 07:42:41 INFO - Running post-run listener: _upload_blobber_files 07:42:41 INFO - Blob upload gear active. 07:42:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:42:41 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 07:42:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:42:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:42:42 INFO - (blobuploader) - INFO - Open directory for files ... 07:42:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:42:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:42:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:42:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:42:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:42:43 INFO - (blobuploader) - INFO - Done attempting. 07:42:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:42:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:42:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:42:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:42:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:42:44 INFO - (blobuploader) - INFO - Done attempting. 07:42:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:42:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:42:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:42:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:42:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:42:46 INFO - (blobuploader) - INFO - Done attempting. 07:42:46 INFO - (blobuploader) - INFO - Iteration through files over. 07:42:46 INFO - Return code: 0 07:42:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:42:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:42:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3071c29ef58e8f95d0bae8c3d459e8674c0ffccda31fbde3251e851ad2c061300b659a486a117c0c4c439800021a4152b0b6d1f078a394895077bc9f432ef254", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b890f828292b8c228ce020f169bd8868d050fc2a90c863ca0b09edb1bf0f97da4e83f54ac444ba77086f2c5b758a2787230938265e18342b00d3f132b5e6b02e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5ff068e07ca3182dbd12aa575e86f15d08ab49b36c5c7db8189d2e43f0693179c47aea487b1d39b41c7845fc4cc6568be6408228718d64d5f3aea6f32a4bc131"} 07:42:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:42:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:42:46 INFO - Contents: 07:42:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3071c29ef58e8f95d0bae8c3d459e8674c0ffccda31fbde3251e851ad2c061300b659a486a117c0c4c439800021a4152b0b6d1f078a394895077bc9f432ef254", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b890f828292b8c228ce020f169bd8868d050fc2a90c863ca0b09edb1bf0f97da4e83f54ac444ba77086f2c5b758a2787230938265e18342b00d3f132b5e6b02e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5ff068e07ca3182dbd12aa575e86f15d08ab49b36c5c7db8189d2e43f0693179c47aea487b1d39b41c7845fc4cc6568be6408228718d64d5f3aea6f32a4bc131"} 07:42:46 INFO - Running post-run listener: copy_logs_to_upload_dir 07:42:46 INFO - Copying logs to upload dir... 07:42:46 INFO - mkdir: /builds/slave/test/build/upload/logs 07:42:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.760534 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-10-19 07:42:46.517583) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 07:42:46.521715) ========= 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.a9ZKCohQtp/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.nSoRpypBhb/Listeners TMPDIR=/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/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/Mozilla-Aurora/sha512/3071c29ef58e8f95d0bae8c3d459e8674c0ffccda31fbde3251e851ad2c061300b659a486a117c0c4c439800021a4152b0b6d1f078a394895077bc9f432ef254", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b890f828292b8c228ce020f169bd8868d050fc2a90c863ca0b09edb1bf0f97da4e83f54ac444ba77086f2c5b758a2787230938265e18342b00d3f132b5e6b02e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5ff068e07ca3182dbd12aa575e86f15d08ab49b36c5c7db8189d2e43f0693179c47aea487b1d39b41c7845fc4cc6568be6408228718d64d5f3aea6f32a4bc131"} build_url:https://queue.taskcluster.net/v1/task/U50hLkAbSXe58QmMAydCHw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010785 build_url: 'https://queue.taskcluster.net/v1/task/U50hLkAbSXe58QmMAydCHw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3071c29ef58e8f95d0bae8c3d459e8674c0ffccda31fbde3251e851ad2c061300b659a486a117c0c4c439800021a4152b0b6d1f078a394895077bc9f432ef254", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b890f828292b8c228ce020f169bd8868d050fc2a90c863ca0b09edb1bf0f97da4e83f54ac444ba77086f2c5b758a2787230938265e18342b00d3f132b5e6b02e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5ff068e07ca3182dbd12aa575e86f15d08ab49b36c5c7db8189d2e43f0693179c47aea487b1d39b41c7845fc4cc6568be6408228718d64d5f3aea6f32a4bc131"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 07:42:46.558105) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 07:42:46.558465) ========= 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.a9ZKCohQtp/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.nSoRpypBhb/Listeners TMPDIR=/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/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.005211 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 07:42:46.607543) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-19 07:42:46.607905) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-19 07:42:46.608265) ========= ========= Total master_lag: 0.18 =========