builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0330 starttime: 1478171052.52 results: success (0) buildid: 20161103015123 builduid: 863b5a5ce3e5487da970ac1891db94f1 revision: 0ae3a7425ff1a1371b888313013be1c3bd5ddbdd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-03 04:04:12.517157) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-03 04:04:12.517633) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-03 04:04:12.517914) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-03 04:04:12.544824) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 04:04:12.545222) ========= 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.ooORzFkFfn/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.UoiWkj9jXx/Listeners TMPDIR=/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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-11-03 04:04:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 151M=0s 2016-11-03 04:04:12 (151 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.093472 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 04:04:12.663781) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 04:04:12.664107) ========= 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.ooORzFkFfn/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.UoiWkj9jXx/Listeners TMPDIR=/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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.024241 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 04:04:12.712169) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-03 04:04:12.715566) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0ae3a7425ff1a1371b888313013be1c3bd5ddbdd --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 0ae3a7425ff1a1371b888313013be1c3bd5ddbdd --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ooORzFkFfn/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.UoiWkj9jXx/Listeners TMPDIR=/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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-11-03 04:04:12,801 truncating revision to first 12 chars 2016-11-03 04:04:12,801 Setting DEBUG logging. 2016-11-03 04:04:12,801 attempt 1/10 2016-11-03 04:04:12,802 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0ae3a7425ff1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-03 04:04:13,858 unpacking tar archive at: mozilla-aurora-0ae3a7425ff1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.325630 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-03 04:04:14.065138) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-03 04:04:14.065508) ========= script_repo_revision: 0ae3a7425ff1a1371b888313013be1c3bd5ddbdd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-03 04:04:14.065901) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-03 04:04:14.066170) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-03 04:04:14.083869) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-11-03 04:04:14.084257) ========= /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.ooORzFkFfn/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.UoiWkj9jXx/Listeners TMPDIR=/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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 04:04:14 INFO - MultiFileLogger online at 20161103 04:04:14 in /builds/slave/test 04:04:14 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 04:04:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:04:14 INFO - {'append_to_log': False, 04:04:14 INFO - 'base_work_dir': '/builds/slave/test', 04:04:14 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:04:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:04:14 INFO - 'branch': 'Mozilla-Aurora', 04:04:14 INFO - 'buildbot_json_path': 'buildprops.json', 04:04:14 INFO - 'config_files': ('talos/mac_config.py',), 04:04:14 INFO - 'default_actions': ('clobber', 04:04:14 INFO - 'read-buildbot-config', 04:04:14 INFO - 'download-and-extract', 04:04:14 INFO - 'populate-webroot', 04:04:14 INFO - 'create-virtualenv', 04:04:14 INFO - 'install', 04:04:14 INFO - 'run-tests'), 04:04:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:04:14 INFO - 'download_minidump_stackwalk': True, 04:04:14 INFO - 'download_symbols': 'ondemand', 04:04:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:04:14 INFO - 'tooltool.py': '/tools/tooltool.py', 04:04:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:04:14 INFO - '/tools/misc-python/virtualenv.py')}, 04:04:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:04:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:04:14 INFO - 'installer_path': 'installer.exe', 04:04:14 INFO - 'log_level': 'info', 04:04:14 INFO - 'log_name': 'talos', 04:04:14 INFO - 'log_to_console': True, 04:04:14 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:04:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:04:14 INFO - 'opt_config_files': (), 04:04:14 INFO - 'pip_index': False, 04:04:14 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:04:14 INFO - 'cmd': ('bash', 04:04:14 INFO - '-c', 04:04:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:04:14 INFO - 'enabled': True, 04:04:14 INFO - 'halt_on_failure': False, 04:04:14 INFO - 'name': 'check_screen_resolution'},), 04:04:14 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:04:14 INFO - 'cmd': ('bash', 04:04:14 INFO - '-c', 04:04:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:04:14 INFO - 'enabled': True, 04:04:14 INFO - 'halt_on_failure': False, 04:04:14 INFO - 'name': 'check_screen_resolution'},), 04:04:14 INFO - 'run_cmd_checks_enabled': True, 04:04:14 INFO - 'sps_profile': False, 04:04:14 INFO - 'sps_profile_interval': 0, 04:04:14 INFO - 'suite': 'dromaeojs', 04:04:14 INFO - 'system_bits': '32', 04:04:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:04:14 INFO - 'title': 't-yosemite-r7-0330', 04:04:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:04:14 INFO - 'use_talos_json': True, 04:04:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:04:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:04:14 INFO - 'work_dir': 'build'} 04:04:14 INFO - [mozharness: 2016-11-03 11:04:14.283845Z] Running clobber step. 04:04:14 INFO - Running pre-action listener: _resource_record_pre_action 04:04:14 INFO - Running main action method: clobber 04:04:14 INFO - rmtree: /builds/slave/test/build 04:04:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:04:16 INFO - Running post-action listener: _resource_record_post_action 04:04:16 INFO - [mozharness: 2016-11-03 11:04:16.359110Z] Finished clobber step (success) 04:04:16 INFO - [mozharness: 2016-11-03 11:04:16.359238Z] Running read-buildbot-config step. 04:04:16 INFO - Running pre-action listener: _resource_record_pre_action 04:04:16 INFO - Running main action method: read_buildbot_config 04:04:16 INFO - Using buildbot properties: 04:04:16 INFO - { 04:04:16 INFO - "project": "", 04:04:16 INFO - "product": "firefox", 04:04:16 INFO - "script_repo_revision": "production", 04:04:16 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 04:04:16 INFO - "repository": "", 04:04:16 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 04:04:16 INFO - "buildid": "20161103015123", 04:04:16 INFO - "pgo_build": "False", 04:04:16 INFO - "basedir": "/builds/slave/test", 04:04:16 INFO - "buildnumber": 114, 04:04:16 INFO - "slavename": "t-yosemite-r7-0330", 04:04:16 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 04:04:16 INFO - "platform": "yosemite_r7", 04:04:16 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 04:04:16 INFO - "branch": "mozilla-aurora", 04:04:16 INFO - "repo_path": "releases/mozilla-aurora", 04:04:16 INFO - "revision": "0ae3a7425ff1a1371b888313013be1c3bd5ddbdd", 04:04:16 INFO - "stage_platform": "macosx64", 04:04:16 INFO - "builduid": "863b5a5ce3e5487da970ac1891db94f1", 04:04:16 INFO - "slavebuilddir": "test" 04:04:16 INFO - } 04:04:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/Dd8zwx0xR8CEmyg-D80NMw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 04:04:16 INFO - Running post-action listener: _resource_record_post_action 04:04:16 INFO - [mozharness: 2016-11-03 11:04:16.362647Z] Finished read-buildbot-config step (success) 04:04:16 INFO - [mozharness: 2016-11-03 11:04:16.362753Z] Running download-and-extract step. 04:04:16 INFO - Running pre-action listener: _resource_record_pre_action 04:04:16 INFO - Running main action method: download_and_extract 04:04:16 INFO - mkdir: /builds/slave/test/build/tests 04:04:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:04:16 INFO - trying https://queue.taskcluster.net/v1/task/Dd8zwx0xR8CEmyg-D80NMw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 04:04:16 INFO - Downloading https://queue.taskcluster.net/v1/task/Dd8zwx0xR8CEmyg-D80NMw/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 04:04:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dd8zwx0xR8CEmyg-D80NMw/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 04:04:17 INFO - Downloaded 1199 bytes. 04:04:17 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 04:04:17 INFO - Using the following test package requirements: 04:04:17 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 04:04:17 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 04:04:17 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 04:04:17 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 04:04:17 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 04:04:17 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 04:04:17 INFO - u'jsshell-mac.zip'], 04:04:17 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 04:04:17 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 04:04:17 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 04:04:17 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 04:04:17 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 04:04:17 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 04:04:17 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 04:04:17 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 04:04:17 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 04:04:17 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 04:04:17 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 04:04:17 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 04:04:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dd8zwx0xR8CEmyg-D80NMw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 04:04:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dd8zwx0xR8CEmyg-D80NMw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 04:04:17 INFO - Fetch https://queue.taskcluster.net/v1/task/Dd8zwx0xR8CEmyg-D80NMw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 04:04:18 INFO - Expected file size: 16421487 04:04:25 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 04:04:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dd8zwx0xR8CEmyg-D80NMw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 04:04:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dd8zwx0xR8CEmyg-D80NMw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 04:04:25 INFO - Fetch https://queue.taskcluster.net/v1/task/Dd8zwx0xR8CEmyg-D80NMw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 04:04:26 INFO - Expected file size: 16421487 04:04:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dd8zwx0xR8CEmyg-D80NMw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 04:04:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dd8zwx0xR8CEmyg-D80NMw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 04:04:32 INFO - Fetch https://queue.taskcluster.net/v1/task/Dd8zwx0xR8CEmyg-D80NMw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 04:04:33 INFO - Expected file size: 14414089 04:04:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:04:34 INFO - trying https://queue.taskcluster.net/v1/task/Dd8zwx0xR8CEmyg-D80NMw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 04:04:34 INFO - Downloading https://queue.taskcluster.net/v1/task/Dd8zwx0xR8CEmyg-D80NMw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 04:04:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dd8zwx0xR8CEmyg-D80NMw/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 04:04:36 INFO - Downloaded 115462841 bytes. 04:04:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Dd8zwx0xR8CEmyg-D80NMw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 04:04:36 INFO - mkdir: /builds/slave/test/properties 04:04:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:04:36 INFO - Writing to file /builds/slave/test/properties/build_url 04:04:36 INFO - Contents: 04:04:36 INFO - build_url:https://queue.taskcluster.net/v1/task/Dd8zwx0xR8CEmyg-D80NMw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 04:04:37 INFO - Running post-action listener: _resource_record_post_action 04:04:37 INFO - Running post-action listener: set_extra_try_arguments 04:04:37 INFO - [mozharness: 2016-11-03 11:04:37.587942Z] Finished download-and-extract step (success) 04:04:37 INFO - [mozharness: 2016-11-03 11:04:37.588110Z] Running populate-webroot step. 04:04:37 INFO - Running pre-action listener: _resource_record_pre_action 04:04:37 INFO - Running main action method: populate_webroot 04:04:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:04:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:04:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:04:37 INFO - '--tppagecycles', 04:04:37 INFO - '7'], 04:04:37 INFO - 'tests': ['tsvgm']}}, 04:04:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:04:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:04:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:04:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:04:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:04:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:04:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:04:37 INFO - 'talos_options': ['--disable-e10s'], 04:04:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:04:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:04:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:04:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:04:37 INFO - 'talos_options': ['--disable-e10s'], 04:04:37 INFO - 'tests': ['damp', 'tps']}, 04:04:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:04:37 INFO - 'tests': ['damp', 'tps']}, 04:04:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:04:37 INFO - 'tests': ['dromaeo_dom']}, 04:04:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:04:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:04:37 INFO - 'tests': ['basic_compositor_video']}, 04:04:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:04:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:04:37 INFO - 'tests': ['a11yr', 04:04:37 INFO - 'ts_paint', 04:04:37 INFO - 'tpaint', 04:04:37 INFO - 'sessionrestore', 04:04:37 INFO - 'sessionrestore_no_auto_restore', 04:04:37 INFO - 'tabpaint']}, 04:04:37 INFO - 'other-e10s': {'tests': ['a11yr', 04:04:37 INFO - 'ts_paint', 04:04:37 INFO - 'tpaint', 04:04:37 INFO - 'sessionrestore', 04:04:37 INFO - 'sessionrestore_no_auto_restore', 04:04:37 INFO - 'tabpaint']}, 04:04:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:04:37 INFO - 'ts_paint', 04:04:37 INFO - 'tpaint', 04:04:37 INFO - 'sessionrestore', 04:04:37 INFO - 'sessionrestore_no_auto_restore', 04:04:37 INFO - 'tabpaint']}, 04:04:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:04:37 INFO - 'ts_paint', 04:04:37 INFO - 'tpaint', 04:04:37 INFO - 'sessionrestore', 04:04:37 INFO - 'sessionrestore_no_auto_restore', 04:04:37 INFO - 'tabpaint']}, 04:04:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:04:37 INFO - 'tests': ['a11yr', 04:04:37 INFO - 'ts_paint', 04:04:37 INFO - 'tpaint', 04:04:37 INFO - 'sessionrestore', 04:04:37 INFO - 'sessionrestore_no_auto_restore', 04:04:37 INFO - 'tabpaint']}, 04:04:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:04:37 INFO - 'tests': ['a11yr', 04:04:37 INFO - 'ts_paint', 04:04:37 INFO - 'tpaint', 04:04:37 INFO - 'sessionrestore', 04:04:37 INFO - 'sessionrestore_no_auto_restore', 04:04:37 INFO - 'tabpaint']}, 04:04:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:04:37 INFO - 'tests': ['tsvgx', 04:04:37 INFO - 'tsvgr_opacity', 04:04:37 INFO - 'tart', 04:04:37 INFO - 'tscrollx', 04:04:37 INFO - 'cart']}, 04:04:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:04:37 INFO - 'tsvgr_opacity', 04:04:37 INFO - 'tart', 04:04:37 INFO - 'tscrollx', 04:04:37 INFO - 'cart']}, 04:04:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:04:37 INFO - 'talos_options': ['--disable-e10s'], 04:04:37 INFO - 'tests': ['tp5o']}, 04:04:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:04:37 INFO - 'tests': ['tp5o']}, 04:04:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:04:37 INFO - 'talos_options': ['--disable-e10s', 04:04:37 INFO - '--xperf_path', 04:04:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:04:37 INFO - 'tests': ['tp5n']}, 04:04:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:04:37 INFO - 'talos_options': ['--xperf_path', 04:04:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:04:37 INFO - 'tests': ['tp5n']}}, 04:04:37 INFO - 'talos.zip': {'path': '', 04:04:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:04:37 INFO - Running post-action listener: _resource_record_post_action 04:04:37 INFO - [mozharness: 2016-11-03 11:04:37.606910Z] Finished populate-webroot step (success) 04:04:37 INFO - [mozharness: 2016-11-03 11:04:37.607040Z] Running create-virtualenv step. 04:04:37 INFO - Running pre-action listener: _resource_record_pre_action 04:04:37 INFO - Running main action method: create_virtualenv 04:04:37 INFO - Creating virtualenv /builds/slave/test/build/venv 04:04:37 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 04:04:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:04:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:04:37 INFO - Using real prefix '/tools/python27' 04:04:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:04:38 INFO - Installing distribute.............................................................................................................................................................................................done. 04:04:41 INFO - Installing pip.................done. 04:04:41 INFO - Return code: 0 04:04:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:04:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:04:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:04:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101167490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010dd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd58d68660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f7bd30>, '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 0x100de1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f73b20>, '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.ooORzFkFfn/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.UoiWkj9jXx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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 04:04:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:04:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:04:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ooORzFkFfn/Render', 04:04:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:04:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:04:41 INFO - 'HOME': '/Users/cltbld', 04:04:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:04:41 INFO - 'LOGNAME': 'cltbld', 04:04:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:41 INFO - 'MOZ_NO_REMOTE': '1', 04:04:41 INFO - 'NO_EM_RESTART': '1', 04:04:41 INFO - 'PAGER': '/bin/cat', 04:04:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:04:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:41 INFO - 'PWD': '/builds/slave/test', 04:04:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:04:41 INFO - 'SHELL': '/bin/bash', 04:04:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UoiWkj9jXx/Listeners', 04:04:41 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 04:04:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:04:41 INFO - 'USER': 'cltbld', 04:04:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:04:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:04:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:41 INFO - 'XPC_FLAGS': '0x0', 04:04:41 INFO - 'XPC_SERVICE_NAME': '0', 04:04:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:04:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:41 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:04:41 INFO - Cleaning up... 04:04:41 INFO - Return code: 0 04:04:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:04:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:04:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:04:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101167490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010dd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd58d68660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f7bd30>, '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 0x100de1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f73b20>, '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.ooORzFkFfn/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.UoiWkj9jXx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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 04:04:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:04:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:04:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ooORzFkFfn/Render', 04:04:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:04:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:04:41 INFO - 'HOME': '/Users/cltbld', 04:04:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:04:41 INFO - 'LOGNAME': 'cltbld', 04:04:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:41 INFO - 'MOZ_NO_REMOTE': '1', 04:04:41 INFO - 'NO_EM_RESTART': '1', 04:04:41 INFO - 'PAGER': '/bin/cat', 04:04:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:04:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:41 INFO - 'PWD': '/builds/slave/test', 04:04:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:04:41 INFO - 'SHELL': '/bin/bash', 04:04:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UoiWkj9jXx/Listeners', 04:04:41 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 04:04:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:04:41 INFO - 'USER': 'cltbld', 04:04:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:04:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:04:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:41 INFO - 'XPC_FLAGS': '0x0', 04:04:41 INFO - 'XPC_SERVICE_NAME': '0', 04:04:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:04:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:41 INFO - Downloading/unpacking psutil>=3.1.1 04:04:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:04:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:04:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:04:44 INFO - Installing collected packages: psutil 04:04:44 INFO - Running setup.py install for psutil 04:04:44 INFO - building 'psutil._psutil_osx' extension 04:04:44 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 04:04:45 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 04:04:45 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 04:04:45 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 04:04:45 INFO - building 'psutil._psutil_posix' extension 04:04:45 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 04:04:45 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:04:45 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:04:45 INFO - ^ 04:04:45 INFO - 1 warning generated. 04:04:45 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 04:04:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:04:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:04:45 INFO - Successfully installed psutil 04:04:45 INFO - Cleaning up... 04:04:45 INFO - Return code: 0 04:04:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:04:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:04:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:04:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101167490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010dd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd58d68660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f7bd30>, '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 0x100de1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f73b20>, '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.ooORzFkFfn/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.UoiWkj9jXx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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 04:04:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:04:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:04:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ooORzFkFfn/Render', 04:04:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:04:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:04:45 INFO - 'HOME': '/Users/cltbld', 04:04:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:04:45 INFO - 'LOGNAME': 'cltbld', 04:04:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:45 INFO - 'MOZ_NO_REMOTE': '1', 04:04:45 INFO - 'NO_EM_RESTART': '1', 04:04:45 INFO - 'PAGER': '/bin/cat', 04:04:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:04:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:45 INFO - 'PWD': '/builds/slave/test', 04:04:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:04:45 INFO - 'SHELL': '/bin/bash', 04:04:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UoiWkj9jXx/Listeners', 04:04:45 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 04:04:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:04:45 INFO - 'USER': 'cltbld', 04:04:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:04:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:04:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:45 INFO - 'XPC_FLAGS': '0x0', 04:04:45 INFO - 'XPC_SERVICE_NAME': '0', 04:04:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:04:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:04:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:04:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:04:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:04:48 INFO - Installing collected packages: mozsystemmonitor 04:04:48 INFO - Running setup.py install for mozsystemmonitor 04:04:48 INFO - Successfully installed mozsystemmonitor 04:04:48 INFO - Cleaning up... 04:04:48 INFO - Return code: 0 04:04:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:04:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:04:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:04:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101167490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010dd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd58d68660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f7bd30>, '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 0x100de1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f73b20>, '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.ooORzFkFfn/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.UoiWkj9jXx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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 04:04:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:04:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:04:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ooORzFkFfn/Render', 04:04:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:04:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:04:48 INFO - 'HOME': '/Users/cltbld', 04:04:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:04:48 INFO - 'LOGNAME': 'cltbld', 04:04:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:48 INFO - 'MOZ_NO_REMOTE': '1', 04:04:48 INFO - 'NO_EM_RESTART': '1', 04:04:48 INFO - 'PAGER': '/bin/cat', 04:04:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:04:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:48 INFO - 'PWD': '/builds/slave/test', 04:04:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:04:48 INFO - 'SHELL': '/bin/bash', 04:04:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UoiWkj9jXx/Listeners', 04:04:48 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 04:04:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:04:48 INFO - 'USER': 'cltbld', 04:04:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:04:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:04:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:48 INFO - 'XPC_FLAGS': '0x0', 04:04:48 INFO - 'XPC_SERVICE_NAME': '0', 04:04:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:04:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:49 INFO - Downloading/unpacking jsonschema==2.5.1 04:04:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:04:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:51 INFO - Downloading functools32-3.2.3-2.tar.gz 04:04:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:04:52 INFO - warning: no files found matching '*.txt' 04:04:52 INFO - no previously-included directories found matching 'build' 04:04:52 INFO - no previously-included directories found matching 'dist' 04:04:52 INFO - no previously-included directories found matching '.git*' 04:04:52 INFO - Installing collected packages: jsonschema, functools32 04:04:52 INFO - Running setup.py install for functools32 04:04:52 INFO - warning: no files found matching '*.txt' 04:04:52 INFO - no previously-included directories found matching 'build' 04:04:52 INFO - no previously-included directories found matching 'dist' 04:04:52 INFO - no previously-included directories found matching '.git*' 04:04:52 INFO - Successfully installed jsonschema functools32 04:04:52 INFO - Cleaning up... 04:04:52 INFO - Return code: 0 04:04:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:04:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:04:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:52 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 0x101167490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010dd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd58d68660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f7bd30>, '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 0x100de1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f73b20>, '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.ooORzFkFfn/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.UoiWkj9jXx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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 04:04:52 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 04:04:52 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 04:04:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ooORzFkFfn/Render', 04:04:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:04:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:04:52 INFO - 'HOME': '/Users/cltbld', 04:04:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:04:52 INFO - 'LOGNAME': 'cltbld', 04:04:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:52 INFO - 'MOZ_NO_REMOTE': '1', 04:04:52 INFO - 'NO_EM_RESTART': '1', 04:04:52 INFO - 'PAGER': '/bin/cat', 04:04:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:04:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:52 INFO - 'PWD': '/builds/slave/test', 04:04:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:04:52 INFO - 'SHELL': '/bin/bash', 04:04:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UoiWkj9jXx/Listeners', 04:04:52 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 04:04:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:04:52 INFO - 'USER': 'cltbld', 04:04:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:04:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:04:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:52 INFO - 'XPC_FLAGS': '0x0', 04:04:52 INFO - 'XPC_SERVICE_NAME': '0', 04:04:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:04:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:04:52 INFO - Cleaning up... 04:04:52 INFO - Return code: 0 04:04:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:04:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:04:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:52 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 0x101167490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010dd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd58d68660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f7bd30>, '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 0x100de1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f73b20>, '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.ooORzFkFfn/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.UoiWkj9jXx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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 04:04:52 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 04:04:52 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 04:04:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ooORzFkFfn/Render', 04:04:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:04:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:04:52 INFO - 'HOME': '/Users/cltbld', 04:04:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:04:52 INFO - 'LOGNAME': 'cltbld', 04:04:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:52 INFO - 'MOZ_NO_REMOTE': '1', 04:04:52 INFO - 'NO_EM_RESTART': '1', 04:04:52 INFO - 'PAGER': '/bin/cat', 04:04:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:04:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:52 INFO - 'PWD': '/builds/slave/test', 04:04:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:04:52 INFO - 'SHELL': '/bin/bash', 04:04:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UoiWkj9jXx/Listeners', 04:04:52 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 04:04:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:04:52 INFO - 'USER': 'cltbld', 04:04:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:04:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:04:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:52 INFO - 'XPC_FLAGS': '0x0', 04:04:52 INFO - 'XPC_SERVICE_NAME': '0', 04:04:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:04:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:52 INFO - Downloading/unpacking blobuploader==1.2.4 04:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:55 INFO - Downloading blobuploader-1.2.4.tar.gz 04:04:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:04:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:04:55 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 04:04:55 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 04:04:55 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 04:04:55 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 04:04:55 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 04:04:55 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 04:04:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:04:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:04:56 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 04:04:56 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 04:04:56 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 04:04:56 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 04:04:56 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 04:04:56 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 04:04:56 INFO - Downloading docopt-0.6.1.tar.gz 04:04:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:04:56 INFO - Installing collected packages: blobuploader, requests, docopt 04:04:56 INFO - Running setup.py install for blobuploader 04:04:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:04:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:04:56 INFO - Running setup.py install for requests 04:04:57 INFO - Running setup.py install for docopt 04:04:57 INFO - Successfully installed blobuploader requests docopt 04:04:57 INFO - Cleaning up... 04:04:57 INFO - Return code: 0 04:04:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:04:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:04:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:57 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 0x101167490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010dd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd58d68660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f7bd30>, '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 0x100de1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f73b20>, '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.ooORzFkFfn/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.UoiWkj9jXx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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 04:04:57 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 04:04:57 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 04:04:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ooORzFkFfn/Render', 04:04:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:04:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:04:57 INFO - 'HOME': '/Users/cltbld', 04:04:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:04:57 INFO - 'LOGNAME': 'cltbld', 04:04:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:57 INFO - 'MOZ_NO_REMOTE': '1', 04:04:57 INFO - 'NO_EM_RESTART': '1', 04:04:57 INFO - 'PAGER': '/bin/cat', 04:04:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:04:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:57 INFO - 'PWD': '/builds/slave/test', 04:04:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:04:57 INFO - 'SHELL': '/bin/bash', 04:04:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UoiWkj9jXx/Listeners', 04:04:57 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 04:04:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:04:57 INFO - 'USER': 'cltbld', 04:04:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:04:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:04:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:57 INFO - 'XPC_FLAGS': '0x0', 04:04:57 INFO - 'XPC_SERVICE_NAME': '0', 04:04:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:04:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:04:57 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-MmMa4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:04:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:04:57 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-zws6al-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:04:58 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-22m1Gj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:04:58 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-GDcXZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:04:58 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-4kkzoL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:04:58 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-v0Xbk7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:04:58 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-GtdWxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:04:58 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-wd3UFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:04:58 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-V8ri4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:04:58 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-W7rr0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:04:58 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-mvSPrp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:04:58 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-tRBu6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:04:59 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-Icc0FW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:04:59 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-Ap7xNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:04:59 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-owkhC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:04:59 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-djnwXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:04:59 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-csVPCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:04:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:04:59 INFO - Running setup.py install for manifestparser 04:04:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:04:59 INFO - Running setup.py install for mozcrash 04:04:59 INFO - Running setup.py install for mozdebug 04:05:00 INFO - Running setup.py install for mozdevice 04:05:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:05:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:05:00 INFO - Running setup.py install for mozfile 04:05:00 INFO - Running setup.py install for mozhttpd 04:05:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:05:00 INFO - Running setup.py install for mozinfo 04:05:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:05:00 INFO - Running setup.py install for mozInstall 04:05:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:05:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:05:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:05:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:05:00 INFO - Running setup.py install for mozleak 04:05:00 INFO - Running setup.py install for mozlog 04:05:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:05:01 INFO - Running setup.py install for moznetwork 04:05:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:05:01 INFO - Running setup.py install for mozprocess 04:05:01 INFO - Running setup.py install for mozprofile 04:05:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:05:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:05:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:05:01 INFO - Running setup.py install for mozrunner 04:05:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:05:01 INFO - Running setup.py install for mozscreenshot 04:05:01 INFO - Running setup.py install for moztest 04:05:02 INFO - Running setup.py install for mozversion 04:05:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:05:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:05:02 INFO - Cleaning up... 04:05:02 INFO - Return code: 0 04:05:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:05:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:05:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:02 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 0x101167490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010dd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd58d68660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f7bd30>, '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 0x100de1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f73b20>, '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.ooORzFkFfn/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.UoiWkj9jXx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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 04:05:02 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 04:05:02 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 04:05:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ooORzFkFfn/Render', 04:05:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:05:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:05:02 INFO - 'HOME': '/Users/cltbld', 04:05:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:05:02 INFO - 'LOGNAME': 'cltbld', 04:05:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:02 INFO - 'MOZ_NO_REMOTE': '1', 04:05:02 INFO - 'NO_EM_RESTART': '1', 04:05:02 INFO - 'PAGER': '/bin/cat', 04:05:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:05:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:02 INFO - 'PWD': '/builds/slave/test', 04:05:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:05:02 INFO - 'SHELL': '/bin/bash', 04:05:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UoiWkj9jXx/Listeners', 04:05:02 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 04:05:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:05:02 INFO - 'USER': 'cltbld', 04:05:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:05:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:05:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:02 INFO - 'XPC_FLAGS': '0x0', 04:05:02 INFO - 'XPC_SERVICE_NAME': '0', 04:05:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:05:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:05:02 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-c0e8Xs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:05:02 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)) 04:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:05:02 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-Z80N8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:05:02 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)) 04:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:05:02 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-wDMGgn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:05:02 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)) 04:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:05:02 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-Difl2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:05:02 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)) 04:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:05:02 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-URpyAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:05:02 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)) 04:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:05:02 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-Kd9DaK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:05:03 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)) 04:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:05:03 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-wgsyCG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:05:03 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)) 04:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:05:03 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-FXEWY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:05:03 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)) 04:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:05:03 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-YBV6w5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:05:03 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)) 04:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:05:03 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-mWxndq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:05:03 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)) 04:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:05:03 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-OeuCuY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:05:03 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)) 04:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:05:03 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-Oy4IAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:05:03 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)) 04:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:05:03 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-Vc8Cwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:05:03 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)) 04:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:05:03 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-NXezOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:05:03 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)) 04:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:05:03 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-ejvZAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:05:04 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)) 04:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:05:04 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-CbdOnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:05:04 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)) 04:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:05:04 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-CNK08Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:05:04 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)) 04:05:04 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)) 04:05:04 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)) 04:05:04 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)) 04:05:04 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)) 04:05:04 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)) 04:05:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:05: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 04:05: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 04:05: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 04:05: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 04:05: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 04:05: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 04:05:06 INFO - Downloading blessings-1.6.tar.gz 04:05:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:05:06 INFO - Installing collected packages: blessings 04:05:06 INFO - Running setup.py install for blessings 04:05:06 INFO - Successfully installed blessings 04:05:06 INFO - Cleaning up... 04:05:07 INFO - Return code: 0 04:05:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:05:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:05:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:05:07 INFO - Reading from file tmpfile_stdout 04:05:07 INFO - Current package versions: 04:05:07 INFO - blessings == 1.6 04:05:07 INFO - blobuploader == 1.2.4 04:05:07 INFO - docopt == 0.6.1 04:05:07 INFO - functools32 == 3.2.3-2 04:05:07 INFO - jsonschema == 2.5.1 04:05:07 INFO - manifestparser == 1.1 04:05:07 INFO - mozInstall == 1.12 04:05:07 INFO - mozcrash == 0.17 04:05:07 INFO - mozdebug == 0.1 04:05:07 INFO - mozdevice == 0.48 04:05:07 INFO - mozfile == 1.2 04:05:07 INFO - mozhttpd == 0.7 04:05:07 INFO - mozinfo == 0.9 04:05:07 INFO - mozleak == 0.1 04:05:07 INFO - mozlog == 3.4 04:05:07 INFO - moznetwork == 0.27 04:05:07 INFO - mozprocess == 0.23 04:05:07 INFO - mozprofile == 0.28 04:05:07 INFO - mozrunner == 6.12 04:05:07 INFO - mozscreenshot == 0.1 04:05:07 INFO - mozsystemmonitor == 0.3 04:05:07 INFO - moztest == 0.7 04:05:07 INFO - mozversion == 1.4 04:05:07 INFO - psutil == 3.1.1 04:05:07 INFO - requests == 1.2.3 04:05:07 INFO - wsgiref == 0.1.2 04:05:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:05:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:05:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:05:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:07 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 0x101167490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010dd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd58d68660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f7bd30>, '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 0x100de1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f73b20>, '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.ooORzFkFfn/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.UoiWkj9jXx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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 04:05:07 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 04:05:07 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 04:05:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ooORzFkFfn/Render', 04:05:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:05:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:05:07 INFO - 'HOME': '/Users/cltbld', 04:05:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:05:07 INFO - 'LOGNAME': 'cltbld', 04:05:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:07 INFO - 'MOZ_NO_REMOTE': '1', 04:05:07 INFO - 'NO_EM_RESTART': '1', 04:05:07 INFO - 'PAGER': '/bin/cat', 04:05:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:05:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:07 INFO - 'PWD': '/builds/slave/test', 04:05:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:05:07 INFO - 'SHELL': '/bin/bash', 04:05:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UoiWkj9jXx/Listeners', 04:05:07 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 04:05:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:05:07 INFO - 'USER': 'cltbld', 04:05:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:05:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:05:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:07 INFO - 'XPC_FLAGS': '0x0', 04:05:07 INFO - 'XPC_SERVICE_NAME': '0', 04:05:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:05:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:07 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)) 04:05:07 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)) 04:05:07 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)) 04:05:07 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)) 04:05:07 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)) 04:05:07 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)) 04:05:07 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)) 04:05:07 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)) 04:05:07 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)) 04:05:07 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)) 04:05:07 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)) 04:05:07 INFO - Cleaning up... 04:05:07 INFO - Return code: 0 04:05:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:05:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:05:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:05:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:07 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 0x101167490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010dd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd58d68660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f7bd30>, '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 0x100de1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f73b20>, '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.ooORzFkFfn/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.UoiWkj9jXx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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 04:05:07 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 04:05:07 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 04:05:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ooORzFkFfn/Render', 04:05:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:05:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:05:07 INFO - 'HOME': '/Users/cltbld', 04:05:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:05:07 INFO - 'LOGNAME': 'cltbld', 04:05:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:07 INFO - 'MOZ_NO_REMOTE': '1', 04:05:07 INFO - 'NO_EM_RESTART': '1', 04:05:07 INFO - 'PAGER': '/bin/cat', 04:05:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:05:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:07 INFO - 'PWD': '/builds/slave/test', 04:05:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:05:07 INFO - 'SHELL': '/bin/bash', 04:05:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UoiWkj9jXx/Listeners', 04:05:07 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 04:05:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:05:07 INFO - 'USER': 'cltbld', 04:05:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:05:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:05:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:07 INFO - 'XPC_FLAGS': '0x0', 04:05:07 INFO - 'XPC_SERVICE_NAME': '0', 04:05:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:05:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:05:07 INFO - Cleaning up... 04:05:07 INFO - Return code: 0 04:05:07 INFO - Running post-action listener: _resource_record_post_action 04:05:07 INFO - Running post-action listener: _start_resource_monitoring 04:05:07 INFO - Starting resource monitoring. 04:05:07 INFO - [mozharness: 2016-11-03 11:05:07.890162Z] Finished create-virtualenv step (success) 04:05:07 INFO - [mozharness: 2016-11-03 11:05:07.891133Z] Running install step. 04:05:07 INFO - Running pre-action listener: _resource_record_pre_action 04:05:07 INFO - Running main action method: install 04:05:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:05:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:05:08 INFO - Reading from file tmpfile_stdout 04:05:08 INFO - Detecting whether we're running mozinstall >=1.0... 04:05:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:05:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:05:08 INFO - Reading from file tmpfile_stdout 04:05:08 INFO - Output received: 04:05:08 INFO - Usage: mozinstall [options] installer 04:05:08 INFO - Options: 04:05:08 INFO - -h, --help show this help message and exit 04:05:08 INFO - -d DEST, --destination=DEST 04:05:08 INFO - Directory to install application into. [default: 04:05:08 INFO - "/builds/slave/test"] 04:05:08 INFO - --app=APP Application being installed. [default: firefox] 04:05:08 INFO - mkdir: /builds/slave/test/build/application 04:05:08 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'] 04:05:08 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 04:05:40 INFO - Reading from file tmpfile_stdout 04:05:40 INFO - Output received: 04:05:40 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 04:05:40 INFO - Running post-action listener: _resource_record_post_action 04:05:40 INFO - [mozharness: 2016-11-03 11:05:40.714415Z] Finished install step (success) 04:05:40 INFO - [mozharness: 2016-11-03 11:05:40.714551Z] Running run-tests step. 04:05:40 INFO - Running pre-action listener: _resource_record_pre_action 04:05:40 INFO - Running main action method: run_tests 04:05:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:05:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:05:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:05:40 INFO - 2016-11-03 04:05:40.728 screenresolution[1648:7506] starting screenresolution argv=screenresolution get 04:05:40 INFO - 2016-11-03 04:05:40.731 screenresolution[1648:7506] Display 0: 1600x1200x32@60 04:05:40 INFO - 2016-11-03 04:05:40.737 screenresolution[1649:7509] starting screenresolution argv=screenresolution list 04:05:40 INFO - Available Modes on Display 0 04:05:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:05:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:05:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:05:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:05:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:05:40 INFO - Intel Iris: 04:05:40 INFO - Chipset Model: Intel Iris 04:05:40 INFO - Type: GPU 04:05:40 INFO - Bus: Built-In 04:05:40 INFO - VRAM (Dynamic, Max): 1536 MB 04:05:40 INFO - Vendor: Intel (0x8086) 04:05:40 INFO - Device ID: 0x0a2e 04:05:40 INFO - Revision ID: 0x0009 04:05:40 INFO - Displays: 04:05:40 INFO - Display: 04:05:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:05:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:05:40 INFO - Display Serial Number: 1600x1200 60 04:05:40 INFO - Main Display: Yes 04:05:40 INFO - Mirror: Off 04:05:40 INFO - Online: Yes 04:05:40 INFO - Rotation: Supported 04:05:40 INFO - Return code: 0 04:05:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:05:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:05:40 INFO - Python 2.7.3 04:05:40 INFO - Return code: 0 04:05:40 INFO - grabbing minidump binary from tooltool 04:05:40 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')]} 04:05:40 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 0x100f7bd30>, '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 0x100de1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f73b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:05:40 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 04:05:40 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 04:05:40 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 04:05:41 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:05:41 INFO - Return code: 0 04:05:41 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:05:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:05:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:05:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:05:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:05:41 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/Dd8zwx0xR8CEmyg-D80NMw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0330', '--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 04:05:41 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/Dd8zwx0xR8CEmyg-D80NMw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0330 --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 04:05:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ooORzFkFfn/Render', 04:05:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:05:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:05:41 INFO - 'HOME': '/Users/cltbld', 04:05:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:05:41 INFO - 'LOGNAME': 'cltbld', 04:05:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:05:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:05:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:41 INFO - 'MOZ_NO_REMOTE': '1', 04:05:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:05:41 INFO - 'NO_EM_RESTART': '1', 04:05:41 INFO - 'PAGER': '/bin/cat', 04:05:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:05:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:41 INFO - 'PWD': '/builds/slave/test', 04:05:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:05:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:05:41 INFO - 'SHELL': '/bin/bash', 04:05:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UoiWkj9jXx/Listeners', 04:05:41 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 04:05:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:05:41 INFO - 'USER': 'cltbld', 04:05:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:05:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:05:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:41 INFO - 'XPC_FLAGS': '0x0', 04:05:41 INFO - 'XPC_SERVICE_NAME': '0', 04:05:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:05:41 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/Dd8zwx0xR8CEmyg-D80NMw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0330', '--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 04:05:41 INFO - mozversion application_buildid: 20161103015123 04:05:41 INFO - mozversion application_changeset: 0ae3a7425ff1a1371b888313013be1c3bd5ddbdd 04:05:41 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:05:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:05:41 INFO - mozversion application_name: Firefox 04:05:41 INFO - mozversion application_remotingname: firefox-dev 04:05:41 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:05:41 INFO - mozversion application_vendor: Mozilla 04:05:41 INFO - mozversion application_version: 51.0a2 04:05:41 INFO - mozversion platform_buildid: 20161103015123 04:05:41 INFO - mozversion platform_changeset: 0ae3a7425ff1a1371b888313013be1c3bd5ddbdd 04:05:41 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:05:41 INFO - mozversion platform_version: 51.0a2 04:05:41 INFO - using testdate: 1478171141 04:05:41 INFO - actual date: 1478171141 04:05:41 INFO - starting webserver on 'localhost:49266' 04:05:41 INFO - SUITE-START | Running 2 tests 04:05:41 INFO - TEST-START | dromaeo_css 04:05:41 INFO - operating with platform_type : mac_ 04:05:41 INFO - Initialising browser for dromaeo_css test... 04:05:41 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/tmpCN4LXx/profile http://localhost:49266/getInfo.html) 04:05:43 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 04:05:43 INFO - PROCESS | 1659 | colorDepth:24 04:05:43 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 04:05:43 INFO - PROCESS | 1659 | __metrics 04:05:43 INFO - PROCESS | 1659 | 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" 04:05:43 INFO - PROCESS | 1659 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:05:44 INFO - TEST-INFO | 1659: exit 0 04:05:44 INFO - Browser initialized. 04:05:44 INFO - Running cycle 1/1 for dromaeo_css test... 04:05:44 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/tmpCN4LXx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:05:56 INFO - PROCESS | 1661 | RSS: Main: 219848704 04:05:56 INFO - PROCESS | 1661 | 04:06:47 INFO - PROCESS | 1661 | 1478171207851 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] 04:09:00 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 04:09:01 INFO - PROCESS | 1661 | RSS: Main: 348889088 04:09:01 INFO - PROCESS | 1661 | 04:12:04 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 04:12:05 INFO - PROCESS | 1661 | RSS: Main: 351633408 04:12:05 INFO - PROCESS | 1661 | 04:15:07 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 04:15:08 INFO - PROCESS | 1661 | RSS: Main: 350060544 04:15:08 INFO - PROCESS | 1661 | 04:18:10 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 04:18:11 INFO - PROCESS | 1661 | RSS: Main: 320548864 04:18:11 INFO - PROCESS | 1661 | 04:21:14 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 04:21:15 INFO - PROCESS | 1661 | RSS: Main: 311205888 04:21:15 INFO - PROCESS | 1661 | 04:24:18 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 04:24:18 INFO - PROCESS | 1661 | RSS: Main: 357326848 04:24:18 INFO - PROCESS | 1661 | 04:24:18 INFO - PROCESS | 1661 | __start_tp_report 04:24:18 INFO - PROCESS | 1661 | _x_x_mozilla_page_load 04:24:18 INFO - PROCESS | 1661 | _x_x_mozilla_page_load_details 04:24:18 INFO - PROCESS | 1661 | |i|pagename|runs| 04:24:18 INFO - PROCESS | 1661 | |0;dojo.html;3270.2151483643925;3292.8024318540884;3326.4012477754027;3333.383324085043;3386.339663765565;5630.77476900924;5680.602357834943;5737.282839645044;5764.135379693048;5781.7109144542765;5647.040003199456;5703.144528320754;5723.828285151441;5742.167385729067;5742.885142297151;5191.480851914816;5203.86990325243;5226.738663066841;5239.816606418776;5262.000219958196;5187.144121219994;5188.429272779991;5203.089459344599;5304.549113325353;5333.519983201511;5190.273361729361;5223.973880130594;5238.13570760824;5241.3186285782795;5253.737313134328;5237.554807841319;5274.05067087924;5299.046171689094;5301.231321458367;5346.304980352568;5042.495750424965;5154.690718556899;5223.268742376071;5237.214417837316;5251.894962100737;5610.579206559483;5631.6902570359025;5632.633878797865;5676.886462270772;5714.71426428681;6191.9690401547705;6211.937880621181;6255.718492667841;6279.466245369149;6291.559590828644;6142.6522545212965;6251.593646412968;6254.186955695776;6301.810945671591;6331.430171284561;4820.3492528508905;5689.203511508392;5741.942580574141;5778.797742079007;5781.219535362757;6242.781502647385;6303.3066362700065;6304.05439184126;6321.209848768904;6333.746650133943;6045.6070355426755;6169.475594574422;6178.567500275028;6180.567360284737;6190.823743488722;5526.171074338801;5914.940850591525;6169.660668663177;6171.074338849208;6232.968835155795;5534.280543529316;6165.075238714228;6238.220222472191;6246.937530624727;6248.375162483715;6216.191895053614;6267.2792628847355;6275.1842260506755;6282.18331616896;6284.12022316876;4850.854474365704;4904.215325547895;4915.8033678652455;4917.409910810654;4969.105560998983;3783.981080094582;4424.60178583929;4454.175977444183;4470.083632855322;4480.036792089716;5778.797742079091;5781.739821708034;5783.624064435882;5785;5787.363390027093;5190.532852043334;6211.9689401553605;6296.65368404733;6302.275238347557;6333.923233050393;5808.82573522795;5814.215080964016;5816.1566572846705;5822.679752613562;5863.413658634103;5430.022595932691;5458.781648734006;5463.207834864002;5472.863178420572;5473.589480788957;6009.06859436788;6227.532935029891;6259.06114082873;6276.623402595859;6285.528585356208;6319.431251187415;6335.556511044183;6338.968305158444;6348.93651063502;6355.14205582259;6314.431701146918;6327.335629758809;6344.619322840645;6356.809295721136;6362.840928976812;6065.939340606537;6109.9816581254145;6119.020956646915;6131.662758548323;6213.285472170758;6101.298350689727;6193.102000210034;6252.499800015897;6323.588966717149;6334.461570766536;6127.938720612737;6143.293521245114;6145.938540614537;6148.846278843064;6164.845878853064;5415.2147938547905;5923.052311630118;6082.118092876596;6102.176206212104;6138.048602466625;5837.854053648693;5916.970415147896;5939.316978547349;5971.044632858721;5991.281046274475;6145.187169785014;6156.507479401726;6168.414000669929;6184.010558310649;6190.7523699051535;5953.583249172516;5972.34304226526;6015.030090120541;6060.757569697163;6095.329513753572 04:24:18 INFO - PROCESS | 1661 | |1;ext.html;472.93353487884826;499.7576175554855;514.8532668189566;527.1802347349874;527.6095689189998;29366.41267174655;29835;29848.701512984862;31137.37725245494;32175.51736723948;32181.839090804515;35143.82428087856;42285.15429691404;42451.78774106125;44380.668579942656;9614.663486777947;9768.072033156874;9794.559244833965;9817.90182098177;9827.115559599635;9694.17599504043;9796.6081356746;9800.509974501281;9805.65680201193;9816.214702823758;8624.65501379944;8835.514046727427;11749.41252937354;11997.580084697038;12012.099092568049;11837.348945807977;11983.760324793499;12065.155439119266;12066.939665301705;12072.456739446747;11786.233894796811;11855.170138090338;11855.347955862424;11856.881431185664;11867.643970680894;30784;31279;39108.60891391078;39337.803310983545;39465.60534394648;3402.9659703402895;3470.583529976419;3627.4014787560022;3691.1141326081547;3984.1035766952496;30766.07701768928;31934.840325798454;32873;33617.663823361945;33986.83006584976;3147.5436061771143;3279.737620990315;3302.653221411765;3381.932361352759;3419.606745224306;508325;509635;517221;517280.41359793337;517465;54728.63178420492;67234.65530689359;68633.65683171552;68705.65647171732;68819;55674.443255567734;59335;59337.109943350886;59374.40625593775;67397.66301168462;15549.067055976677;16331.91834040846;16359.427420040241;16366;16393.59016024609;12313.953313968233;12334.629961101182;12338.3830808461;12354.196977196454;12394.946429553589;14813.777793333109;20009;20263.8854862981;20332.59334813325;20361.185552578027;7229.132504099542;7286.744963926237;7603.870916143489;8472.49165050099;8734.650613975497;881.299367003234;899.8560230363111;964.2430691906819;1023.7235946294608;1070.7269646240159;28975.56536651952;29625;29966;29983.25041873927;30768.384632307676;1010.8534262531891;1066.7599790047332;1072.785442911421;1073.1897417449775;1098.3849044535086;15120.924395378173;15561.455349062728;15580.922095389451;15650;15870.047797132209;710997;715573;718945;719425;719952;49349.50650493521;49798;49882.50117498779;56277.7186114075;57161.42838571644;1359.34071975092;1372.9656758581116;1404;1407.9155250684992;1408.78163884596;26828.597571036058;29872.040661643616;30860;31090.68909310878;31233.519776269022;49334.01331973269;49883.75058124686;49928.75035624798;49951;50021;676066;698793;700144;912176;915101;26740.064097757262;42241.36637950494;42340.36489452599;42653.57346426496;42971.35542966796;45375.773121135506;47490;47586.76206618945;47682.523174769194;48592.028159435904;38444.61555384522;38937.805310973265;39181.60818391779;39796.21643834301;40705;31951.840240798647;38345;38700.41949370818;40313.79843100883;40382.9904252396;37664.81167594145;38242.808785955895;38450.230995380494;38519.42220866633;38690.4196437048;30041.347725875286;32233;34655.48016779801;34813.65186348104;34851.4772278411;25411.36471588225;25661.74338256668;25763.355916102246;26164.869175654;26284.94860205647 04:24:18 INFO - PROCESS | 1661 | |2;jquery.html;353.7806559932842;361.1332801276935;375.93797023491106;384.18744355687727;406.666533442577;15383.077015379085;15492.380304787808;17320.913395433006;21120.683189752166;21538.89230553849;20673;20902.477438064056;21355.466113347175;21360.893195534038;21535.030923608436;5180;5527.50252477277;5997.7600895964215;6264.780732674334;6278.529110316722;4233.19569281837;6154;6257.468115210213;6261;6267.686615669221;4451.532589078149;6625.304343043959;6925.238223795379;6954.756583519578;7065.470089743264;5750.769969201227;6123.357047509992;6167.105769663373;7032.613206273653;7034.6834392452465;5995.460408563206;6004.489618382443;6005.669688167149;6006.879862402728;6013.7293821777685;23151.76848231513;25273.494530109478;25698.229053128434;25742.613860792102;25769.711514424205;2204.360735386736;2208.3043841189974;2305.1816605105114;2351.247600767755;2602.3624212068166;9355.532223388871;9827.656032038843;10153.746156346151;10209.438480883548;10278;1773.6807374672553;1820.6486497271533;1862.9347972820885;1878.1454438230571;1888.3107665702057;96685;100397;121788;122672;126652.36673816665;9091.590878410487;11412.600558980395;11470.311781293149;11589.6523104307;11688.70778230534;14358.138511689333;14380;14387;14387.92806035963;14445.133292002514;8421.747347579583;8647.264982476434;8667.393282470293;8782.077881822317;8786.297096232285;8663.220310172115;8685.261752751087;8688.739337819876;8879.644814207359;8883.466991980502;4416.315471101984;4506.121306345297;4530.88672783183;4547.636189104864;4598.701084429568;1579.8499142581436;1847.9630407391776;1897.354899334233;1906.218450435315;1910.1404368034162;780.5823884221915;840.9159084091664;885.287343688337;988.5897352598735;997.9700608981597;20342.288019919528;21933.122675092818;21985.340439786833;22052.007659655355;22071.00680469383;901.2744740483843;941.8775559177263;943.6555657185215;962.1244667352676;987.0573602209872;8780.429272097294;9850.753731156636;11284.492197851116;12192.512299508098;12248.571300004634;620516;626160.7383926193;633714;637217;644701;126105.73894261123;138602.3069884644;139689;140956;144853;1015.0712098430001;1019.6227395863579;1022.2486472442748;1065.5151905882806;1069.8769641491172;18655.72016419782;19478.026098694725;20041.49896252547;20069.49826254297;20093.296734614218;55637;56449.71775141098;56889.43110568841;57615;57991.71004144952;61598;81182;82274.58862705648;82773;85066;8019.358451323997;8152.633131508977;8190.099089100075;8501.574921254036;8544.658213671384;12543.87456125427;12998.740025199631;13113.344332783132;13208.33958302062;13346.532871349456;10934.835977460185;11157.330560166416;11246.381449020055;11314.03830674402;11525.942370288094;10620.628278010232;11033;11086.057685096535;11153.386563739072;11285.322880627189;9792.510374481106;10888.455577221266;11399.259048161843;11525.308481491138;11793.587224447103;7927.762167134995;7996.840063198587;8111.716089936824;8299.792505187419;8462.492250464991;8339.791505212419;10357.378557286587;11219.158563107963;11267.323960562393;11554.76890462203 04:24:18 INFO - PROCESS | 1661 | |3;mootools.html;1363.4273605085864;1526.5267766992233;1552.0532475190137;1755.8595312375012;1901.3060233014953;7900.209979002104;8417.537035463054;8662.307015438766;8952.865707014384;8960.686375976842;8813.206811386974;8923.15230053144;8925;8926.642934282638;8929.330300227477;2399.256230568525;2431.222008957134;2434.7808697217247;2436.683231179944;2439.146298795425;2398.556267090585;2416.685830841997;2433.841800282985;2439.9752104116224;2443.657887895696;2392.8803559822027;2393.1623931623967;2413.4569721812627;2424.8423852449623;2427.5387676341525;2108.9156433742633;2244.9663255051187;2389.95220095598;2401.8438801477846;2402.1352313167245;2355.823313251513;2379.0364902214633;2379.298107058422;2381.5475059738596;2382.392489915078;8735.43219690718;8953.328500362433;8953.865692014626;8957.328200384933;8959.776005599848;5235.476452354772;5425;5427.62006659534;5473.616846820724;5495.642783219078;3656.451532270154;3680.411134218539;3714.647108524713;3755.0800053986677;3760.6615404613717;1083.9024487796137;1086.2124959404448;1090.2368342160519;1108.3073079325422;1110.5002748763088;11884.40577971098;11926.344051077187;12004.279743215435;12020.63938081859;12047.518099276018;4473.507914129443;4529.68292219548;4697.81208751653;4704.88237794051;4706.882327941828;9192.21866141372;9202.30982676302;9209.125133112344;9211.769705757275;9217.815643687089;5291.365036195604;5293.788248470018;5296.523312901857;5299.258103865462;5304.92042619361;4204.684648651363;4434.645228381786;4591.242444996605;4591.724496530219;4962.206047032458;3124.7343975762315;3813.504244448204;3895.454636350913;3898.532176138825;3910.7066969977363;1147.5065721739566;1167.3871217610822;1172.384498138484;1179.9823002654966;1180.7992641250837;767.0909971683461;863.589794847455;892.2772554231094;908.9136532029447;911.813078318943;5605.691686957175;5728.51307638847;5774.480296773227;5985.132155837379;6068.787592434243;864.3085531574715;938.4932136646271;948;964.4165280005636;983.3509883476871;3704.5554533456157;3842.4620553122586;3853.96146038536;3854.325493038763;3975.105601239698;10699.518521666543;10905.291156074829;11020.906027854682;11036.227464077598;11072.3910184939;10989.450527473595;10990.890091098987;10991.285566438157;10991.505382257817;11043.944780276208;7869.213078692085;8167.183281671904;8176.918230817616;8368.3305335573;8444.57777111142;5178.119719647593;5673.319201695823;5710.17202505626;5889.882202356014;5957.314908785545;9778.315517913677;9893.307468477138;10073.496325183858;10176.643817466353;10231.181505479693;8127.593620318842;10129.139023183112;10240.64157754475;10356.326838755456;10370.688879333633;7525.435592330707;7703.768886933401;7711.537307761328;7713.151553329241;7722.189170137055;8124;8326.50040997542;8402.285805706584;8404.20160084791;8415.11641277657;7546.773596792105;7550.924490755022;7571.507851989603;7616.276453736886;7685.730999414994;7326.4138868889295;7409.814754630962;7436;7476.775696729107;7476.9532265481785;6927.134108236471;7012.298770122947;7080.610566418896;7100.467464940253;7114;4872.610191184767;4880.438749543848;4920.311156438173;4962.280469331999;4966.428860680923;4833.347498087714;4895.877603059809;4990.476000019946;5040.243963405518;5046.268291097844 04:24:18 INFO - PROCESS | 1661 | |4;prototype.html;272.4414949353824;291.1034015233084;292.1993737160181;300.7969620506158;303.8936372269706;4040.6767458603313;4190.811413486393;5090.650977490968;5327.573794096473;5385.919211211825;4908.901821963558;5274.841754747364;5305.920411193835;5319.361676598804;5367.892642147155;3511.894643160709;3722.4602432647384;3976.1848820991627;3984.4820173377566;4035;3747.7563958342757;3887.3391523441082;3903.609639036102;4034.3746719258415;4041.575634558373;3282.770206085575;3618.5476815398074;3979.8408063677416;3982.900427489307;4006.8998275043064;4003.679705623543;4014.498187726534;4017.7589344639414;4020.3567429211184;4024.476818013669;2780.957141072098;2841.659000919882;3344.4481660525985;3399.3031428557088;3460.377132116218;4452.0873220989615;5067.721275329855;5097.1844504879045;5133.281340612317;5149.3305870237;4520.547945205486;4524.343970124346;4532.342810292489;4533.659975501818;4561.612262957653;4541.886452838672;5220.921686174673;5540.86147846303;5562.3881373048935;5568.9443105569235;3259.755518336134;3700.888973330804;3741.139537906297;3751.4935483709623;3763.6236376362417;5762.481376676077;5821.068629019379;5828.125781132864;5836.88326233473;5897.233359663216;3046.2484071658887;3672.761270517408;3843.5387753469763;3845.2693988142164;3858.5176852893387;3042.8478576071107;3191.744660427207;3470.9652903471147;3834.846606135779;3835;3504.3867323218333;3679.172186258124;3781.4138808484727;4274.764887931132;4409.735415874994;4688.866565712593;5515.876387590806;5534.537130976757;5555.583331250173;5556.749946252428;1308.7447947650307;1331.9200847949155;1332.9866701333056;1333.986170510419;1341.6914109754812;734.736253643732;835.8507052802397;862.1507814802414;876.54419701756;886.4371124335964;4404.238304678091;5195.636305458657;5210.7915683373;5212.7489402543115;5219.556337711337;4980.879302156985;5399.568034557226;5640.294963129609;5667.773289068474;5735;4902.921357301388;4982.277569752366;5259.36887573486;5265.973670131625;5266.499682530153;2353.411447273118;2513.4219129600297;2529.5446819572653;2531.152064058561;2540.4411029573466;3910.6675932546054;3997.6402123809;4341.761203133795;4603.01607909716;4987.900241995139;4301;4485.205917632973;4727.432708075053;4849.612031037508;4868.440129385095;4334.783260836945;4358.58593433617;4377.474703035656;4592.897704550951;4995.375578052744;3816.7137464689704;4674.415698037746;4769.546893045155;4789.592884604708;4861.562459378673;4250.723702959298;4718.504557021463;4725.5663333382645;4728.45622753374;4753.453352864465;3947.703922205789;4449.911001780011;4769;4878.878028049327;4934.3716573531365;2751.5047291487726;2963.851807409664;3310.2551925816497;3321.086701157201;3359.3874940029414;4437.223485890021;4779.713217206979;4783.593394561502;5371.811986580451;5625.493705566519;5184.662996905189;5416.783328666967;5492.642978206404;5609.74756135983;5668.631538949955;5487;5526.364468086222;5549.890021995537;5552.5008247773685;5579.409868187547;5252.606054546;5429.484199001088;5479.561635069264;5513.696746678811;5549.639273447213;5181.974090129525;5236.947630523799;5330.786768529216;5500.5874559409;5595.356533998643;4474.552544745499;5290.550303224269;5446.400895901527;5480.314960629921;5507.834764957058 04:24:18 INFO - PROCESS | 1661 | |5;yui.html;750.1036261667309;771.2018061306547;777.8211011467358;798.3815257080823;805.8388322335533;13965.022448428614;14303.856961430383;14798.186099764522;14831.851681483182;16419.343226270965;14227.78658320126;14426.639334016654;14493.855061449382;14509.274536273197;14519.49181778638;828.6064119543214;856.7044369692446;857.5797859049084;858.4634603372892;859.716293623106;554.7365001624237;683.9897401538981;684.5995092870652;835.1106072033265;855.670566831768;908.9590968406437;914.3508109242413;914.8170365926841;917.0371110334156;917.0645941140033;906.5739102621757;907.4101833808078;907.5416914458223;908.2960705453261;908.8636704494313;512.0654804980887;529.3594750352079;643.0290261704813;662.6686656671665;665.6638397609177;15463.226838658022;15483.22583870802;15496.147711875843;15527.844721552752;15533.533993980198;14042.438302467888;14333.641658958506;14397.856021439757;14544.490942817056;14658.926705366512;12144.3320617366;12416.447944006999;12474.43865026076;13127.474901003949;13197.604071877762;4613.907721845578;4616;4717.575418212343;4721.811127554894;4799.112164249625;120781.79218207882;121302;124240;127144;128909.35545322308;10947.726306842233;11222.775544489064;11372.48823802931;11390.487428065757;11472.655820325404;18871.90564047171;22679.546409072056;22704.772952270265;22839.88580057089;22852.65721014186;7803.102643195992;7858.553950814753;8157.55133467665;8204.876926846102;8264.132266112092;4203.5376108628025;4414.889627759268;4435.534268901783;4577.267637178035;4594.264917613166;3245.367153405063;3478.9478157827652;3688.686461650736;3966.36538153894;4165.187788381297;743.2790193512285;755.8412733325953;763.5418748750816;767.397592889579;768.2164192523595;633.6324931539788;653.4608947618234;660.6300471735843;664.5149041199951;682.1405029662661;8947.686830960885;9585.856212156823;9732.367396119229;9760.902390976;9979;651.4202359899693;659.1496968910052;663.7278715726529;667.6127845849396;685.3763075601179;4485.170243504962;4788.808447662054;4804.927926081112;4861.9191105541795;4866.926996095061;168385;176254;177526;178052;180783.09608451874;144949.8257526138;147712;151870;152609;154647;127053.99999999815;127228.7277127217;128070.35964820116;131321.3433932824;132736.67263327242;8998.235150012322;8999.865002024844;9191.862122068309;9236.26109911192;9258;61053;70549;70639.940400893;70854.64572677104;72907.27092729005;103803;106263;109339.90660093616;110663;120373;11656.18406711522;11871.287722736663;12055.638330850088;12079.154459187772;12407.007439404646;12870.420831062438;13049.804252936023;13334.466621335037;13755.518556850462;13816.516421925184;12210.938945305217;12430.875691243333;12823.93588032054;12875.098743087894;12929.612111636667;12125.75748485043;12455.065870059601;12478.438470268678;12533.93733031329;12543.059270554562;12092.516299347928;12101.273923564615;12119.697007574528;12269.447874845831;12740.917022053229;10164.33931794431;10351.06840384369;10470.528826202992;10932.617358392417;10944.726381840517;9973.32565059094;10102.141317988053;10599.8197004636;10715.785684286426;10821.729456763329 04:24:18 INFO - PROCESS | 1661 | __end_tp_report 04:24:18 INFO - PROCESS | 1661 | __start_cc_report 04:24:18 INFO - PROCESS | 1661 | _x_x_mozilla_cycle_collect,1226 04:24:18 INFO - PROCESS | 1661 | __end_cc_report 04:24:18 INFO - PROCESS | 1661 | __startTimestamp1478172258411__endTimestamp 04:24:18 INFO - PROCESS | 1661 | 04:24:18 INFO - PROCESS | 1661 | ------- Summary: start ------- 04:24:18 INFO - PROCESS | 1661 | Number of tests: 6 04:24:18 INFO - PROCESS | 1661 | 04:24:18 INFO - PROCESS | 1661 | [#0] dojo.html Cycles:165 Average:5735.72 Median:5923.05 stddev:654.80 (11.1%) stddev-sans-first:627.60 04:24:18 INFO - PROCESS | 1661 | Values: 3270.2 3292.8 3326.4 3333.4 3386.3 5630.8 5680.6 5737.3 5764.1 5781.7 5647.0 5703.1 5723.8 5742.2 5742.9 5191.5 5203.9 5226.7 5239.8 5262.0 5187.1 5188.4 5203.1 5304.5 5333.5 5190.3 5224.0 5238.1 5241.3 5253.7 5237.6 5274.1 5299.0 5301.2 5346.3 5042.5 5154.7 5223.3 5237.2 5251.9 5610.6 5631.7 5632.6 5676.9 5714.7 6192.0 6211.9 6255.7 6279.5 6291.6 6142.7 6251.6 6254.2 6301.8 6331.4 4820.3 5689.2 5741.9 5778.8 5781.2 6242.8 6303.3 6304.1 6321.2 6333.7 6045.6 6169.5 6178.6 6180.6 6190.8 5526.2 5914.9 6169.7 6171.1 6233.0 5534.3 6165.1 6238.2 6246.9 6248.4 6216.2 6267.3 6275.2 6282.2 6284.1 4850.9 4904.2 4915.8 4917.4 4969.1 3784.0 4424.6 4454.2 4470.1 4480.0 5778.8 5781.7 5783.6 5785.0 5787.4 5190.5 6212.0 6296.7 6302.3 6333.9 5808.8 5814.2 5816.2 5822.7 5863.4 5430.0 5458.8 5463.2 5472.9 5473.6 6009.1 6227.5 6259.1 6276.6 6285.5 6319.4 6335.6 6339.0 6348.9 6355.1 6314.4 6327.3 6344.6 6356.8 6362.8 6065.9 6110.0 6119.0 6131.7 6213.3 6101.3 6193.1 6252.5 6323.6 6334.5 6127.9 6143.3 6145.9 6148.8 6164.8 5415.2 5923.1 6082.1 6102.2 6138.0 5837.9 5917.0 5939.3 5971.0 5991.3 6145.2 6156.5 6168.4 6184.0 6190.8 5953.6 5972.3 6015.0 6060.8 6095.3 04:24:18 INFO - PROCESS | 1661 | 04:24:18 INFO - PROCESS | 1661 | [#1] ext.html Cycles:180 Average:78762.02 Median:37953.81 stddev:183665.97 (483.9%) stddev-sans-first:184087.14 04:24:18 INFO - PROCESS | 1661 | Values: 472.9 499.8 514.9 527.2 527.6 29366.4 29835.0 29848.7 31137.4 32175.5 32181.8 35143.8 42285.2 42451.8 44380.7 9614.7 9768.1 9794.6 9817.9 9827.1 9694.2 9796.6 9800.5 9805.7 9816.2 8624.7 8835.5 11749.4 11997.6 12012.1 11837.3 11983.8 12065.2 12066.9 12072.5 11786.2 11855.2 11855.3 11856.9 11867.6 30784.0 31279.0 39108.6 39337.8 39465.6 3403.0 3470.6 3627.4 3691.1 3984.1 30766.1 31934.8 32873.0 33617.7 33986.8 3147.5 3279.7 3302.7 3381.9 3419.6 508325.0 509635.0 517221.0 517280.4 517465.0 54728.6 67234.7 68633.7 68705.7 68819.0 55674.4 59335.0 59337.1 59374.4 67397.7 15549.1 16331.9 16359.4 16366.0 16393.6 12314.0 12334.6 12338.4 12354.2 12394.9 14813.8 20009.0 20263.9 20332.6 20361.2 7229.1 7286.7 7603.9 8472.5 8734.7 881.3 899.9 964.2 1023.7 1070.7 28975.6 29625.0 29966.0 29983.3 30768.4 1010.9 1066.8 1072.8 1073.2 1098.4 15120.9 15561.5 15580.9 15650.0 15870.0 710997.0 715573.0 718945.0 719425.0 719952.0 49349.5 49798.0 49882.5 56277.7 57161.4 1359.3 1373.0 1404.0 1407.9 1408.8 26828.6 29872.0 30860.0 31090.7 31233.5 49334.0 49883.8 49928.8 49951.0 50021.0 676066.0 698793.0 700144.0 912176.0 915101.0 26740.1 42241.4 42340.4 42653.6 42971.4 45375.8 47490.0 47586.8 47682.5 48592.0 38444.6 38937.8 39181.6 39796.2 40705.0 31951.8 38345.0 38700.4 40313.8 40383.0 37664.8 38242.8 38450.2 38519.4 38690.4 30041.3 32233.0 34655.5 34813.7 34851.5 25411.4 25661.7 25763.4 26164.9 26284.9 04:24:18 INFO - PROCESS | 1661 | 04:24:18 INFO - PROCESS | 1661 | [#2] jquery.html Cycles:180 Average:36300.86 Median:14186.04 stddev:105476.33 (743.5%) stddev-sans-first:105737.69 04:24:18 INFO - PROCESS | 1661 | Values: 353.8 361.1 375.9 384.2 406.7 15383.1 15492.4 17320.9 21120.7 21538.9 20673.0 20902.5 21355.5 21360.9 21535.0 5180.0 5527.5 5997.8 6264.8 6278.5 4233.2 6154.0 6257.5 6261.0 6267.7 4451.5 6625.3 6925.2 6954.8 7065.5 5750.8 6123.4 6167.1 7032.6 7034.7 5995.5 6004.5 6005.7 6006.9 6013.7 23151.8 25273.5 25698.2 25742.6 25769.7 2204.4 2208.3 2305.2 2351.2 2602.4 9355.5 9827.7 10153.7 10209.4 10278.0 1773.7 1820.6 1862.9 1878.1 1888.3 96685.0 100397.0 121788.0 122672.0 126652.4 9091.6 11412.6 11470.3 11589.7 11688.7 14358.1 14380.0 14387.0 14387.9 14445.1 8421.7 8647.3 8667.4 8782.1 8786.3 8663.2 8685.3 8688.7 8879.6 8883.5 4416.3 4506.1 4530.9 4547.6 4598.7 1579.8 1848.0 1897.4 1906.2 1910.1 780.6 840.9 885.3 988.6 998.0 20342.3 21933.1 21985.3 22052.0 22071.0 901.3 941.9 943.7 962.1 987.1 8780.4 9850.8 11284.5 12192.5 12248.6 620516.0 626160.7 633714.0 637217.0 644701.0 126105.7 138602.3 139689.0 140956.0 144853.0 1015.1 1019.6 1022.2 1065.5 1069.9 18655.7 19478.0 20041.5 20069.5 20093.3 55637.0 56449.7 56889.4 57615.0 57991.7 61598.0 81182.0 82274.6 82773.0 85066.0 8019.4 8152.6 8190.1 8501.6 8544.7 12543.9 12998.7 13113.3 13208.3 13346.5 10934.8 11157.3 11246.4 11314.0 11525.9 10620.6 11033.0 11086.1 11153.4 11285.3 9792.5 10888.5 11399.3 11525.3 11793.6 7927.8 7996.8 8111.7 8299.8 8462.5 8339.8 10357.4 11219.2 11267.3 11554.8 04:24:18 INFO - PROCESS | 1661 | 04:24:18 INFO - PROCESS | 1661 | [#3] mootools.html Cycles:180 Average:5719.41 Median:4941.26 stddev:3229.16 (65.4%) stddev-sans-first:3221.62 04:24:18 INFO - PROCESS | 1661 | Values: 1363.4 1526.5 1552.1 1755.9 1901.3 7900.2 8417.5 8662.3 8952.9 8960.7 8813.2 8923.2 8925.0 8926.6 8929.3 2399.3 2431.2 2434.8 2436.7 2439.1 2398.6 2416.7 2433.8 2440.0 2443.7 2392.9 2393.2 2413.5 2424.8 2427.5 2108.9 2245.0 2390.0 2401.8 2402.1 2355.8 2379.0 2379.3 2381.5 2382.4 8735.4 8953.3 8953.9 8957.3 8959.8 5235.5 5425.0 5427.6 5473.6 5495.6 3656.5 3680.4 3714.6 3755.1 3760.7 1083.9 1086.2 1090.2 1108.3 1110.5 11884.4 11926.3 12004.3 12020.6 12047.5 4473.5 4529.7 4697.8 4704.9 4706.9 9192.2 9202.3 9209.1 9211.8 9217.8 5291.4 5293.8 5296.5 5299.3 5304.9 4204.7 4434.6 4591.2 4591.7 4962.2 3124.7 3813.5 3895.5 3898.5 3910.7 1147.5 1167.4 1172.4 1180.0 1180.8 767.1 863.6 892.3 908.9 911.8 5605.7 5728.5 5774.5 5985.1 6068.8 864.3 938.5 948.0 964.4 983.4 3704.6 3842.5 3854.0 3854.3 3975.1 10699.5 10905.3 11020.9 11036.2 11072.4 10989.5 10990.9 10991.3 10991.5 11043.9 7869.2 8167.2 8176.9 8368.3 8444.6 5178.1 5673.3 5710.2 5889.9 5957.3 9778.3 9893.3 10073.5 10176.6 10231.2 8127.6 10129.1 10240.6 10356.3 10370.7 7525.4 7703.8 7711.5 7713.2 7722.2 8124.0 8326.5 8402.3 8404.2 8415.1 7546.8 7550.9 7571.5 7616.3 7685.7 7326.4 7409.8 7436.0 7476.8 7477.0 6927.1 7012.3 7080.6 7100.5 7114.0 4872.6 4880.4 4920.3 4962.3 4966.4 4833.3 4895.9 4990.5 5040.2 5046.3 04:24:18 INFO - PROCESS | 1661 | 04:24:18 INFO - PROCESS | 1661 | [#4] prototype.html Cycles:180 Average:4240.60 Median:4638.72 stddev:1332.02 (28.7%) stddev-sans-first:1302.04 04:24:18 INFO - PROCESS | 1661 | Values: 272.4 291.1 292.2 300.8 303.9 4040.7 4190.8 5090.7 5327.6 5385.9 4908.9 5274.8 5305.9 5319.4 5367.9 3511.9 3722.5 3976.2 3984.5 4035.0 3747.8 3887.3 3903.6 4034.4 4041.6 3282.8 3618.5 3979.8 3982.9 4006.9 4003.7 4014.5 4017.8 4020.4 4024.5 2781.0 2841.7 3344.4 3399.3 3460.4 4452.1 5067.7 5097.2 5133.3 5149.3 4520.5 4524.3 4532.3 4533.7 4561.6 4541.9 5220.9 5540.9 5562.4 5568.9 3259.8 3700.9 3741.1 3751.5 3763.6 5762.5 5821.1 5828.1 5836.9 5897.2 3046.2 3672.8 3843.5 3845.3 3858.5 3042.8 3191.7 3471.0 3834.8 3835.0 3504.4 3679.2 3781.4 4274.8 4409.7 4688.9 5515.9 5534.5 5555.6 5556.7 1308.7 1331.9 1333.0 1334.0 1341.7 734.7 835.9 862.2 876.5 886.4 4404.2 5195.6 5210.8 5212.7 5219.6 4980.9 5399.6 5640.3 5667.8 5735.0 4902.9 4982.3 5259.4 5266.0 5266.5 2353.4 2513.4 2529.5 2531.2 2540.4 3910.7 3997.6 4341.8 4603.0 4987.9 4301.0 4485.2 4727.4 4849.6 4868.4 4334.8 4358.6 4377.5 4592.9 4995.4 3816.7 4674.4 4769.5 4789.6 4861.6 4250.7 4718.5 4725.6 4728.5 4753.5 3947.7 4449.9 4769.0 4878.9 4934.4 2751.5 2963.9 3310.3 3321.1 3359.4 4437.2 4779.7 4783.6 5371.8 5625.5 5184.7 5416.8 5492.6 5609.7 5668.6 5487.0 5526.4 5549.9 5552.5 5579.4 5252.6 5429.5 5479.6 5513.7 5549.6 5182.0 5236.9 5330.8 5500.6 5595.4 4474.6 5290.6 5446.4 5480.3 5507.8 04:24:18 INFO - PROCESS | 1661 | 04:24:18 INFO - PROCESS | 1661 | [#5] yui.html Cycles:180 Average:27770.91 Median:22692.16 stddev:46703.13 (205.8%) stddev-sans-first:46790.08 04:24:18 INFO - PROCESS | 1661 | Values: 750.1 771.2 777.8 798.4 805.8 13965.0 14303.9 14798.2 14831.9 16419.3 14227.8 14426.6 14493.9 14509.3 14519.5 828.6 856.7 857.6 858.5 859.7 554.7 684.0 684.6 835.1 855.7 909.0 914.4 914.8 917.0 917.1 906.6 907.4 907.5 908.3 908.9 512.1 529.4 643.0 662.7 665.7 15463.2 15483.2 15496.1 15527.8 15533.5 14042.4 14333.6 14397.9 14544.5 14658.9 12144.3 12416.4 12474.4 13127.5 13197.6 4613.9 4616.0 4717.6 4721.8 4799.1 120781.8 121302.0 124240.0 127144.0 128909.4 10947.7 11222.8 11372.5 11390.5 11472.7 18871.9 22679.5 22704.8 22839.9 22852.7 7803.1 7858.6 8157.6 8204.9 8264.1 4203.5 4414.9 4435.5 4577.3 4594.3 3245.4 3478.9 3688.7 3966.4 4165.2 743.3 755.8 763.5 767.4 768.2 633.6 653.5 660.6 664.5 682.1 8947.7 9585.9 9732.4 9760.9 9979.0 651.4 659.1 663.7 667.6 685.4 4485.2 4788.8 4804.9 4861.9 4866.9 168385.0 176254.0 177526.0 178052.0 180783.1 144949.8 147712.0 151870.0 152609.0 154647.0 127054.0 127228.7 128070.4 131321.3 132736.7 8998.2 8999.9 9191.9 9236.3 9258.0 61053.0 70549.0 70639.9 70854.6 72907.3 103803.0 106263.0 109339.9 110663.0 120373.0 11656.2 11871.3 12055.6 12079.2 12407.0 12870.4 13049.8 13334.5 13755.5 13816.5 12210.9 12430.9 12823.9 12875.1 12929.6 12125.8 12455.1 12478.4 12533.9 12543.1 12092.5 12101.3 12119.7 12269.4 12740.9 10164.3 10351.1 10470.5 10932.6 10944.7 9973.3 10102.1 10599.8 10715.8 10821.7 04:24:18 INFO - PROCESS | 1661 | -------- Summary: end -------- 04:24:18 INFO - PROCESS | 1661 | 04:24:19 INFO - TEST-INFO | 1661: exit 0 04:24:19 INFO - TEST-OK | dromaeo_css | took 1117841ms 04:24:19 INFO - TEST-START | kraken 04:24:19 INFO - operating with platform_type : mac_ 04:24:19 INFO - Initialising browser for kraken test... 04:24:19 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/tmpR9Suux/profile http://localhost:49266/getInfo.html) 04:24:21 INFO - PROCESS | 1671 | __metrics Screen width/height:1600/1200 04:24:21 INFO - PROCESS | 1671 | colorDepth:24 04:24:21 INFO - PROCESS | 1671 | Browser inner width/height: 1024/689 04:24:21 INFO - PROCESS | 1671 | __metrics 04:24:21 INFO - PROCESS | 1671 | 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" 04:24:21 INFO - PROCESS | 1671 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:24:22 INFO - TEST-INFO | 1671: exit 0 04:24:22 INFO - Browser initialized. 04:24:22 INFO - Running cycle 1/1 for kraken test... 04:24:22 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/tmpR9Suux/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:24:34 INFO - PROCESS | 1672 | RSS: Main: 220209152 04:24:34 INFO - PROCESS | 1672 | 04:24:37 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection) 04:24:38 INFO - PROCESS | 1672 | RSS: Main: 270397440 04:24:38 INFO - PROCESS | 1672 | 04:24:40 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-dft) 04:24:41 INFO - PROCESS | 1672 | RSS: Main: 281047040 04:24:41 INFO - PROCESS | 1672 | 04:24:44 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-fft) 04:24:45 INFO - PROCESS | 1672 | RSS: Main: 377860096 04:24:45 INFO - PROCESS | 1672 | 04:24:47 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator) 04:24:47 INFO - PROCESS | 1672 | RSS: Main: 281006080 04:24:47 INFO - PROCESS | 1672 | 04:24:49 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:24:50 INFO - PROCESS | 1672 | RSS: Main: 282173440 04:24:50 INFO - PROCESS | 1672 | 04:24:53 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom) 04:24:53 INFO - PROCESS | 1672 | RSS: Main: 319610880 04:24:53 INFO - PROCESS | 1672 | 04:24:56 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate) 04:24:57 INFO - PROCESS | 1672 | RSS: Main: 318304256 04:24:57 INFO - PROCESS | 1672 | 04:24:59 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial) 04:25:00 INFO - PROCESS | 1672 | RSS: Main: 315060224 04:25:00 INFO - PROCESS | 1672 | 04:25:02 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:25:02 INFO - PROCESS | 1672 | RSS: Main: 291934208 04:25:02 INFO - PROCESS | 1672 | 04:25:04 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:25:05 INFO - PROCESS | 1672 | RSS: Main: 294875136 04:25:05 INFO - PROCESS | 1672 | 04:25:07 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:25:08 INFO - PROCESS | 1672 | RSS: Main: 297639936 04:25:08 INFO - PROCESS | 1672 | 04:25:10 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:25:11 INFO - PROCESS | 1672 | RSS: Main: 311316480 04:25:11 INFO - PROCESS | 1672 | 04:25:14 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:25:15 INFO - PROCESS | 1672 | RSS: Main: 305209344 04:25:15 INFO - PROCESS | 1672 | 04:25:17 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49266/tests/kraken/driver.html?testName=ai-astar) 04:25:17 INFO - PROCESS | 1672 | RSS: Main: 349069312 04:25:17 INFO - PROCESS | 1672 | 04:25:17 INFO - PROCESS | 1672 | __start_tp_report 04:25:17 INFO - PROCESS | 1672 | _x_x_mozilla_page_load 04:25:17 INFO - PROCESS | 1672 | _x_x_mozilla_page_load_details 04:25:17 INFO - PROCESS | 1672 | |i|pagename|runs| 04:25:17 INFO - PROCESS | 1672 | |0;ai-astar;114;112;113;118;166;162;112;112;112;110 04:25:17 INFO - PROCESS | 1672 | |1;audio-beat-detection;147;116;113;142;110;107;110;107;138;107 04:25:17 INFO - PROCESS | 1672 | |2;audio-dft;184;179;184;183;181;182;183;182;183;182 04:25:17 INFO - PROCESS | 1672 | |3;audio-fft;81;60;72;113;86;62;57;58;82;58 04:25:17 INFO - PROCESS | 1672 | |4;audio-oscillator;87;70;95;69;68;69;93;92;101;124 04:25:17 INFO - PROCESS | 1672 | |5;imaging-gaussian-blur;88;85;88;84;89;81;88;85;87;84 04:25:17 INFO - PROCESS | 1672 | |6;imaging-darkroom;94;102;93;96;93;93;92;96;93;93 04:25:17 INFO - PROCESS | 1672 | |7;imaging-desaturate;93;134;86;85;85;83;85;85;86;89 04:25:17 INFO - PROCESS | 1672 | |8;json-parse-financial;58;52;54;54;57;56;57;57;57;57 04:25:17 INFO - PROCESS | 1672 | |9;json-stringify-tinderbox;64;74;75;73;76;70;70;70;70;72 04:25:17 INFO - PROCESS | 1672 | |10;stanford-crypto-aes;80;83;82;94;94;100;101;78;83;93 04:25:17 INFO - PROCESS | 1672 | |11;stanford-crypto-ccm;115;149;146;148;154;135;142;158;193;139 04:25:17 INFO - PROCESS | 1672 | |12;stanford-crypto-pbkdf2;163;165;161;165;163;165;162;167;224;195 04:25:17 INFO - PROCESS | 1672 | |13;stanford-crypto-sha256-iterative;68;69;83;89;88;89;77;66;67;65 04:25:17 INFO - PROCESS | 1672 | __end_tp_report 04:25:17 INFO - PROCESS | 1672 | __start_cc_report 04:25:17 INFO - PROCESS | 1672 | _x_x_mozilla_cycle_collect,1961 04:25:17 INFO - PROCESS | 1672 | __end_cc_report 04:25:17 INFO - PROCESS | 1672 | __startTimestamp1478172317381__endTimestamp 04:25:17 INFO - PROCESS | 1672 | 04:25:17 INFO - PROCESS | 1672 | ------- Summary: start ------- 04:25:17 INFO - PROCESS | 1672 | Number of tests: 14 04:25:17 INFO - PROCESS | 1672 | 04:25:17 INFO - PROCESS | 1672 | [#0] ai-astar Cycles:10 Average:123.10 Median:113.50 stddev:21.68 (19.1%) stddev-sans-first:22.74 04:25:17 INFO - PROCESS | 1672 | Values: 114.0 112.0 113.0 118.0 166.0 162.0 112.0 112.0 112.0 110.0 04:25:17 INFO - PROCESS | 1672 | 04:25:17 INFO - PROCESS | 1672 | [#1] audio-beat-detection Cycles:10 Average:119.70 Median:114.50 stddev:16.01 (14.0%) stddev-sans-first:13.60 04:25:17 INFO - PROCESS | 1672 | Values: 147.0 116.0 113.0 142.0 110.0 107.0 110.0 107.0 138.0 107.0 04:25:17 INFO - PROCESS | 1672 | 04:25:17 INFO - PROCESS | 1672 | [#2] audio-dft Cycles:10 Average:182.30 Median:183.00 stddev:1.49 (0.8%) stddev-sans-first:1.45 04:25:17 INFO - PROCESS | 1672 | Values: 184.0 179.0 184.0 183.0 181.0 182.0 183.0 182.0 183.0 182.0 04:25:17 INFO - PROCESS | 1672 | 04:25:17 INFO - PROCESS | 1672 | [#3] audio-fft Cycles:10 Average:72.90 Median:67.00 stddev:17.98 (26.8%) stddev-sans-first:18.83 04:25:17 INFO - PROCESS | 1672 | Values: 81.0 60.0 72.0 113.0 86.0 62.0 57.0 58.0 82.0 58.0 04:25:17 INFO - PROCESS | 1672 | 04:25:17 INFO - PROCESS | 1672 | [#4] audio-oscillator Cycles:10 Average:86.80 Median:78.50 stddev:18.22 (23.2%) stddev-sans-first:19.32 04:25:17 INFO - PROCESS | 1672 | Values: 87.0 70.0 95.0 69.0 68.0 69.0 93.0 92.0 101.0 124.0 04:25:17 INFO - PROCESS | 1672 | 04:25:17 INFO - PROCESS | 1672 | [#5] imaging-gaussian-blur Cycles:10 Average:85.90 Median:87.50 stddev:2.51 (2.9%) stddev-sans-first:2.55 04:25:17 INFO - PROCESS | 1672 | Values: 88.0 85.0 88.0 84.0 89.0 81.0 88.0 85.0 87.0 84.0 04:25:17 INFO - PROCESS | 1672 | 04:25:17 INFO - PROCESS | 1672 | [#6] imaging-darkroom Cycles:10 Average:94.50 Median:93.00 stddev:2.95 (3.2%) stddev-sans-first:3.13 04:25:17 INFO - PROCESS | 1672 | Values: 94.0 102.0 93.0 96.0 93.0 93.0 92.0 96.0 93.0 93.0 04:25:17 INFO - PROCESS | 1672 | 04:25:17 INFO - PROCESS | 1672 | [#7] imaging-desaturate Cycles:10 Average:91.10 Median:85.50 stddev:15.33 (17.9%) stddev-sans-first:16.24 04:25:17 INFO - PROCESS | 1672 | Values: 93.0 134.0 86.0 85.0 85.0 83.0 85.0 85.0 86.0 89.0 04:25:17 INFO - PROCESS | 1672 | 04:25:17 INFO - PROCESS | 1672 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:57.00 stddev:1.91 (3.4%) stddev-sans-first:1.87 04:25:17 INFO - PROCESS | 1672 | Values: 58.0 52.0 54.0 54.0 57.0 56.0 57.0 57.0 57.0 57.0 04:25:17 INFO - PROCESS | 1672 | 04:25:17 INFO - PROCESS | 1672 | [#9] json-stringify-tinderbox Cycles:10 Average:71.40 Median:72.50 stddev:3.44 (4.7%) stddev-sans-first:2.39 04:25:17 INFO - PROCESS | 1672 | Values: 64.0 74.0 75.0 73.0 76.0 70.0 70.0 70.0 70.0 72.0 04:25:17 INFO - PROCESS | 1672 | 04:25:17 INFO - PROCESS | 1672 | [#10] stanford-crypto-aes Cycles:10 Average:88.80 Median:83.00 stddev:8.52 (10.3%) stddev-sans-first:8.42 04:25:17 INFO - PROCESS | 1672 | Values: 80.0 83.0 82.0 94.0 94.0 100.0 101.0 78.0 83.0 93.0 04:25:17 INFO - PROCESS | 1672 | 04:25:17 INFO - PROCESS | 1672 | [#11] stanford-crypto-ccm Cycles:10 Average:147.90 Median:148.50 stddev:19.84 (13.4%) stddev-sans-first:17.10 04:25:17 INFO - PROCESS | 1672 | Values: 115.0 149.0 146.0 148.0 154.0 135.0 142.0 158.0 193.0 139.0 04:25:17 INFO - PROCESS | 1672 | 04:25:17 INFO - PROCESS | 1672 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.00 Median:165.00 stddev:20.49 (12.4%) stddev-sans-first:21.41 04:25:17 INFO - PROCESS | 1672 | Values: 163.0 165.0 161.0 165.0 163.0 165.0 162.0 167.0 224.0 195.0 04:25:17 INFO - PROCESS | 1672 | 04:25:17 INFO - PROCESS | 1672 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.10 Median:80.00 stddev:10.26 (12.8%) stddev-sans-first:10.45 04:25:17 INFO - PROCESS | 1672 | Values: 68.0 69.0 83.0 89.0 88.0 89.0 77.0 66.0 67.0 65.0 04:25:17 INFO - PROCESS | 1672 | -------- Summary: end -------- 04:25:17 INFO - PROCESS | 1672 | 04:25:18 INFO - TEST-INFO | 1672: exit 0 04:25:18 INFO - TEST-OK | kraken | took 59069ms 04:25:18 INFO - SUITE-END | took 1176s 04:25:18 INFO - Completed test suite (00:19:37) 04:25:18 INFO - javascript benchmark 04:25:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3270.2151483643925, 3292.8024318540884, 3326.4012477754027, 3333.383324085043, 3386.339663765565, 5630.77476900924, 5680.602357834943, 5737.282839645044, 5764.135379693048, 5781.7109144542765, 5647.040003199456, 5703.144528320754, 5723.828285151441, 5742.167385729067, 5742.885142297151, 5191.480851914816, 5203.86990325243, 5226.738663066841, 5239.816606418776, 5262.000219958196, 5187.144121219994, 5188.429272779991, 5203.089459344599, 5304.549113325353, 5333.519983201511, 5190.273361729361, 5223.973880130594, 5238.13570760824, 5241.3186285782795, 5253.737313134328, 5237.554807841319, 5274.05067087924, 5299.046171689094, 5301.231321458367, 5346.304980352568, 5042.495750424965, 5154.690718556899, 5223.268742376071, 5237.214417837316, 5251.894962100737, 5610.579206559483, 5631.6902570359025, 5632.633878797865, 5676.886462270772, 5714.71426428681, 6191.9690401547705, 6211.937880621181, 6255.718492667841, 6279.466245369149, 6291.559590828644, 6142.6522545212965, 6251.593646412968, 6254.186955695776, 6301.810945671591, 6331.430171284561, 4820.3492528508905, 5689.203511508392, 5741.942580574141, 5778.797742079007, 5781.219535362757, 6242.781502647385, 6303.3066362700065, 6304.05439184126, 6321.209848768904, 6333.746650133943, 6045.6070355426755, 6169.475594574422, 6178.567500275028, 6180.567360284737, 6190.823743488722, 5526.171074338801, 5914.940850591525, 6169.660668663177, 6171.074338849208, 6232.968835155795, 5534.280543529316, 6165.075238714228, 6238.220222472191, 6246.937530624727, 6248.375162483715, 6216.191895053614, 6267.2792628847355, 6275.1842260506755, 6282.18331616896, 6284.12022316876, 4850.854474365704, 4904.215325547895, 4915.8033678652455, 4917.409910810654, 4969.105560998983, 3783.981080094582, 4424.60178583929, 4454.175977444183, 4470.083632855322, 4480.036792089716, 5778.797742079091, 5781.739821708034, 5783.624064435882, 5785.0, 5787.363390027093, 5190.532852043334, 6211.9689401553605, 6296.65368404733, 6302.275238347557, 6333.923233050393, 5808.82573522795, 5814.215080964016, 5816.1566572846705, 5822.679752613562, 5863.413658634103, 5430.022595932691, 5458.781648734006, 5463.207834864002, 5472.863178420572, 5473.589480788957, 6009.06859436788, 6227.532935029891, 6259.06114082873, 6276.623402595859, 6285.528585356208, 6319.431251187415, 6335.556511044183, 6338.968305158444, 6348.93651063502, 6355.14205582259, 6314.431701146918, 6327.335629758809, 6344.619322840645, 6356.809295721136, 6362.840928976812, 6065.939340606537, 6109.9816581254145, 6119.020956646915, 6131.662758548323, 6213.285472170758, 6101.298350689727, 6193.102000210034, 6252.499800015897, 6323.588966717149, 6334.461570766536, 6127.938720612737, 6143.293521245114, 6145.938540614537, 6148.846278843064, 6164.845878853064, 5415.2147938547905, 5923.052311630118, 6082.118092876596, 6102.176206212104, 6138.048602466625, 5837.854053648693, 5916.970415147896, 5939.316978547349, 5971.044632858721, 5991.281046274475, 6145.187169785014, 6156.507479401726, 6168.414000669929, 6184.010558310649, 6190.7523699051535, 5953.583249172516, 5972.34304226526, 6015.030090120541, 6060.757569697163, 6095.329513753572], "value": 5693.160790613453, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [472.93353487884826, 499.7576175554855, 514.8532668189566, 527.1802347349874, 527.6095689189998, 29366.41267174655, 29835.0, 29848.701512984862, 31137.37725245494, 32175.51736723948, 32181.839090804515, 35143.82428087856, 42285.15429691404, 42451.78774106125, 44380.668579942656, 9614.663486777947, 9768.072033156874, 9794.559244833965, 9817.90182098177, 9827.115559599635, 9694.17599504043, 9796.6081356746, 9800.509974501281, 9805.65680201193, 9816.214702823758, 8624.65501379944, 8835.514046727427, 11749.41252937354, 11997.580084697038, 12012.099092568049, 11837.348945807977, 11983.760324793499, 12065.155439119266, 12066.939665301705, 12072.456739446747, 11786.233894796811, 11855.170138090338, 11855.347955862424, 11856.881431185664, 11867.643970680894, 30784.0, 31279.0, 39108.60891391078, 39337.803310983545, 39465.60534394648, 3402.9659703402895, 3470.583529976419, 3627.4014787560022, 3691.1141326081547, 3984.1035766952496, 30766.07701768928, 31934.840325798454, 32873.0, 33617.663823361945, 33986.83006584976, 3147.5436061771143, 3279.737620990315, 3302.653221411765, 3381.932361352759, 3419.606745224306, 508325.0, 509635.0, 517221.0, 517280.41359793337, 517465.0, 54728.63178420492, 67234.65530689359, 68633.65683171552, 68705.65647171732, 68819.0, 55674.443255567734, 59335.0, 59337.109943350886, 59374.40625593775, 67397.66301168462, 15549.067055976677, 16331.91834040846, 16359.427420040241, 16366.0, 16393.59016024609, 12313.953313968233, 12334.629961101182, 12338.3830808461, 12354.196977196454, 12394.946429553589, 14813.777793333109, 20009.0, 20263.8854862981, 20332.59334813325, 20361.185552578027, 7229.132504099542, 7286.744963926237, 7603.870916143489, 8472.49165050099, 8734.650613975497, 881.299367003234, 899.8560230363111, 964.2430691906819, 1023.7235946294608, 1070.7269646240159, 28975.56536651952, 29625.0, 29966.0, 29983.25041873927, 30768.384632307676, 1010.8534262531891, 1066.7599790047332, 1072.785442911421, 1073.1897417449775, 1098.3849044535086, 15120.924395378173, 15561.455349062728, 15580.922095389451, 15650.0, 15870.047797132209, 710997.0, 715573.0, 718945.0, 719425.0, 719952.0, 49349.50650493521, 49798.0, 49882.50117498779, 56277.7186114075, 57161.42838571644, 1359.34071975092, 1372.9656758581116, 1404.0, 1407.9155250684992, 1408.78163884596, 26828.597571036058, 29872.040661643616, 30860.0, 31090.68909310878, 31233.519776269022, 49334.01331973269, 49883.75058124686, 49928.75035624798, 49951.0, 50021.0, 676066.0, 698793.0, 700144.0, 912176.0, 915101.0, 26740.064097757262, 42241.36637950494, 42340.36489452599, 42653.57346426496, 42971.35542966796, 45375.773121135506, 47490.0, 47586.76206618945, 47682.523174769194, 48592.028159435904, 38444.61555384522, 38937.805310973265, 39181.60818391779, 39796.21643834301, 40705.0, 31951.840240798647, 38345.0, 38700.41949370818, 40313.79843100883, 40382.9904252396, 37664.81167594145, 38242.808785955895, 38450.230995380494, 38519.42220866633, 38690.4196437048, 30041.347725875286, 32233.0, 34655.48016779801, 34813.65186348104, 34851.4772278411, 25411.36471588225, 25661.74338256668, 25763.355916102246, 26164.869175654, 26284.94860205647], "value": 20617.795711233823, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.7806559932842, 361.1332801276935, 375.93797023491106, 384.18744355687727, 406.666533442577, 15383.077015379085, 15492.380304787808, 17320.913395433006, 21120.683189752166, 21538.89230553849, 20673.0, 20902.477438064056, 21355.466113347175, 21360.893195534038, 21535.030923608436, 5180.0, 5527.50252477277, 5997.7600895964215, 6264.780732674334, 6278.529110316722, 4233.19569281837, 6154.0, 6257.468115210213, 6261.0, 6267.686615669221, 4451.532589078149, 6625.304343043959, 6925.238223795379, 6954.756583519578, 7065.470089743264, 5750.769969201227, 6123.357047509992, 6167.105769663373, 7032.613206273653, 7034.6834392452465, 5995.460408563206, 6004.489618382443, 6005.669688167149, 6006.879862402728, 6013.7293821777685, 23151.76848231513, 25273.494530109478, 25698.229053128434, 25742.613860792102, 25769.711514424205, 2204.360735386736, 2208.3043841189974, 2305.1816605105114, 2351.247600767755, 2602.3624212068166, 9355.532223388871, 9827.656032038843, 10153.746156346151, 10209.438480883548, 10278.0, 1773.6807374672553, 1820.6486497271533, 1862.9347972820885, 1878.1454438230571, 1888.3107665702057, 96685.0, 100397.0, 121788.0, 122672.0, 126652.36673816665, 9091.590878410487, 11412.600558980395, 11470.311781293149, 11589.6523104307, 11688.70778230534, 14358.138511689333, 14380.0, 14387.0, 14387.92806035963, 14445.133292002514, 8421.747347579583, 8647.264982476434, 8667.393282470293, 8782.077881822317, 8786.297096232285, 8663.220310172115, 8685.261752751087, 8688.739337819876, 8879.644814207359, 8883.466991980502, 4416.315471101984, 4506.121306345297, 4530.88672783183, 4547.636189104864, 4598.701084429568, 1579.8499142581436, 1847.9630407391776, 1897.354899334233, 1906.218450435315, 1910.1404368034162, 780.5823884221915, 840.9159084091664, 885.287343688337, 988.5897352598735, 997.9700608981597, 20342.288019919528, 21933.122675092818, 21985.340439786833, 22052.007659655355, 22071.00680469383, 901.2744740483843, 941.8775559177263, 943.6555657185215, 962.1244667352676, 987.0573602209872, 8780.429272097294, 9850.753731156636, 11284.492197851116, 12192.512299508098, 12248.571300004634, 620516.0, 626160.7383926193, 633714.0, 637217.0, 644701.0, 126105.73894261123, 138602.3069884644, 139689.0, 140956.0, 144853.0, 1015.0712098430001, 1019.6227395863579, 1022.2486472442748, 1065.5151905882806, 1069.8769641491172, 18655.72016419782, 19478.026098694725, 20041.49896252547, 20069.49826254297, 20093.296734614218, 55637.0, 56449.71775141098, 56889.43110568841, 57615.0, 57991.71004144952, 61598.0, 81182.0, 82274.58862705648, 82773.0, 85066.0, 8019.358451323997, 8152.633131508977, 8190.099089100075, 8501.574921254036, 8544.658213671384, 12543.87456125427, 12998.740025199631, 13113.344332783132, 13208.33958302062, 13346.532871349456, 10934.835977460185, 11157.330560166416, 11246.381449020055, 11314.03830674402, 11525.942370288094, 10620.628278010232, 11033.0, 11086.057685096535, 11153.386563739072, 11285.322880627189, 9792.510374481106, 10888.455577221266, 11399.259048161843, 11525.308481491138, 11793.587224447103, 7927.762167134995, 7996.840063198587, 8111.716089936824, 8299.792505187419, 8462.492250464991, 8339.791505212419, 10357.378557286587, 11219.158563107963, 11267.323960562393, 11554.76890462203], "value": 9676.804945097214, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1363.4273605085864, 1526.5267766992233, 1552.0532475190137, 1755.8595312375012, 1901.3060233014953, 7900.209979002104, 8417.537035463054, 8662.307015438766, 8952.865707014384, 8960.686375976842, 8813.206811386974, 8923.15230053144, 8925.0, 8926.642934282638, 8929.330300227477, 2399.256230568525, 2431.222008957134, 2434.7808697217247, 2436.683231179944, 2439.146298795425, 2398.556267090585, 2416.685830841997, 2433.841800282985, 2439.9752104116224, 2443.657887895696, 2392.8803559822027, 2393.1623931623967, 2413.4569721812627, 2424.8423852449623, 2427.5387676341525, 2108.9156433742633, 2244.9663255051187, 2389.95220095598, 2401.8438801477846, 2402.1352313167245, 2355.823313251513, 2379.0364902214633, 2379.298107058422, 2381.5475059738596, 2382.392489915078, 8735.43219690718, 8953.328500362433, 8953.865692014626, 8957.328200384933, 8959.776005599848, 5235.476452354772, 5425.0, 5427.62006659534, 5473.616846820724, 5495.642783219078, 3656.451532270154, 3680.411134218539, 3714.647108524713, 3755.0800053986677, 3760.6615404613717, 1083.9024487796137, 1086.2124959404448, 1090.2368342160519, 1108.3073079325422, 1110.5002748763088, 11884.40577971098, 11926.344051077187, 12004.279743215435, 12020.63938081859, 12047.518099276018, 4473.507914129443, 4529.68292219548, 4697.81208751653, 4704.88237794051, 4706.882327941828, 9192.21866141372, 9202.30982676302, 9209.125133112344, 9211.769705757275, 9217.815643687089, 5291.365036195604, 5293.788248470018, 5296.523312901857, 5299.258103865462, 5304.92042619361, 4204.684648651363, 4434.645228381786, 4591.242444996605, 4591.724496530219, 4962.206047032458, 3124.7343975762315, 3813.504244448204, 3895.454636350913, 3898.532176138825, 3910.7066969977363, 1147.5065721739566, 1167.3871217610822, 1172.384498138484, 1179.9823002654966, 1180.7992641250837, 767.0909971683461, 863.589794847455, 892.2772554231094, 908.9136532029447, 911.813078318943, 5605.691686957175, 5728.51307638847, 5774.480296773227, 5985.132155837379, 6068.787592434243, 864.3085531574715, 938.4932136646271, 948.0, 964.4165280005636, 983.3509883476871, 3704.5554533456157, 3842.4620553122586, 3853.96146038536, 3854.325493038763, 3975.105601239698, 10699.518521666543, 10905.291156074829, 11020.906027854682, 11036.227464077598, 11072.3910184939, 10989.450527473595, 10990.890091098987, 10991.285566438157, 10991.505382257817, 11043.944780276208, 7869.213078692085, 8167.183281671904, 8176.918230817616, 8368.3305335573, 8444.57777111142, 5178.119719647593, 5673.319201695823, 5710.17202505626, 5889.882202356014, 5957.314908785545, 9778.315517913677, 9893.307468477138, 10073.496325183858, 10176.643817466353, 10231.181505479693, 8127.593620318842, 10129.139023183112, 10240.64157754475, 10356.326838755456, 10370.688879333633, 7525.435592330707, 7703.768886933401, 7711.537307761328, 7713.151553329241, 7722.189170137055, 8124.0, 8326.50040997542, 8402.285805706584, 8404.20160084791, 8415.11641277657, 7546.773596792105, 7550.924490755022, 7571.507851989603, 7616.276453736886, 7685.730999414994, 7326.4138868889295, 7409.814754630962, 7436.0, 7476.775696729107, 7476.9532265481785, 6927.134108236471, 7012.298770122947, 7080.610566418896, 7100.467464940253, 7114.0, 4872.610191184767, 4880.438749543848, 4920.311156438173, 4962.280469331999, 4966.428860680923, 4833.347498087714, 4895.877603059809, 4990.476000019946, 5040.243963405518, 5046.268291097844], "value": 4584.690574816022, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [272.4414949353824, 291.1034015233084, 292.1993737160181, 300.7969620506158, 303.8936372269706, 4040.6767458603313, 4190.811413486393, 5090.650977490968, 5327.573794096473, 5385.919211211825, 4908.901821963558, 5274.841754747364, 5305.920411193835, 5319.361676598804, 5367.892642147155, 3511.894643160709, 3722.4602432647384, 3976.1848820991627, 3984.4820173377566, 4035.0, 3747.7563958342757, 3887.3391523441082, 3903.609639036102, 4034.3746719258415, 4041.575634558373, 3282.770206085575, 3618.5476815398074, 3979.8408063677416, 3982.900427489307, 4006.8998275043064, 4003.679705623543, 4014.498187726534, 4017.7589344639414, 4020.3567429211184, 4024.476818013669, 2780.957141072098, 2841.659000919882, 3344.4481660525985, 3399.3031428557088, 3460.377132116218, 4452.0873220989615, 5067.721275329855, 5097.1844504879045, 5133.281340612317, 5149.3305870237, 4520.547945205486, 4524.343970124346, 4532.342810292489, 4533.659975501818, 4561.612262957653, 4541.886452838672, 5220.921686174673, 5540.86147846303, 5562.3881373048935, 5568.9443105569235, 3259.755518336134, 3700.888973330804, 3741.139537906297, 3751.4935483709623, 3763.6236376362417, 5762.481376676077, 5821.068629019379, 5828.125781132864, 5836.88326233473, 5897.233359663216, 3046.2484071658887, 3672.761270517408, 3843.5387753469763, 3845.2693988142164, 3858.5176852893387, 3042.8478576071107, 3191.744660427207, 3470.9652903471147, 3834.846606135779, 3835.0, 3504.3867323218333, 3679.172186258124, 3781.4138808484727, 4274.764887931132, 4409.735415874994, 4688.866565712593, 5515.876387590806, 5534.537130976757, 5555.583331250173, 5556.749946252428, 1308.7447947650307, 1331.9200847949155, 1332.9866701333056, 1333.986170510419, 1341.6914109754812, 734.736253643732, 835.8507052802397, 862.1507814802414, 876.54419701756, 886.4371124335964, 4404.238304678091, 5195.636305458657, 5210.7915683373, 5212.7489402543115, 5219.556337711337, 4980.879302156985, 5399.568034557226, 5640.294963129609, 5667.773289068474, 5735.0, 4902.921357301388, 4982.277569752366, 5259.36887573486, 5265.973670131625, 5266.499682530153, 2353.411447273118, 2513.4219129600297, 2529.5446819572653, 2531.152064058561, 2540.4411029573466, 3910.6675932546054, 3997.6402123809, 4341.761203133795, 4603.01607909716, 4987.900241995139, 4301.0, 4485.205917632973, 4727.432708075053, 4849.612031037508, 4868.440129385095, 4334.783260836945, 4358.58593433617, 4377.474703035656, 4592.897704550951, 4995.375578052744, 3816.7137464689704, 4674.415698037746, 4769.546893045155, 4789.592884604708, 4861.562459378673, 4250.723702959298, 4718.504557021463, 4725.5663333382645, 4728.45622753374, 4753.453352864465, 3947.703922205789, 4449.911001780011, 4769.0, 4878.878028049327, 4934.3716573531365, 2751.5047291487726, 2963.851807409664, 3310.2551925816497, 3321.086701157201, 3359.3874940029414, 4437.223485890021, 4779.713217206979, 4783.593394561502, 5371.811986580451, 5625.493705566519, 5184.662996905189, 5416.783328666967, 5492.642978206404, 5609.74756135983, 5668.631538949955, 5487.0, 5526.364468086222, 5549.890021995537, 5552.5008247773685, 5579.409868187547, 5252.606054546, 5429.484199001088, 5479.561635069264, 5513.696746678811, 5549.639273447213, 5181.974090129525, 5236.947630523799, 5330.786768529216, 5500.5874559409, 5595.356533998643, 4474.552544745499, 5290.550303224269, 5446.400895901527, 5480.314960629921, 5507.834764957058], "value": 3824.6435255370525, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [750.1036261667309, 771.2018061306547, 777.8211011467358, 798.3815257080823, 805.8388322335533, 13965.022448428614, 14303.856961430383, 14798.186099764522, 14831.851681483182, 16419.343226270965, 14227.78658320126, 14426.639334016654, 14493.855061449382, 14509.274536273197, 14519.49181778638, 828.6064119543214, 856.7044369692446, 857.5797859049084, 858.4634603372892, 859.716293623106, 554.7365001624237, 683.9897401538981, 684.5995092870652, 835.1106072033265, 855.670566831768, 908.9590968406437, 914.3508109242413, 914.8170365926841, 917.0371110334156, 917.0645941140033, 906.5739102621757, 907.4101833808078, 907.5416914458223, 908.2960705453261, 908.8636704494313, 512.0654804980887, 529.3594750352079, 643.0290261704813, 662.6686656671665, 665.6638397609177, 15463.226838658022, 15483.22583870802, 15496.147711875843, 15527.844721552752, 15533.533993980198, 14042.438302467888, 14333.641658958506, 14397.856021439757, 14544.490942817056, 14658.926705366512, 12144.3320617366, 12416.447944006999, 12474.43865026076, 13127.474901003949, 13197.604071877762, 4613.907721845578, 4616.0, 4717.575418212343, 4721.811127554894, 4799.112164249625, 120781.79218207882, 121302.0, 124240.0, 127144.0, 128909.35545322308, 10947.726306842233, 11222.775544489064, 11372.48823802931, 11390.487428065757, 11472.655820325404, 18871.90564047171, 22679.546409072056, 22704.772952270265, 22839.88580057089, 22852.65721014186, 7803.102643195992, 7858.553950814753, 8157.55133467665, 8204.876926846102, 8264.132266112092, 4203.5376108628025, 4414.889627759268, 4435.534268901783, 4577.267637178035, 4594.264917613166, 3245.367153405063, 3478.9478157827652, 3688.686461650736, 3966.36538153894, 4165.187788381297, 743.2790193512285, 755.8412733325953, 763.5418748750816, 767.397592889579, 768.2164192523595, 633.6324931539788, 653.4608947618234, 660.6300471735843, 664.5149041199951, 682.1405029662661, 8947.686830960885, 9585.856212156823, 9732.367396119229, 9760.902390976, 9979.0, 651.4202359899693, 659.1496968910052, 663.7278715726529, 667.6127845849396, 685.3763075601179, 4485.170243504962, 4788.808447662054, 4804.927926081112, 4861.9191105541795, 4866.926996095061, 168385.0, 176254.0, 177526.0, 178052.0, 180783.09608451874, 144949.8257526138, 147712.0, 151870.0, 152609.0, 154647.0, 127053.99999999815, 127228.7277127217, 128070.35964820116, 131321.3433932824, 132736.67263327242, 8998.235150012322, 8999.865002024844, 9191.862122068309, 9236.26109911192, 9258.0, 61053.0, 70549.0, 70639.940400893, 70854.64572677104, 72907.27092729005, 103803.0, 106263.0, 109339.90660093616, 110663.0, 120373.0, 11656.18406711522, 11871.287722736663, 12055.638330850088, 12079.154459187772, 12407.007439404646, 12870.420831062438, 13049.804252936023, 13334.466621335037, 13755.518556850462, 13816.516421925184, 12210.938945305217, 12430.875691243333, 12823.93588032054, 12875.098743087894, 12929.612111636667, 12125.75748485043, 12455.065870059601, 12478.438470268678, 12533.93733031329, 12543.059270554562, 12092.516299347928, 12101.273923564615, 12119.697007574528, 12269.447874845831, 12740.917022053229, 10164.33931794431, 10351.06840384369, 10470.528826202992, 10932.617358392417, 10944.726381840517, 9973.32565059094, 10102.141317988053, 10599.8197004636, 10715.785684286426, 10821.729456763329], "value": 8018.221448428172, "unit": "score"}], "name": "dromaeo_css", "value": 7365.907611035415, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 112.0, 113.0, 118.0, 166.0, 162.0, 112.0, 112.0, 112.0, 110.0], "value": 123.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 116.0, 113.0, 142.0, 110.0, 107.0, 110.0, 107.0, 138.0, 107.0], "value": 119.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 179.0, 184.0, 183.0, 181.0, 182.0, 183.0, 182.0, 183.0, 182.0], "value": 182.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 60.0, 72.0, 113.0, 86.0, 62.0, 57.0, 58.0, 82.0, 58.0], "value": 72.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 70.0, 95.0, 69.0, 68.0, 69.0, 93.0, 92.0, 101.0, 124.0], "value": 86.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 88.0, 84.0, 89.0, 81.0, 88.0, 85.0, 87.0, 84.0], "value": 85.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 102.0, 93.0, 96.0, 93.0, 93.0, 92.0, 96.0, 93.0, 93.0], "value": 94.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 134.0, 86.0, 85.0, 85.0, 83.0, 85.0, 85.0, 86.0, 89.0], "value": 91.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 52.0, 54.0, 54.0, 57.0, 56.0, 57.0, 57.0, 57.0, 57.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 74.0, 75.0, 73.0, 76.0, 70.0, 70.0, 70.0, 70.0, 72.0], "value": 71.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 83.0, 82.0, 94.0, 94.0, 100.0, 101.0, 78.0, 83.0, 93.0], "value": 88.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 149.0, 146.0, 148.0, 154.0, 135.0, 142.0, 158.0, 193.0, 139.0], "value": 147.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 161.0, 165.0, 163.0, 165.0, 162.0, 167.0, 224.0, 195.0], "value": 173.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 83.0, 89.0, 88.0, 89.0, 77.0, 66.0, 67.0, 65.0], "value": 76.1, "unit": "score"}], "name": "kraken", "value": 1469.3999999999999, "alertThreshold": 2.0}]} 04:25:18 INFO - Return code: 0 04:25:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:25:18 INFO - # TBPL SUCCESS # 04:25:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:25:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:25:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:25:18 INFO - 2016-11-03 04:25:18.712 screenresolution[1676:9872] starting screenresolution argv=screenresolution get 04:25:18 INFO - 2016-11-03 04:25:18.715 screenresolution[1676:9872] Display 0: 1600x1200x32@60 04:25:18 INFO - 2016-11-03 04:25:18.721 screenresolution[1677:9875] starting screenresolution argv=screenresolution list 04:25:18 INFO - Available Modes on Display 0 04:25:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:25:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:25:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:25:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:25:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:25:18 INFO - Intel Iris: 04:25:18 INFO - Chipset Model: Intel Iris 04:25:18 INFO - Type: GPU 04:25:18 INFO - Bus: Built-In 04:25:18 INFO - VRAM (Dynamic, Max): 1536 MB 04:25:18 INFO - Vendor: Intel (0x8086) 04:25:18 INFO - Device ID: 0x0a2e 04:25:18 INFO - Revision ID: 0x0009 04:25:18 INFO - Displays: 04:25:18 INFO - Display: 04:25:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:25:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:25:18 INFO - Display Serial Number: 1600x1200 60 04:25:18 INFO - Main Display: Yes 04:25:18 INFO - Mirror: Off 04:25:18 INFO - Online: Yes 04:25:18 INFO - Rotation: Supported 04:25:18 INFO - Return code: 0 04:25:18 INFO - Running post-action listener: _resource_record_post_action 04:25:18 INFO - [mozharness: 2016-11-03 11:25:18.955239Z] Finished run-tests step (success) 04:25:18 INFO - Running post-run listener: _resource_record_post_run 04:25:19 INFO - Total resource usage - Wall time: 1210s; CPU: 53.0%; Read bytes: 37561344; Write bytes: 663972864; Read time: 243; Write time: 1856 04:25:19 INFO - TinderboxPrint: CPU usage
53.2% 04:25:19 INFO - TinderboxPrint: I/O read bytes / time
37,561,344 / 243 04:25:19 INFO - TinderboxPrint: I/O write bytes / time
663,972,864 / 1,856 04:25:19 INFO - TinderboxPrint: CPU idle
2,264.7 (46.8%) 04:25:19 INFO - TinderboxPrint: CPU system
964.9 (19.9%) 04:25:19 INFO - TinderboxPrint: CPU user
1,612.0 (33.3%) 04:25:19 INFO - TinderboxPrint: Swap in / out
400,678,912 / 0 04:25:19 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 355586560; Write bytes: 357165056; Read time: 27715; Write time: 712 04:25:19 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 36594688; Write bytes: 296649728; Read time: 229; Write time: 1108 04:25:19 INFO - Running post-run listener: _upload_blobber_files 04:25:19 INFO - Blob upload gear active. 04:25:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:25:19 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 04:25:19 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'] 04:25:19 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 04:25:19 INFO - (blobuploader) - INFO - Open directory for files ... 04:25:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:25:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:25:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:25:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:25:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:25:20 INFO - (blobuploader) - INFO - Done attempting. 04:25:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:25:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:25:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:25:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:25:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:25:21 INFO - (blobuploader) - INFO - Done attempting. 04:25:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:25:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:25:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:25:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:25:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:25:24 INFO - (blobuploader) - INFO - Done attempting. 04:25:24 INFO - (blobuploader) - INFO - Iteration through files over. 04:25:24 INFO - Return code: 0 04:25:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:25:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:25:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d7faf1a2181af24eb0506ba5a7df7036140881c3ffe6309ac70b7534cec92fdcd092a71b760bc0d7118dae0a3606d3ac43d753d8b0628cb80f91e3e624ac65fb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/02809e28570e814904b1498f50e40a150458758faf15ad0bf0b73cee6e5e924f79d81ee400278247669cd87f7b5c5022a505a8d3ec90c16443302b25baa77b23", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2a094a651e27d234c6f6eddebada5a3f18f0addce2cfb1f1d77d958efd70586304ae5be4b1209e80fff3a4f7204f865207b1c45260c163ea4c2f1ad7f624276b"} 04:25:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:25:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:25:24 INFO - Contents: 04:25:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d7faf1a2181af24eb0506ba5a7df7036140881c3ffe6309ac70b7534cec92fdcd092a71b760bc0d7118dae0a3606d3ac43d753d8b0628cb80f91e3e624ac65fb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/02809e28570e814904b1498f50e40a150458758faf15ad0bf0b73cee6e5e924f79d81ee400278247669cd87f7b5c5022a505a8d3ec90c16443302b25baa77b23", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2a094a651e27d234c6f6eddebada5a3f18f0addce2cfb1f1d77d958efd70586304ae5be4b1209e80fff3a4f7204f865207b1c45260c163ea4c2f1ad7f624276b"} 04:25:24 INFO - Running post-run listener: copy_logs_to_upload_dir 04:25:24 INFO - Copying logs to upload dir... 04:25:24 INFO - mkdir: /builds/slave/test/build/upload/logs 04:25:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.147462 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-11-03 04:25:24.286477) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-03 04:25:24.290787) ========= 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.ooORzFkFfn/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.UoiWkj9jXx/Listeners TMPDIR=/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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/d7faf1a2181af24eb0506ba5a7df7036140881c3ffe6309ac70b7534cec92fdcd092a71b760bc0d7118dae0a3606d3ac43d753d8b0628cb80f91e3e624ac65fb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/02809e28570e814904b1498f50e40a150458758faf15ad0bf0b73cee6e5e924f79d81ee400278247669cd87f7b5c5022a505a8d3ec90c16443302b25baa77b23", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2a094a651e27d234c6f6eddebada5a3f18f0addce2cfb1f1d77d958efd70586304ae5be4b1209e80fff3a4f7204f865207b1c45260c163ea4c2f1ad7f624276b"} build_url:https://queue.taskcluster.net/v1/task/Dd8zwx0xR8CEmyg-D80NMw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011017 build_url: 'https://queue.taskcluster.net/v1/task/Dd8zwx0xR8CEmyg-D80NMw/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/d7faf1a2181af24eb0506ba5a7df7036140881c3ffe6309ac70b7534cec92fdcd092a71b760bc0d7118dae0a3606d3ac43d753d8b0628cb80f91e3e624ac65fb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/02809e28570e814904b1498f50e40a150458758faf15ad0bf0b73cee6e5e924f79d81ee400278247669cd87f7b5c5022a505a8d3ec90c16443302b25baa77b23", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2a094a651e27d234c6f6eddebada5a3f18f0addce2cfb1f1d77d958efd70586304ae5be4b1209e80fff3a4f7204f865207b1c45260c163ea4c2f1ad7f624276b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-03 04:25:24.325386) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 04:25:24.325757) ========= 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.ooORzFkFfn/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.UoiWkj9jXx/Listeners TMPDIR=/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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.005051 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 04:25:24.374182) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-03 04:25:24.377520) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-03 04:25:24.377845) ========= ========= Total master_lag: 0.19 =========