builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0266 starttime: 1490779658.75 results: success (0) buildid: 20170329004027 builduid: 6ea758aee0f34738a96547945a477588 revision: 93a70cd28ef91670a90a21c9553541c8d98d7027 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-29 02:27:38.749437) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-29 02:27:38.749917) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-29 02:27:38.750216) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-29 02:27:38.777706) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 02:27:38.778042) ========= 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.mxd8XoBvWZ/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.XkcFxGVKTy/Listeners TMPDIR=/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-29 02:27:38-- 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% 101M=0s 2017-03-29 02:27:38 (101 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.110576 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 02:27:38.913490) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 02:27:38.913818) ========= 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.mxd8XoBvWZ/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.XkcFxGVKTy/Listeners TMPDIR=/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.037544 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 02:27:38.973477) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-29 02:27:38.973846) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 93a70cd28ef91670a90a21c9553541c8d98d7027 --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 93a70cd28ef91670a90a21c9553541c8d98d7027 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.mxd8XoBvWZ/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.XkcFxGVKTy/Listeners TMPDIR=/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-29 02:27:39,081 truncating revision to first 12 chars 2017-03-29 02:27:39,081 Setting DEBUG logging. 2017-03-29 02:27:39,081 attempt 1/10 2017-03-29 02:27:39,081 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/93a70cd28ef9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-29 02:27:40,179 unpacking tar archive at: mozilla-aurora-93a70cd28ef9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.557875 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-29 02:27:40.554981) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-29 02:27:40.555314) ========= script_repo_revision: 93a70cd28ef91670a90a21c9553541c8d98d7027 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-29 02:27:40.555709) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-29 02:27:40.555975) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-29 02:27:40.575516) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-03-29 02:27:40.575812) ========= /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.mxd8XoBvWZ/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.XkcFxGVKTy/Listeners TMPDIR=/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 02:27:40 INFO - MultiFileLogger online at 20170329 02:27:40 in /builds/slave/test 02:27:40 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 02:27:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:27:40 INFO - {'append_to_log': False, 02:27:40 INFO - 'base_work_dir': '/builds/slave/test', 02:27:40 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:27:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:27:40 INFO - 'branch': 'Mozilla-Aurora', 02:27:40 INFO - 'buildbot_json_path': 'buildprops.json', 02:27:40 INFO - 'config_files': ('talos/mac_config.py',), 02:27:40 INFO - 'default_actions': ('clobber', 02:27:40 INFO - 'read-buildbot-config', 02:27:40 INFO - 'download-and-extract', 02:27:40 INFO - 'populate-webroot', 02:27:40 INFO - 'create-virtualenv', 02:27:40 INFO - 'install', 02:27:40 INFO - 'run-tests'), 02:27:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:27:40 INFO - 'download_minidump_stackwalk': True, 02:27:40 INFO - 'download_symbols': 'ondemand', 02:27:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:27:40 INFO - 'tooltool.py': '/tools/tooltool.py', 02:27:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:27:40 INFO - '/tools/misc-python/virtualenv.py')}, 02:27:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:27:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:27:40 INFO - 'gecko_profile': False, 02:27:40 INFO - 'gecko_profile_interval': 0, 02:27:40 INFO - 'installer_path': 'installer.exe', 02:27:40 INFO - 'log_level': 'info', 02:27:40 INFO - 'log_name': 'talos', 02:27:40 INFO - 'log_to_console': True, 02:27:40 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:27:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:27:40 INFO - 'opt_config_files': (), 02:27:40 INFO - 'pip_index': False, 02:27:40 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:27:40 INFO - 'cmd': ('bash', 02:27:40 INFO - '-c', 02:27:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:27:40 INFO - 'enabled': True, 02:27:40 INFO - 'halt_on_failure': False, 02:27:40 INFO - 'name': 'check_screen_resolution'},), 02:27:40 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:27:40 INFO - 'cmd': ('bash', 02:27:40 INFO - '-c', 02:27:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:27:40 INFO - 'enabled': True, 02:27:40 INFO - 'halt_on_failure': False, 02:27:40 INFO - 'name': 'check_screen_resolution'},), 02:27:40 INFO - 'run_cmd_checks_enabled': True, 02:27:40 INFO - 'suite': 'dromaeojs', 02:27:40 INFO - 'system_bits': '32', 02:27:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:27:40 INFO - 'title': 't-yosemite-r7-0266', 02:27:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:27:40 INFO - 'use_talos_json': True, 02:27:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:27:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:27:40 INFO - 'work_dir': 'build'} 02:27:40 INFO - [mozharness: 2017-03-29 09:27:40.789130Z] Running clobber step. 02:27:40 INFO - Running pre-action listener: _resource_record_pre_action 02:27:40 INFO - Running main action method: clobber 02:27:40 INFO - rmtree: /builds/slave/test/build 02:27:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:27:43 INFO - Running post-action listener: _resource_record_post_action 02:27:43 INFO - [mozharness: 2017-03-29 09:27:43.290645Z] Finished clobber step (success) 02:27:43 INFO - [mozharness: 2017-03-29 09:27:43.290799Z] Running read-buildbot-config step. 02:27:43 INFO - Running pre-action listener: _resource_record_pre_action 02:27:43 INFO - Running main action method: read_buildbot_config 02:27:43 INFO - Using buildbot properties: 02:27:43 INFO - { 02:27:43 INFO - "project": "", 02:27:43 INFO - "product": "firefox", 02:27:43 INFO - "script_repo_revision": "production", 02:27:43 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 02:27:43 INFO - "repository": "", 02:27:43 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 02:27:43 INFO - "buildid": "20170329004027", 02:27:43 INFO - "stage_platform": "macosx64", 02:27:43 INFO - "basedir": "/builds/slave/test", 02:27:43 INFO - "nightly_build": "True", 02:27:43 INFO - "buildnumber": 68, 02:27:43 INFO - "slavename": "t-yosemite-r7-0266", 02:27:43 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 02:27:43 INFO - "platform": "yosemite_r7", 02:27:43 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:27:43 INFO - "branch": "mozilla-aurora", 02:27:43 INFO - "repo_path": "releases/mozilla-aurora", 02:27:43 INFO - "revision": "93a70cd28ef91670a90a21c9553541c8d98d7027", 02:27:43 INFO - "pgo_build": "False", 02:27:43 INFO - "builduid": "6ea758aee0f34738a96547945a477588", 02:27:43 INFO - "slavebuilddir": "test" 02:27:43 INFO - } 02:27:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/BpvuIEGERui6qrnZGEemBQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 02:27:43 INFO - Running post-action listener: _resource_record_post_action 02:27:43 INFO - [mozharness: 2017-03-29 09:27:43.294372Z] Finished read-buildbot-config step (success) 02:27:43 INFO - [mozharness: 2017-03-29 09:27:43.294501Z] Running download-and-extract step. 02:27:43 INFO - Running pre-action listener: _resource_record_pre_action 02:27:43 INFO - Running main action method: download_and_extract 02:27:43 INFO - mkdir: /builds/slave/test/build/tests 02:27:43 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')]} 02:27:43 INFO - trying https://queue.taskcluster.net/v1/task/BpvuIEGERui6qrnZGEemBQ/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 02:27:43 INFO - Downloading https://queue.taskcluster.net/v1/task/BpvuIEGERui6qrnZGEemBQ/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 02:27:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BpvuIEGERui6qrnZGEemBQ/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 02:27:43 INFO - Downloaded 1199 bytes. 02:27:43 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 02:27:43 INFO - Using the following test package requirements: 02:27:43 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 02:27:43 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:27:43 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 02:27:43 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:27:43 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 02:27:43 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:27:43 INFO - u'jsshell-mac.zip'], 02:27:43 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:27:43 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 02:27:43 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 02:27:43 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:27:43 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 02:27:43 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:27:43 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 02:27:43 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:27:43 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 02:27:43 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:27:43 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 02:27:43 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:27:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BpvuIEGERui6qrnZGEemBQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 02:27:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BpvuIEGERui6qrnZGEemBQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:27:43 INFO - Fetch https://queue.taskcluster.net/v1/task/BpvuIEGERui6qrnZGEemBQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 02:27:45 INFO - Expected file size: 51787795 02:27:45 INFO - Obtained file size: 51787795 02:28:01 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:28:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BpvuIEGERui6qrnZGEemBQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 02:28:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BpvuIEGERui6qrnZGEemBQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:28:01 INFO - Fetch https://queue.taskcluster.net/v1/task/BpvuIEGERui6qrnZGEemBQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 02:28:02 INFO - Expected file size: 51787795 02:28:02 INFO - Obtained file size: 51787795 02:28:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BpvuIEGERui6qrnZGEemBQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 02:28:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BpvuIEGERui6qrnZGEemBQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:28:17 INFO - Fetch https://queue.taskcluster.net/v1/task/BpvuIEGERui6qrnZGEemBQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 02:28:18 INFO - Expected file size: 14404438 02:28:18 INFO - Obtained file size: 14404438 02:28:19 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')]} 02:28:19 INFO - trying https://queue.taskcluster.net/v1/task/BpvuIEGERui6qrnZGEemBQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:28:19 INFO - Downloading https://queue.taskcluster.net/v1/task/BpvuIEGERui6qrnZGEemBQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 02:28:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BpvuIEGERui6qrnZGEemBQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 02:28:21 INFO - Downloaded 74739594 bytes. 02:28:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BpvuIEGERui6qrnZGEemBQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:28:21 INFO - mkdir: /builds/slave/test/properties 02:28:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:28:21 INFO - Writing to file /builds/slave/test/properties/build_url 02:28:21 INFO - Contents: 02:28:21 INFO - build_url:https://queue.taskcluster.net/v1/task/BpvuIEGERui6qrnZGEemBQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:28:21 INFO - Running post-action listener: _resource_record_post_action 02:28:21 INFO - Running post-action listener: set_extra_try_arguments 02:28:21 INFO - [mozharness: 2017-03-29 09:28:21.849113Z] Finished download-and-extract step (success) 02:28:21 INFO - [mozharness: 2017-03-29 09:28:21.849270Z] Running populate-webroot step. 02:28:21 INFO - Running pre-action listener: _resource_record_pre_action 02:28:21 INFO - Running main action method: populate_webroot 02:28:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:28:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:28:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:28:21 INFO - '--tppagecycles', 02:28:21 INFO - '7'], 02:28:21 INFO - 'tests': ['tsvgm']}}, 02:28:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:28:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:28:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:28:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:28:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:28:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:28:21 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:28:21 INFO - 'talos_options': ['--disable-e10s'], 02:28:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:28:21 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:28:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:28:21 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:28:21 INFO - 'talos_options': ['--disable-e10s'], 02:28:21 INFO - 'tests': ['damp', 'tps']}, 02:28:21 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:28:21 INFO - 'tests': ['damp', 'tps']}, 02:28:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:28:21 INFO - 'tests': ['dromaeo_dom']}, 02:28:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:28:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:28:21 INFO - 'tests': ['basic_compositor_video']}, 02:28:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:28:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:28:21 INFO - 'tests': ['a11yr', 02:28:21 INFO - 'ts_paint', 02:28:21 INFO - 'tpaint', 02:28:21 INFO - 'sessionrestore', 02:28:21 INFO - 'sessionrestore_no_auto_restore', 02:28:21 INFO - 'tabpaint']}, 02:28:21 INFO - 'other-e10s': {'tests': ['a11yr', 02:28:21 INFO - 'ts_paint', 02:28:21 INFO - 'tpaint', 02:28:21 INFO - 'sessionrestore', 02:28:21 INFO - 'sessionrestore_no_auto_restore', 02:28:21 INFO - 'tabpaint']}, 02:28:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:28:21 INFO - 'ts_paint', 02:28:21 INFO - 'tpaint', 02:28:21 INFO - 'sessionrestore', 02:28:21 INFO - 'sessionrestore_no_auto_restore', 02:28:21 INFO - 'tabpaint']}, 02:28:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:28:21 INFO - 'ts_paint', 02:28:21 INFO - 'tpaint', 02:28:21 INFO - 'sessionrestore', 02:28:21 INFO - 'sessionrestore_no_auto_restore', 02:28:21 INFO - 'tabpaint']}, 02:28:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:28:21 INFO - 'tests': ['a11yr', 02:28:21 INFO - 'ts_paint', 02:28:21 INFO - 'tpaint', 02:28:21 INFO - 'sessionrestore', 02:28:21 INFO - 'sessionrestore_no_auto_restore', 02:28:21 INFO - 'tabpaint']}, 02:28:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:28:21 INFO - 'tests': ['a11yr', 02:28:21 INFO - 'ts_paint', 02:28:21 INFO - 'tpaint', 02:28:21 INFO - 'sessionrestore', 02:28:21 INFO - 'sessionrestore_no_auto_restore', 02:28:21 INFO - 'tabpaint']}, 02:28:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:28:21 INFO - 'tests': ['tsvgx', 02:28:21 INFO - 'tsvgr_opacity', 02:28:21 INFO - 'tart', 02:28:21 INFO - 'tscrollx', 02:28:21 INFO - 'cart', 02:28:21 INFO - 'tsvg_static']}, 02:28:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:28:21 INFO - 'tsvgr_opacity', 02:28:21 INFO - 'tart', 02:28:21 INFO - 'tscrollx', 02:28:21 INFO - 'cart', 02:28:21 INFO - 'tsvg_static']}, 02:28:21 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:28:21 INFO - 'talos_options': ['--disable-e10s'], 02:28:21 INFO - 'tests': ['tp5o']}, 02:28:21 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:28:21 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:28:21 INFO - 'talos_options': ['--disable-e10s', 02:28:21 INFO - '--xperf_path', 02:28:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:28:21 INFO - 'tests': ['tp5n']}, 02:28:21 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:28:21 INFO - 'talos_options': ['--xperf_path', 02:28:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:28:21 INFO - 'tests': ['tp5n']}}, 02:28:21 INFO - 'talos.zip': {'path': '', 02:28:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:28:21 INFO - Running post-action listener: _resource_record_post_action 02:28:21 INFO - [mozharness: 2017-03-29 09:28:21.867711Z] Finished populate-webroot step (success) 02:28:21 INFO - [mozharness: 2017-03-29 09:28:21.867824Z] Running create-virtualenv step. 02:28:21 INFO - Running pre-action listener: _resource_record_pre_action 02:28:21 INFO - Running main action method: create_virtualenv 02:28:21 INFO - Creating virtualenv /builds/slave/test/build/venv 02:28:21 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 02:28:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:28:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:28:21 INFO - Using real prefix '/tools/python27' 02:28:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:28:22 INFO - Installing distribute.............................................................................................................................................................................................done. 02:28:25 INFO - Installing pip.................done. 02:28:25 INFO - Return code: 0 02:28:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:28:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:28:25 INFO - Reading from file tmpfile_stdout 02:28:25 INFO - Output received: 02:28:25 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 02:28:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:28:25 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')]} 02:28:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:25 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')]} 02:28:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:25 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 0x106a69b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a6c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5e156eaa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106847d30>, '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 0x10676edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10683cbe8>, '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.mxd8XoBvWZ/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.XkcFxGVKTy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:28:25 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 02:28:25 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 02:28:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mxd8XoBvWZ/Render', 02:28:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:28:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:28:25 INFO - 'HOME': '/Users/cltbld', 02:28:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:28:25 INFO - 'LOGNAME': 'cltbld', 02:28:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:25 INFO - 'MOZ_NO_REMOTE': '1', 02:28:25 INFO - 'NO_EM_RESTART': '1', 02:28:25 INFO - 'PAGER': '/bin/cat', 02:28:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:28:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:25 INFO - 'PWD': '/builds/slave/test', 02:28:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:28:25 INFO - 'SHELL': '/bin/bash', 02:28:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XkcFxGVKTy/Listeners', 02:28:25 INFO - 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', 02:28:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:28:25 INFO - 'USER': 'cltbld', 02:28:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:28:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:28:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:25 INFO - 'XPC_FLAGS': '0x0', 02:28:25 INFO - 'XPC_SERVICE_NAME': '0', 02:28:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:28:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:26 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 02:28:26 INFO - Cleaning up... 02:28:26 INFO - Return code: 0 02:28:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:28:26 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')]} 02:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:26 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')]} 02:28:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:26 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 0x106a69b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a6c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5e156eaa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106847d30>, '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 0x10676edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10683cbe8>, '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.mxd8XoBvWZ/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.XkcFxGVKTy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:28:26 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 02:28:26 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 02:28:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mxd8XoBvWZ/Render', 02:28:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:28:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:28:26 INFO - 'HOME': '/Users/cltbld', 02:28:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:28:26 INFO - 'LOGNAME': 'cltbld', 02:28:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:26 INFO - 'MOZ_NO_REMOTE': '1', 02:28:26 INFO - 'NO_EM_RESTART': '1', 02:28:26 INFO - 'PAGER': '/bin/cat', 02:28:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:28:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:26 INFO - 'PWD': '/builds/slave/test', 02:28:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:28:26 INFO - 'SHELL': '/bin/bash', 02:28:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XkcFxGVKTy/Listeners', 02:28:26 INFO - 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', 02:28:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:28:26 INFO - 'USER': 'cltbld', 02:28:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:28:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:28:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:26 INFO - 'XPC_FLAGS': '0x0', 02:28:26 INFO - 'XPC_SERVICE_NAME': '0', 02:28:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:28:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:26 INFO - Downloading/unpacking psutil>=3.1.1 02:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:28:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:28:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:28:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:28:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:28:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:28:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:28:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:28:29 INFO - Installing collected packages: psutil 02:28:29 INFO - Running setup.py install for psutil 02:28:30 INFO - building 'psutil._psutil_osx' extension 02:28:30 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 02:28:30 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 02:28:30 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 02:28:30 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 02:28:30 INFO - building 'psutil._psutil_posix' extension 02:28:30 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 02:28:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:28:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:28:30 INFO - ^ 02:28:30 INFO - 1 warning generated. 02:28:30 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 02:28:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:28:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:28:31 INFO - Successfully installed psutil 02:28:31 INFO - Cleaning up... 02:28:31 INFO - Return code: 0 02:28:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:28:31 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')]} 02:28:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:31 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')]} 02:28:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:31 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 0x106a69b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a6c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5e156eaa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106847d30>, '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 0x10676edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10683cbe8>, '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.mxd8XoBvWZ/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.XkcFxGVKTy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:28:31 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 02:28:31 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 02:28:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mxd8XoBvWZ/Render', 02:28:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:28:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:28:31 INFO - 'HOME': '/Users/cltbld', 02:28:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:28:31 INFO - 'LOGNAME': 'cltbld', 02:28:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:31 INFO - 'MOZ_NO_REMOTE': '1', 02:28:31 INFO - 'NO_EM_RESTART': '1', 02:28:31 INFO - 'PAGER': '/bin/cat', 02:28:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:28:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:31 INFO - 'PWD': '/builds/slave/test', 02:28:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:28:31 INFO - 'SHELL': '/bin/bash', 02:28:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XkcFxGVKTy/Listeners', 02:28:31 INFO - 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', 02:28:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:28:31 INFO - 'USER': 'cltbld', 02:28:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:28:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:28:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:31 INFO - 'XPC_FLAGS': '0x0', 02:28:31 INFO - 'XPC_SERVICE_NAME': '0', 02:28:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:28:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:28:31 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 02:28:31 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 02:28:31 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 02:28:31 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 02:28:31 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 02:28:31 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 02:28:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:28:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:28:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:28:34 INFO - Installing collected packages: mozsystemmonitor 02:28:34 INFO - Running setup.py install for mozsystemmonitor 02:28:34 INFO - Successfully installed mozsystemmonitor 02:28:34 INFO - Cleaning up... 02:28:34 INFO - Return code: 0 02:28:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:28: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')]} 02:28:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28: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')]} 02:28:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:34 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 0x106a69b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a6c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5e156eaa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106847d30>, '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 0x10676edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10683cbe8>, '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.mxd8XoBvWZ/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.XkcFxGVKTy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:28:34 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 02:28:34 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 02:28:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mxd8XoBvWZ/Render', 02:28:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:28:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:28:34 INFO - 'HOME': '/Users/cltbld', 02:28:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:28:34 INFO - 'LOGNAME': 'cltbld', 02:28:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:34 INFO - 'MOZ_NO_REMOTE': '1', 02:28:34 INFO - 'NO_EM_RESTART': '1', 02:28:34 INFO - 'PAGER': '/bin/cat', 02:28:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:28:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:34 INFO - 'PWD': '/builds/slave/test', 02:28:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:28:34 INFO - 'SHELL': '/bin/bash', 02:28:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XkcFxGVKTy/Listeners', 02:28:34 INFO - 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', 02:28:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:28:34 INFO - 'USER': 'cltbld', 02:28:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:28:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:28:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:34 INFO - 'XPC_FLAGS': '0x0', 02:28:34 INFO - 'XPC_SERVICE_NAME': '0', 02:28:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:28:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:34 INFO - Downloading/unpacking jsonschema==2.5.1 02:28:34 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 02:28:34 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 02:28:34 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 02:28:34 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 02:28:34 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 02:28:34 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 02:28:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:28:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:28:37 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 02:28:37 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 02:28:37 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 02:28:37 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 02:28:37 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 02:28:37 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 02:28:37 INFO - Downloading functools32-3.2.3-2.tar.gz 02:28:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:28:37 INFO - warning: no files found matching '*.txt' 02:28:37 INFO - no previously-included directories found matching 'build' 02:28:37 INFO - no previously-included directories found matching 'dist' 02:28:37 INFO - no previously-included directories found matching '.git*' 02:28:37 INFO - Installing collected packages: jsonschema, functools32 02:28:37 INFO - Running setup.py install for functools32 02:28:37 INFO - warning: no files found matching '*.txt' 02:28:37 INFO - no previously-included directories found matching 'build' 02:28:37 INFO - no previously-included directories found matching 'dist' 02:28:37 INFO - no previously-included directories found matching '.git*' 02:28:37 INFO - Successfully installed jsonschema functools32 02:28:37 INFO - Cleaning up... 02:28:38 INFO - Return code: 0 02:28:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:28:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:28:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:28:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:38 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 0x106a69b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a6c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5e156eaa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106847d30>, '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 0x10676edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10683cbe8>, '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.mxd8XoBvWZ/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.XkcFxGVKTy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:28:38 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 02:28:38 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 02:28:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mxd8XoBvWZ/Render', 02:28:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:28:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:28:38 INFO - 'HOME': '/Users/cltbld', 02:28:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:28:38 INFO - 'LOGNAME': 'cltbld', 02:28:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:38 INFO - 'MOZ_NO_REMOTE': '1', 02:28:38 INFO - 'NO_EM_RESTART': '1', 02:28:38 INFO - 'PAGER': '/bin/cat', 02:28:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:28:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:38 INFO - 'PWD': '/builds/slave/test', 02:28:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:28:38 INFO - 'SHELL': '/bin/bash', 02:28:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XkcFxGVKTy/Listeners', 02:28:38 INFO - 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', 02:28:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:28:38 INFO - 'USER': 'cltbld', 02:28:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:28:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:28:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:38 INFO - 'XPC_FLAGS': '0x0', 02:28:38 INFO - 'XPC_SERVICE_NAME': '0', 02:28:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:28:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:28:39 INFO - Cleaning up... 02:28:39 INFO - Return code: 0 02:28:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:28:39 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')]} 02:28:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:39 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')]} 02:28:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:39 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 0x106a69b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a6c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5e156eaa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106847d30>, '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 0x10676edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10683cbe8>, '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.mxd8XoBvWZ/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.XkcFxGVKTy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:28:39 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 02:28:39 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 02:28:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mxd8XoBvWZ/Render', 02:28:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:28:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:28:39 INFO - 'HOME': '/Users/cltbld', 02:28:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:28:39 INFO - 'LOGNAME': 'cltbld', 02:28:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:39 INFO - 'MOZ_NO_REMOTE': '1', 02:28:39 INFO - 'NO_EM_RESTART': '1', 02:28:39 INFO - 'PAGER': '/bin/cat', 02:28:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:28:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:39 INFO - 'PWD': '/builds/slave/test', 02:28:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:28:39 INFO - 'SHELL': '/bin/bash', 02:28:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XkcFxGVKTy/Listeners', 02:28:39 INFO - 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', 02:28:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:28:39 INFO - 'USER': 'cltbld', 02:28:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:28:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:28:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:39 INFO - 'XPC_FLAGS': '0x0', 02:28:39 INFO - 'XPC_SERVICE_NAME': '0', 02:28:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:28:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:39 INFO - Downloading/unpacking blobuploader==1.2.4 02:28:39 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 02:28:39 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 02:28:39 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 02:28:39 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 02:28:39 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 02:28:39 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 02:28:42 INFO - Downloading blobuploader-1.2.4.tar.gz 02:28:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:28:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:28:42 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 02:28:42 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 02:28:42 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 02:28:42 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 02:28:42 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 02:28:42 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 02:28:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:28:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:28:43 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 02:28:43 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 02:28:43 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 02:28:43 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 02:28:43 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 02:28:43 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 02:28:43 INFO - Downloading docopt-0.6.1.tar.gz 02:28:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:28:43 INFO - Installing collected packages: blobuploader, requests, docopt 02:28:43 INFO - Running setup.py install for blobuploader 02:28:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:28:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:28:44 INFO - Running setup.py install for requests 02:28:44 INFO - Running setup.py install for docopt 02:28:44 INFO - Successfully installed blobuploader requests docopt 02:28:44 INFO - Cleaning up... 02:28:44 INFO - Return code: 0 02:28:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:28:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:28:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:28:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:44 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 0x106a69b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a6c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5e156eaa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106847d30>, '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 0x10676edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10683cbe8>, '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.mxd8XoBvWZ/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.XkcFxGVKTy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:28:44 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 02:28:44 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 02:28:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mxd8XoBvWZ/Render', 02:28:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:28:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:28:44 INFO - 'HOME': '/Users/cltbld', 02:28:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:28:44 INFO - 'LOGNAME': 'cltbld', 02:28:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:44 INFO - 'MOZ_NO_REMOTE': '1', 02:28:44 INFO - 'NO_EM_RESTART': '1', 02:28:44 INFO - 'PAGER': '/bin/cat', 02:28:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:28:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:44 INFO - 'PWD': '/builds/slave/test', 02:28:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:28:44 INFO - 'SHELL': '/bin/bash', 02:28:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XkcFxGVKTy/Listeners', 02:28:44 INFO - 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', 02:28:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:28:44 INFO - 'USER': 'cltbld', 02:28:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:28:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:28:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:44 INFO - 'XPC_FLAGS': '0x0', 02:28:44 INFO - 'XPC_SERVICE_NAME': '0', 02:28:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:28:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:28:45 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-7lrThu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:28:45 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-C35E9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:28:45 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-cMxqTe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:28:45 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-OITmEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:28:45 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-PMDHEM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:28:45 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-sEJxWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:28:45 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-BDsEHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:28:45 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-bMlqj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:28:45 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-1XSR8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:28:46 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-TKATIL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:28:46 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-NxBmpB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:28:46 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-AO41L1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:28:46 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-gIFlWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:28:46 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-3b_Qhl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:28:46 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-luXy7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:28:46 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-IoIBZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:28:46 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-vESNZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:28:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:28:46 INFO - Running setup.py install for manifestparser 02:28:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:28:47 INFO - Running setup.py install for mozcrash 02:28:47 INFO - Running setup.py install for mozdebug 02:28:47 INFO - Running setup.py install for mozdevice 02:28:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:28:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:28:47 INFO - Running setup.py install for mozfile 02:28:47 INFO - Running setup.py install for mozhttpd 02:28:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:28:47 INFO - Running setup.py install for mozinfo 02:28:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:28:47 INFO - Running setup.py install for mozInstall 02:28:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:28:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:28:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:28:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:28:48 INFO - Running setup.py install for mozleak 02:28:48 INFO - Running setup.py install for mozlog 02:28:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:28:48 INFO - Running setup.py install for moznetwork 02:28:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:28:48 INFO - Running setup.py install for mozprocess 02:28:48 INFO - Running setup.py install for mozprofile 02:28:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:28:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:28:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:28:48 INFO - Running setup.py install for mozrunner 02:28:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:28:49 INFO - Running setup.py install for mozscreenshot 02:28:49 INFO - Running setup.py install for moztest 02:28:49 INFO - Running setup.py install for mozversion 02:28:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:28:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:28:49 INFO - Cleaning up... 02:28:49 INFO - Return code: 0 02:28:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:28:49 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')]} 02:28:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:49 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')]} 02:28:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:49 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 0x106a69b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a6c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5e156eaa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106847d30>, '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 0x10676edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10683cbe8>, '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.mxd8XoBvWZ/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.XkcFxGVKTy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:28:49 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 02:28:49 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 02:28:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mxd8XoBvWZ/Render', 02:28:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:28:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:28:49 INFO - 'HOME': '/Users/cltbld', 02:28:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:28:49 INFO - 'LOGNAME': 'cltbld', 02:28:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:49 INFO - 'MOZ_NO_REMOTE': '1', 02:28:49 INFO - 'NO_EM_RESTART': '1', 02:28:49 INFO - 'PAGER': '/bin/cat', 02:28:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:28:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:49 INFO - 'PWD': '/builds/slave/test', 02:28:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:28:49 INFO - 'SHELL': '/bin/bash', 02:28:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XkcFxGVKTy/Listeners', 02:28:49 INFO - 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', 02:28:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:28:49 INFO - 'USER': 'cltbld', 02:28:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:28:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:28:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:49 INFO - 'XPC_FLAGS': '0x0', 02:28:49 INFO - 'XPC_SERVICE_NAME': '0', 02:28:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:28:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:28:49 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-ljOQlN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:28:49 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)) 02:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:28:49 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-QJqB0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:28:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 02:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:28:49 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-Qx9FVF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:28:50 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)) 02:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:28:50 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-mOaWQ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:28:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 02:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:28:50 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-N75WfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:28:50 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)) 02:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:28:50 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-udtx3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:28:50 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)) 02:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:28:50 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-9NWYmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:28:50 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)) 02:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:28:50 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-bGreP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:28:50 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)) 02:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:28:50 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-L22IHN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:28:50 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)) 02:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:28:50 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-gmKmjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:28:50 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)) 02:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:28:50 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-c1SxoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:28:50 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)) 02:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:28:50 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-8ikMjL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:28:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 02:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:28:51 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-QC0EDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:28:51 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)) 02:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:28:51 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-Xelg2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:28:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 02:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:28:51 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-4C7zuf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:28:51 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)) 02:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:28:51 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-O2lvtT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:28:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 02:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:28:51 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-iT2G9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:28:51 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)) 02:28:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:28:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:28:51 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)) 02:28:51 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:28:51 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:28:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:28: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 02:28: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 02:28: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 02:28: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 02:28: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 02:28: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 02:28:54 INFO - Downloading blessings-1.6.tar.gz 02:28:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:28:54 INFO - Installing collected packages: blessings 02:28:54 INFO - Running setup.py install for blessings 02:28:54 INFO - Successfully installed blessings 02:28:54 INFO - Cleaning up... 02:28:54 INFO - Return code: 0 02:28:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:28:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:28:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:28:54 INFO - Reading from file tmpfile_stdout 02:28:54 INFO - Current package versions: 02:28:54 INFO - blessings == 1.6 02:28:54 INFO - blobuploader == 1.2.4 02:28:54 INFO - docopt == 0.6.1 02:28:54 INFO - functools32 == 3.2.3-2 02:28:54 INFO - jsonschema == 2.5.1 02:28:54 INFO - manifestparser == 1.1 02:28:54 INFO - mozInstall == 1.12 02:28:54 INFO - mozcrash == 1.0 02:28:54 INFO - mozdebug == 0.1 02:28:54 INFO - mozdevice == 0.49 02:28:54 INFO - mozfile == 1.2 02:28:54 INFO - mozhttpd == 0.7 02:28:54 INFO - mozinfo == 0.9 02:28:54 INFO - mozleak == 0.1 02:28:54 INFO - mozlog == 3.4 02:28:54 INFO - moznetwork == 0.27 02:28:54 INFO - mozprocess == 0.25 02:28:54 INFO - mozprofile == 0.28 02:28:54 INFO - mozrunner == 6.13 02:28:54 INFO - mozscreenshot == 0.1 02:28:54 INFO - mozsystemmonitor == 0.3 02:28:54 INFO - moztest == 0.8 02:28:54 INFO - mozversion == 1.4 02:28:54 INFO - psutil == 3.1.1 02:28:54 INFO - requests == 1.2.3 02:28:54 INFO - wsgiref == 0.1.2 02:28:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:28:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:28:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:54 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 0x106a69b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a6c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5e156eaa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106847d30>, '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 0x10676edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10683cbe8>, '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.mxd8XoBvWZ/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.XkcFxGVKTy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:28:54 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 02:28:54 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 02:28:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mxd8XoBvWZ/Render', 02:28:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:28:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:28:54 INFO - 'HOME': '/Users/cltbld', 02:28:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:28:54 INFO - 'LOGNAME': 'cltbld', 02:28:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:54 INFO - 'MOZ_NO_REMOTE': '1', 02:28:54 INFO - 'NO_EM_RESTART': '1', 02:28:54 INFO - 'PAGER': '/bin/cat', 02:28:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:28:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:54 INFO - 'PWD': '/builds/slave/test', 02:28:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:28:54 INFO - 'SHELL': '/bin/bash', 02:28:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XkcFxGVKTy/Listeners', 02:28:54 INFO - 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', 02:28:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:28:54 INFO - 'USER': 'cltbld', 02:28:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:28:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:28:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:54 INFO - 'XPC_FLAGS': '0x0', 02:28:54 INFO - 'XPC_SERVICE_NAME': '0', 02:28:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:28:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:55 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)) 02:28:55 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)) 02:28:55 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)) 02:28:55 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)) 02:28:55 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)) 02:28:55 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)) 02:28:55 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)) 02:28:55 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)) 02:28:55 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)) 02:28:55 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)) 02:28:55 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)) 02:28:55 INFO - Cleaning up... 02:28:55 INFO - Return code: 0 02:28:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:28:55 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')]} 02:28:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:55 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')]} 02:28:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:55 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 0x106a69b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a6c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5e156eaa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106847d30>, '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 0x10676edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10683cbe8>, '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.mxd8XoBvWZ/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.XkcFxGVKTy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:28:55 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 02:28:55 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 02:28:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mxd8XoBvWZ/Render', 02:28:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:28:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:28:55 INFO - 'HOME': '/Users/cltbld', 02:28:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:28:55 INFO - 'LOGNAME': 'cltbld', 02:28:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:55 INFO - 'MOZ_NO_REMOTE': '1', 02:28:55 INFO - 'NO_EM_RESTART': '1', 02:28:55 INFO - 'PAGER': '/bin/cat', 02:28:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:28:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:55 INFO - 'PWD': '/builds/slave/test', 02:28:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:28:55 INFO - 'SHELL': '/bin/bash', 02:28:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XkcFxGVKTy/Listeners', 02:28:55 INFO - 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', 02:28:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:28:55 INFO - 'USER': 'cltbld', 02:28:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:28:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:28:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:55 INFO - 'XPC_FLAGS': '0x0', 02:28:55 INFO - 'XPC_SERVICE_NAME': '0', 02:28:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:28:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:28:55 INFO - Cleaning up... 02:28:55 INFO - Return code: 0 02:28:55 INFO - Running post-action listener: _resource_record_post_action 02:28:55 INFO - Running post-action listener: _start_resource_monitoring 02:28:55 INFO - Starting resource monitoring. 02:28:55 INFO - [mozharness: 2017-03-29 09:28:55.337333Z] Finished create-virtualenv step (success) 02:28:55 INFO - [mozharness: 2017-03-29 09:28:55.338354Z] Running install step. 02:28:55 INFO - Running pre-action listener: _resource_record_pre_action 02:28:55 INFO - Running main action method: install 02:28:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:28:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:28:55 INFO - Reading from file tmpfile_stdout 02:28:55 INFO - Detecting whether we're running mozinstall >=1.0... 02:28:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:28:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:28:55 INFO - Reading from file tmpfile_stdout 02:28:55 INFO - Output received: 02:28:55 INFO - Usage: mozinstall [options] installer 02:28:55 INFO - Options: 02:28:55 INFO - -h, --help show this help message and exit 02:28:55 INFO - -d DEST, --destination=DEST 02:28:55 INFO - Directory to install application into. [default: 02:28:55 INFO - "/builds/slave/test"] 02:28:55 INFO - --app=APP Application being installed. [default: firefox] 02:28:55 INFO - mkdir: /builds/slave/test/build/application 02:28:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:28:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:29:15 INFO - Reading from file tmpfile_stdout 02:29:15 INFO - Output received: 02:29:15 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:29:15 INFO - Running post-action listener: _resource_record_post_action 02:29:15 INFO - [mozharness: 2017-03-29 09:29:15.742590Z] Finished install step (success) 02:29:15 INFO - [mozharness: 2017-03-29 09:29:15.742737Z] Running run-tests step. 02:29:15 INFO - Running pre-action listener: _resource_record_pre_action 02:29:15 INFO - Running main action method: run_tests 02:29:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:29:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:29:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:29:15 INFO - 2017-03-29 02:29:15.757 screenresolution[1623:7474] starting screenresolution argv=screenresolution get 02:29:15 INFO - 2017-03-29 02:29:15.759 screenresolution[1623:7474] Display 0: 1600x1200x32@60 02:29:15 INFO - 2017-03-29 02:29:15.765 screenresolution[1624:7477] starting screenresolution argv=screenresolution list 02:29:15 INFO - Available Modes on Display 0 02:29:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:29:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:29:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:29:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:29:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:29:15 INFO - Intel Iris: 02:29:15 INFO - Chipset Model: Intel Iris 02:29:15 INFO - Type: GPU 02:29:15 INFO - Bus: Built-In 02:29:15 INFO - VRAM (Dynamic, Max): 1536 MB 02:29:15 INFO - Vendor: Intel (0x8086) 02:29:15 INFO - Device ID: 0x0a2e 02:29:15 INFO - Revision ID: 0x0009 02:29:15 INFO - Displays: 02:29:15 INFO - Display: 02:29:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:29:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:29:15 INFO - Display Serial Number: 1600x1200 60 02:29:15 INFO - Main Display: Yes 02:29:15 INFO - Mirror: Off 02:29:15 INFO - Online: Yes 02:29:15 INFO - Rotation: Supported 02:29:15 INFO - Return code: 0 02:29:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:29:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:29:16 INFO - Python 2.7.3 02:29:16 INFO - Return code: 0 02:29:16 INFO - grabbing minidump binary from tooltool 02:29: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')]} 02:29:16 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 0x106847d30>, '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 0x10676edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10683cbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:29:16 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 02:29:16 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 02:29:16 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 02:29:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:29:16 INFO - Return code: 0 02:29:16 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:29:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:29:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:29:16 INFO - ENV: RUST_BACKTRACE is now 1 02:29:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:29:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:29:16 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/BpvuIEGERui6qrnZGEemBQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0266', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:29:16 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/BpvuIEGERui6qrnZGEemBQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0266 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:29:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mxd8XoBvWZ/Render', 02:29:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:29:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:29:16 INFO - 'HOME': '/Users/cltbld', 02:29:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:29:16 INFO - 'LOGNAME': 'cltbld', 02:29:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:29:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:29:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:16 INFO - 'MOZ_NO_REMOTE': '1', 02:29:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:29:16 INFO - 'NO_EM_RESTART': '1', 02:29:16 INFO - 'PAGER': '/bin/cat', 02:29:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:29:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:16 INFO - 'PWD': '/builds/slave/test', 02:29:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:29:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:29:16 INFO - 'RUST_BACKTRACE': '1', 02:29:16 INFO - 'SHELL': '/bin/bash', 02:29:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XkcFxGVKTy/Listeners', 02:29:16 INFO - 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', 02:29:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:29:16 INFO - 'USER': 'cltbld', 02:29:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:29:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:29:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:16 INFO - 'XPC_FLAGS': '0x0', 02:29:16 INFO - 'XPC_SERVICE_NAME': '0', 02:29:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:29:16 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/BpvuIEGERui6qrnZGEemBQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0266', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:29:16 INFO - mozversion application_buildid: 20170329004027 02:29:16 INFO - mozversion application_changeset: 93a70cd28ef91670a90a21c9553541c8d98d7027 02:29:16 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:29:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:29:16 INFO - mozversion application_name: Firefox 02:29:16 INFO - mozversion application_remotingname: firefox-dev 02:29:16 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:29:16 INFO - mozversion application_vendor: Mozilla 02:29:16 INFO - mozversion application_version: 54.0a2 02:29:16 INFO - mozversion platform_buildid: 20170329004027 02:29:16 INFO - mozversion platform_changeset: 93a70cd28ef91670a90a21c9553541c8d98d7027 02:29:16 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:29:16 INFO - mozversion platform_version: 54.0a2 02:29:16 INFO - using testdate: 1490779756 02:29:16 INFO - actual date: 1490779756 02:29:16 INFO - starting webserver on 'localhost:49241' 02:29:16 INFO - SUITE-START | Running 2 tests 02:29:16 INFO - TEST-START | dromaeo_css 02:29:16 INFO - operating with platform_type : mac_ 02:29:16 INFO - Initialising browser for dromaeo_css test... 02:29:16 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/tmpC92JtC/profile http://localhost:49241/getInfo.html) 02:29:19 INFO - PROCESS | 1634 | __metrics Screen width/height:1600/1200 02:29:19 INFO - PROCESS | 1634 | colorDepth:24 02:29:19 INFO - PROCESS | 1634 | Browser inner width/height: 1024/689 02:29:19 INFO - PROCESS | 1634 | __metrics 02:29:19 INFO - PROCESS | 1634 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:29:19 INFO - PROCESS | 1634 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:29:19 INFO - TEST-INFO | 1634: exit 0 02:29:19 INFO - Browser initialized. 02:29:19 INFO - Running cycle 1/1 for dromaeo_css test... 02:29:19 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/tmpC92JtC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:29:32 INFO - PROCESS | 1637 | RSS: Main: 214953984 02:29:32 INFO - PROCESS | 1637 | 02:32:35 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 02:32:37 INFO - PROCESS | 1637 | RSS: Main: 351862784 02:32:37 INFO - PROCESS | 1637 | 02:34:22 INFO - PROCESS | 1637 | ************************* 02:34:22 INFO - PROCESS | 1637 | A coding exception was thrown and uncaught in a Task. 02:34:22 INFO - PROCESS | 1637 | 02:34:22 ERROR - PROCESS | 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:34:22 INFO - PROCESS | 1637 | Full stack: 02:34:22 INFO - PROCESS | 1637 | ************************* 02:35:41 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 02:35:41 INFO - PROCESS | 1637 | RSS: Main: 351596544 02:35:41 INFO - PROCESS | 1637 | 02:38:44 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 02:38:45 INFO - PROCESS | 1637 | RSS: Main: 347140096 02:38:45 INFO - PROCESS | 1637 | 02:41:47 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 02:41:48 INFO - PROCESS | 1637 | RSS: Main: 315916288 02:41:48 INFO - PROCESS | 1637 | 02:44:51 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 02:44:52 INFO - PROCESS | 1637 | RSS: Main: 322650112 02:44:52 INFO - PROCESS | 1637 | 02:47:55 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 02:47:55 INFO - PROCESS | 1637 | RSS: Main: 459919360 02:47:55 INFO - PROCESS | 1637 | 02:47:55 INFO - PROCESS | 1637 | __start_tp_report 02:47:55 INFO - PROCESS | 1637 | _x_x_mozilla_page_load 02:47:55 INFO - PROCESS | 1637 | _x_x_mozilla_page_load_details 02:47:55 INFO - PROCESS | 1637 | |i|pagename|runs| 02:47:55 INFO - PROCESS | 1637 | |0;dojo.html;3371.561696979393;3379.831008449578;3383.4924761285806;3387.728981681466;3427.7257819374436;5983.461488466037;5994.520438364926;5997.580169388145;5998.580099393044;6022.518198544111;5961.731722072506;5985.670788106663;6008.939910600892;6029.155918171448;6035.215421995134;5373.489518495737;5382.273393091941;5402.567794576444;5410.513053825155;5514.393416724157;5307.416184219733;5325.227841962913;5368.677879327252;5476.644018138828;5551.444855514456;5398.8920221595745;5417.566594672417;5439.184122381635;5473.8357849264585;5505.366882808488;5446.074167391553;5446.863828404302;5473.06957817172;5473.987312347229;5476.7535460904155;5221.425643179247;5400.189971504266;5401.621886467949;5402.864928376783;5423.5932305076885;5846.824595262149;5852.12218167274;5900.468957793776;5953.3451320354725;6030.819075427744;6346.333634968308;6396;6405.5836370636225;6405.8398540036405;6411.67941602918;6364.968175159141;6450.903236451457;6456.612603243773;6464.224293084813;6479.1901012373455;5857.062869940789;5986.2517185351835;6115.266168059817;6122.234720659918;6141.355157708376;6392.105105285264;6413.230412350548;6454.580452270588;6502.414782669583;6518.315576864456;6377.330380310001;6398.200224971879;6398.456131228804;6408.423241908251;6424.775132870327;6352.110704501373;6407.519436042316;6448.419642232127;6456.22525296958;6473.805785826433;6215.160953271251;6270.529710271748;6367.713452894631;6374.107624932513;6391.3289104643345;6365.681715914186;6388.488920886318;6396.584222025554;6446.774362897276;6447.323031081669;4873.926891096637;5167.948320516747;5178.456262092502;5180.48195180479;5186.455422180617;4491.977540112279;4524.773761311922;4545.204589196944;4588.564086411786;4613.561711637389;5809.651420914759;5831.504322132666;5836.88326233473;5839.240898683229;5862.912056319158;6334.809955701337;6339.429451349401;6373.776917807854;6374.808755737336;6460.353964603596;5015.774290156952;6007.579469437097;6024;6028.09578563219;6056.970315046453;5637.351704553947;5664.0937450007805;5673.375928647845;5692.82921512347;5700.885982280414;6337.936620633919;6385;6444.420002199825;6614.70233839488;6626.370494802986;5402.135658294654;6388.776392826228;6418.967905160444;6424.068510065921;6430.131932189094;6505.934940650723;6567;6571.310012448624;6572.047053177167;6582.670866456754;6183.938160618336;6385.10608514799;6401.583897046677;6404.455621272244;6408.4232419080645;5762.827115186551;6180.042093475518;6236.6258024518675;6314.179156709783;6359.491240700825;6147.047207682816;6286.402791734778;6305.337939516285;6324.367563243823;6325.430711236011;6003.0695242237525;6319.557630965788;6319.905201422074;6350.777722779865;6351.110844481868;6037.879242415215;6063.575549711654;6090.665013424305;6091.390860913873;6093.542984276286;6196.287426945959;6294.716737746904;6323.241211054519;6377.904331434939;6382.20222472191;6244.906326405198;6245.6252624842655;6247.531435142473;6250.437460628384;6251.562390632794 02:47:55 INFO - PROCESS | 1637 | |1;ext.html;784.7175016993881;803.9196080391962;860.8794768732379;878.0780180810152;878.7978764884073;41660.583394166046;42553.57446425535;43999.560004399944;44079;44114.77942610286;42629.57370426295;42794.572054279444;42854.78572607133;42889;43017;7286.526375785584;9245.352825302214;9420.152186303232;9428.151466368026;9444;6496.870062598745;7452.925470745277;7530.736424225153;7539.811504712398;11020.559177632886;11029.83455248168;11037.227394082418;11059.50232239547;11070.723231919226;11161.7209569761;9319.25445964328;10942.945285273563;10968.890311096866;10979.945100274448;11012.449377531091;7253.202147763742;7448.702051917917;10835.079018283455;10882.564697412094;10882.891171088268;40375.7981210095;40663.593364066575;40813.38779918304;40926.795366022976;42806.357904631455;3831.5019047523924;3865.246276975991;3873.1672690371706;3874.4382064600477;3912.4522566840665;27618.309542261402;27695;27699.584506232422;29807.552886706715;29818;2988.4770165221;3078.3843231353594;3162.177833763238;3179.205198700325;3255.886043988473;350841;351092;351728.99999999744;351867;351922;43293.35059974103;43998.12003759971;53779;53903.460965389844;54058;37727.81136094302;54982.900341993736;55634;59015;59151.70424147852;15106.773398399033;15116.622084447978;15178.013429127072;15205.163715995504;15211.315490802941;12729.108962372546;12967;12967.22196668184;12968.870311296767;13020.153690010118;13050.412731427108;13074.019448541207;13114.885234755153;13168.407421666048;13237.933810330887;5521.944780552143;5569.19246709233;5590.077637189818;5592.888142237132;5600.523955463831;761.5240474703311;937.9484128373005;951.1059603972383;979.0796651147898;989.3816364772017;28658.570121448196;29174.562381564294;29510.409791804042;30003.099907002827;30132;905.9139381758722;968.6222373274429;1041.6458404142477;1084.804735147681;1099.8515200447998;15280.541583752505;15299.923500382427;15371.231438428258;15479;15662.843371566367;446717;447297;447808;448657;448876;58776.41223587795;58783.412165878646;58833.11750323749;58892.41107588955;58897.11654325188;1433.8000575079463;1439.5897169306697;1474.7198032373815;1475.8671719545507;1478.0540454109378;27362.589561156998;28222.85888570544;29062.564061539517;29072.982445614303;29148.417031659672;46774.298385524926;47138;47848.04303913972;50221.49778502168;50237.24644130414;473684;476699;477013;477072;477889;24598.13906513335;25033.87483062573;25871.870640646677;29724.959626412972;30728.231794205323;35911.11731676378;38918.4162237561;38963.02592435212;39100.6089939097;39583.60416395914;27511.449771004867;28005.299867503476;28605.427891442472;28885.85557072201;28921.710782892744;27491.17526474209;27737;27771;28692.71307286984;28748.137555873356;32212;32860.849870254424;32978.67021329756;35232.64767352396;35826.492145549564;28876.566851497664;29129.417411652073;29494;29730.405391892473;30051;22491.550168996855;22498.27535721162;23256.95343709503;23811.285661430185;23850.761492384852 02:47:55 INFO - PROCESS | 1637 | |2;jquery.html;385.1776457263741;393.5297319702956;416.4232537934959;425.2175996167052;453.34718006071273;13012.219266843984;14807.62980925476;20821.583568328624;21330;21440.24959126431;21816.89091554544;22060;22415.439614009658;22690.319290421274;22775.316740497812;6655.134832471784;7174.8206294842785;7509.535640550095;7688.5771282579435;7693.538387696756;6300.464460520861;7655.732049378273;7673.769786906401;7722.961385193094;7735.883961740578;7184.892226616605;7757.030371203599;7757.456978011542;7763.184865589088;7779.649915753805;6396.424321811036;7620.047494063242;7622.771316860503;7622.923770762277;7631.580263085528;6849.212340580847;7242.963785181093;7397.445191610651;7401.555906645618;7406.518576292578;25360.873195633903;25378.365540861443;25788;26055.348616284555;26076;2847.957280640792;2884.7115288470986;2966.332575170591;3018;3094.5048792193365;14976.251187440694;15454.690906181813;15482.5355239343;15608.687826243411;16036.679266414723;1880.8683392162554;1886.9716954245698;1939.0789375046882;1942.7280180774703;1996.6605677034938;157342.21328893283;157950;160764;164457;166687;19581.314653987043;20158.798412015985;20335.79664203339;20352.49118772013;20540.589188216152;26965.730342696323;32028.199295017344;32652.510212346835;32657;32773.67226327706;10097.495125243708;10168.542415591317;10380.636677716244;10408.47957602117;10496.422696751599;8553.272971797342;8566.91433085661;8586.656533738706;8660.30717542595;8675.089115642893;9244.399114057565;9389.671361502315;9439.622415103318;9545.952270238604;9569;3428.5371474850576;3851.345271303885;3908.4918960534947;3941.2905676977844;3943;865.6926790989235;978.7161723100363;1038.2939601071344;1066.072516910293;1081.983770243447;20268;20976.26583069585;21030.684539731916;21387.67918481224;21597.385141134106;967.9467629280457;1052.8052310322614;1073.270176280137;1092.5520536579963;1114.9108071354271;10154.593816247267;11198;11201.943990279997;11233.269837460539;11240.988311052044;757375;757478;775292;787744;795653;123479.3826030882;139467.90798138035;140602.67287972066;162282.18858905867;165230;1185.4843143232722;1190.8809119088196;1222;1225.2954551133134;1229.520487010049;17645.470635880945;18823.811761882753;18849.71725424147;18880.52798680044;18931.810681893006;48896.555172241955;58810.823783523236;62543.374566255574;62837;63764.68117659382;58349.4165058344;86285.56857215674;88631.67052494088;88761;89285.10714892768;10992.890071099187;11688.831116888243;12015.45930433115;12091.818622720843;12097.637070887888;12951.935240324116;13007.869921300666;13044.239027731515;13338.466461341826;13342.799858002332;11034.668959931216;11210.607628732956;11410.657680269605;11665.650030499099;11669.649910502698;8726.65093396257;10504.159667226757;10555.577776889146;10824.458777061272;10828.729281768019;11447.484863181011;11772.70568235801;11782.764344713229;11878;11903.82144267854;10178.694639160836;11687.94808467208;11910.344931028876;11978.64064078079;12018.098642602015;11252.156088293246;11324.094072474347;11414.429278536207;11468;11657.708557286136 02:47:55 INFO - PROCESS | 1637 | |3;mootools.html;1357.647011776938;1533.4249656378859;1534.2558858953412;1560.4538411555957;1591.9761203581945;10537.894621053787;11096;11099.278546894466;11103.944480277598;11171.441427928612;10671.306365086284;11031.72420689483;11203.159763017766;11214.943925280362;11229.382383968878;2382.7498112698136;2422.1159276863996;2424.442378252994;2425.320910145162;2426.38127277544;2339.543788961153;2408.397900524869;2441;2442.4992876460374;2442.9755702443013;2342.390978345625;2404.471016376403;2414.9275521734376;2433.1362366359954;2437.731849496554;2319.6404557293645;2391.7727815857465;2392.9042838286446;2395.0180426025245;2410.927672169838;2375.904963801446;2394.7485514021128;2400.0279886645935;2401.243608263409;2403.65147053678;10866.293690910145;11117.944410277978;11138.997490225918;11150.49822757978;11153.665390038312;5725;5891.79378721747;5894.911576326359;5895.793647222326;5909.9953007988315;3525.5593050868642;3668.137987572918;3700.703943684499;3750.8499660013567;3755.380362240227;1195.6233786357357;1209.1898428053225;1215.2161855603174;1249.3440943504643;1262.3246563088794;13805.102668326526;14156.504522341771;14407.567772966828;15430.845691543165;15638.13990230537;4570.405847239837;4748.287756836502;4760.738159401266;4762.571368576775;4766.404199475066;10176.643817466502;11311.886881131248;11326;11330.60342887995;11354.943225283821;4928.6303527235605;5788.334341550775;5998.670073145931;6038.818835434856;6060.121282414113;5161.509656582619;5305.230741542532;5347.438518955531;5392.91910621341;5412.188171774265;4017.4777278953547;4024.7786371749835;4096.283150448659;4124.876253712393;4126.628603425646;1113.1206346985791;1118.3792994887754;1118.5246270335076;1136.5567428702811;1139.0773473486502;916.1800188830958;928.8792456980684;937.5218638494281;952.3809523809579;989.9950500247453;6562.212534495891;6568.8357791055605;6678.966605166943;6804.795856124324;6822.420094292041;946.7739277635478;984.17329443268;986.9753256168653;1008.193445243802;1042.890496497872;3757.5866654667966;4056.9797151014054;4063.187362527506;4391.494978077498;4472.08322293929;13064.934675326753;13644.93177534106;13645.863541364459;13687.863121368859;13842.100263482842;12019.579314723942;12787.360631968364;12961.935190324177;13543.255120968244;13557.389917453542;9957.950210248902;10214.285000049926;10233.385996840214;10243.84634230487;10253.74365640865;6383.808485745435;6746;6787.117674702455;6927.411170050602;6966.407855332353;10999;12002.699932501757;12219.877801221874;12582.119251652297;12603.873961260637;11774.52901883915;11808.822867657163;12251.754964900474;12264.202826816228;12534.310612916377;9115;9307.674231401868;9311.76720581991;9953.900460995297;10351.792964140826;10253.33353332031;10275.229357798045;10608.416537090534;10608.469576521298;10609.628662996758;8598.527081010605;8631.223189912938;8752.737417877473;8882.600282987152;8956.328275379243;8462.449940753831;8530.872036919327;8554.443961142506;8577.82844343122;8692.478451292942;7856.25365590268;7993.600319984093;8006.879896801436;8010.759677209693;8013.118556958846;4965.882676397781;5013.949860501494;5759.769609215752;5993.820185394445;6095.994160963392;5266.447023062523;5955.583109182316;5990.31111422192;6024.0662697282;6159.23009623797 02:47:55 INFO - PROCESS | 1637 | |4;prototype.html;374.2925870105501;378.1133242546228;378.20388083085106;387.27579426472516;389.16329890734914;4330.653547716183;4359.978200108999;4461.709988850731;4562.56279272029;4765.023170250095;4143.73065750726;4646.047560250149;4715.915339471923;4817.22924332107;4992.850214493562;3794.146317078663;3868.729188956774;4140.50313962325;4154.6676265898805;4165.146145040259;3703.925861500162;3906.8046597670145;3999.960000399988;4135.139187365682;4181.728187667807;3874.651281384675;4022.2558826617023;4132.958670413287;4222.057853387446;4231.724937879043;3619.529461170044;4081.6938429787074;4136.9864383226;4173.353130264783;4198.391233271189;3805.296020236265;3814.8474061037805;3818.7851046393025;3827.110531548663;3840.635139661728;3969.503812023497;4140.565240649748;4856.587190088847;4883.682560633583;4935.925961110586;3906.7069969752383;4481.795516205929;4531.864044078683;4839.3466881970835;4842.481909407089;4679;4968.428630707443;5130.486506480597;5361.5978801589645;5408;4336.3278691802825;4339.7830108494445;4365.275716092126;4378.474583050022;4393.319035549495;4843.9031219375765;5024.673396229234;5314.591633217201;5678.5741069419955;5742.540596752292;3942.7580312201567;4096.569860164699;4140.799168241237;4366.257736184856;4385.627221686129;4065.79671016448;4365.869023929287;4390.62679672225;4420.889477763018;4520.32195170727;3964.2269757397607;4745.952540474551;4781.593564546983;4796.904061918812;4858.3441235432765;4542.432195975503;5043.470435604282;5140.254663073833;5254.238135470412;5363.731813409314;1395.406952045397;1428.2929949674976;1433.6200906759716;1501.14434772181;1528.5631506383963;923.2244914272044;1095.70963694621;1140.4981808004618;1144.8339990701302;1146.2893006335958;4342.392065110887;4600.53994600544;4799.0641824844515;4973.129702302155;4980.526849949249;4966.701997880066;5014.949850501448;5453.972730136324;5476.561875049986;5548.69482178484;4352.477702675636;4419.348390965395;4482.910341793146;4549.977250113794;4824.611817150463;2348.5302939411845;2522.8681763909467;2728.3315587681145;2754.2701184186208;2867.9818664373847;4893.84994526286;5739.827805165852;5750.884982300414;5767.279090113736;5802.33273173582;4619.597809139229;4780.521947805261;5216.40011398694;5434.281664874341;5536.501714845684;4896.3389942358035;4969.751512424365;5049.192129259301;5754.539636829044;5777.422257774189;5062.797488100435;5419.674819510842;5517.751701173376;5552.944470555404;5589;4474.127545128668;4759.428868535798;5400.378956419905;5444.727763611882;5470.617056805985;5028.472010438997;5219.217117432416;5648.491635752802;5695.487406133468;5753.453421924911;3756.9248615027;3886.2616102941483;4292.098659281586;4320.654347652243;4326.459192600925;4834.540718631724;5450.836474905759;5556.916646250229;5563.527100196528;5605.32736071674;4764.595009424099;5430.67415955044;5433.821214589351;5453.864028183731;5465.836024919259;4776.379070720784;5148.3564554430695;5350.892982140414;5374.892502149857;5375.973120134374;5158.174692049254;5176.327077479904;5215.556677682288;5228.660137091229;5245.239440281214;4243.6605071593585;5182.870428239325;5352.0366334060245;5373.328333958255;5438;4537.977310113428;4824.480288709045;5126.948730512796;5133.589312855037;5141.100307446257 02:47:55 INFO - PROCESS | 1637 | |5;yui.html;706.2372637551445;729.6133049483774;754.6302311867183;762.9580373079482;814.4095530740213;14937.477188298426;15012.324445399956;15746.763798543017;15971.84028159721;16135.43525976591;14105;14110.294485275746;14616.342264598092;14805.925970370134;14837;940.4921342475055;965.1940629574314;965.6620182935986;967.3567077893192;969.190725744001;939.6006697153716;956.8325543029977;961.9470929098896;977.008336538414;978.6770365779312;1022.6829682798357;1025.446259020132;1025.4975062219496;1025.6205204074465;1026.399556259589;1018.6434747838272;1019.1133713669118;1019.7042857571332;1020.637673625867;1022.468316475436;756.2437562437563;757.7044952468542;758.6699785593285;758.7078974594766;759.3204082346324;15277.923610381988;15643;15674.98112622676;15847.683046339123;16081.11553864537;11838.763224735543;13865.55039622966;13920.373583188679;14109.294535273195;14352.354144063542;10283.845742313872;11666.766664666744;11711.355875426849;11782.469788859522;11884.881151188463;3414.6926776590226;3604.819759012039;3610.4223324268255;3746.2320224353944;3799.5820459749407;84326.57836710777;86485.56757216237;111621;112238;113132;10610.457917727275;10860.565577376974;10982.609953270725;11049.889501105046;11183.44082795857;21591.78408215929;22008.339749807532;22127;22190.556188876133;22215.222467213895;7723.95726576905;7782.533048017137;7841.529508229524;8007.239312265326;8073.273405393543;4147.834086636561;4178.8537401190815;4243.6605071594195;4327.8485253016;4363.650907927358;2932.7535797286496;3268.836558172082;3428;3435.9656403435647;3437.74216933731;610.4444955090846;621.3631028196045;631.4474834519796;637.7640273098983;644.713102669317;629.3329071184559;639.3159319528061;639.5235549515547;642.5181114164377;663.5056882622478;9147.131022552847;9831.71739648733;9965.750856228653;9976.201903847676;10887.727806804893;546.350022930747;555.6332820338557;580.4862696513616;636.5480508838776;707.7063018847224;4685.4143232095985;4977;5080.237964305384;5080.314157588752;5102.515261050195;80577;84757.57621211854;90512.09487905168;92582;98032;48101.51898480971;62486;77740.445191097;78626.42747145025;82111.58944205241;56803.14795277992;70273.24316892118;71615.92576111363;73385.63307183537;74721.25278747252;10758.246922715647;10805.405702686114;10909.560389904042;11093.556257749922;11150.498227579941;45808.77095614634;46088.8477788058;46826.76586617045;47141.52858471371;47497;57622;57976.130358045506;58162.709186453794;58172;58441;12217.266963982189;12227.572034978733;12432.937835310766;12471.314077725812;12512.0615953802;14046.648833779238;14200.644983875485;14295.499657511937;14451.638709032359;14499.78250326267;12965.67850348765;13008.284544350152;13172.670683232996;13379;13399.732005359643;12571.776665967684;13281.734365312834;13331.66670833237;13375.264360460269;13748.381322840696;12157.27056376585;12924.676883077622;12967;13371.53199638008;13386.26375549354;8842.381033327605;9203.861942071007;9254.167124958785;9448.716538503855;9460.858087128836;10044.196464282986;10308.793824123626;11189.384583847966;11199.776004479701;11221 02:47:55 INFO - PROCESS | 1637 | __end_tp_report 02:47:55 INFO - PROCESS | 1637 | __start_cc_report 02:47:55 INFO - PROCESS | 1637 | _x_x_mozilla_cycle_collect,2066 02:47:55 INFO - PROCESS | 1637 | __end_cc_report 02:47:55 INFO - PROCESS | 1637 | __startTimestamp1490780875813__endTimestamp 02:47:55 INFO - PROCESS | 1637 | 02:47:55 INFO - PROCESS | 1637 | ------- Summary: start ------- 02:47:55 INFO - PROCESS | 1637 | Number of tests: 6 02:47:55 INFO - PROCESS | 1637 | 02:47:55 INFO - PROCESS | 1637 | [#0] dojo.html Cycles:165 Average:5929.13 Median:6141.36 stddev:659.09 (10.7%) stddev-sans-first:629.83 02:47:55 INFO - PROCESS | 1637 | Values: 3371.6 3379.8 3383.5 3387.7 3427.7 5983.5 5994.5 5997.6 5998.6 6022.5 5961.7 5985.7 6008.9 6029.2 6035.2 5373.5 5382.3 5402.6 5410.5 5514.4 5307.4 5325.2 5368.7 5476.6 5551.4 5398.9 5417.6 5439.2 5473.8 5505.4 5446.1 5446.9 5473.1 5474.0 5476.8 5221.4 5400.2 5401.6 5402.9 5423.6 5846.8 5852.1 5900.5 5953.3 6030.8 6346.3 6396.0 6405.6 6405.8 6411.7 6365.0 6450.9 6456.6 6464.2 6479.2 5857.1 5986.3 6115.3 6122.2 6141.4 6392.1 6413.2 6454.6 6502.4 6518.3 6377.3 6398.2 6398.5 6408.4 6424.8 6352.1 6407.5 6448.4 6456.2 6473.8 6215.2 6270.5 6367.7 6374.1 6391.3 6365.7 6388.5 6396.6 6446.8 6447.3 4873.9 5167.9 5178.5 5180.5 5186.5 4492.0 4524.8 4545.2 4588.6 4613.6 5809.7 5831.5 5836.9 5839.2 5862.9 6334.8 6339.4 6373.8 6374.8 6460.4 5015.8 6007.6 6024.0 6028.1 6057.0 5637.4 5664.1 5673.4 5692.8 5700.9 6337.9 6385.0 6444.4 6614.7 6626.4 5402.1 6388.8 6419.0 6424.1 6430.1 6505.9 6567.0 6571.3 6572.0 6582.7 6183.9 6385.1 6401.6 6404.5 6408.4 5762.8 6180.0 6236.6 6314.2 6359.5 6147.0 6286.4 6305.3 6324.4 6325.4 6003.1 6319.6 6319.9 6350.8 6351.1 6037.9 6063.6 6090.7 6091.4 6093.5 6196.3 6294.7 6323.2 6377.9 6382.2 6244.9 6245.6 6247.5 6250.4 6251.6 02:47:55 INFO - PROCESS | 1637 | 02:47:55 INFO - PROCESS | 1637 | [#1] ext.html Cycles:180 Average:56397.00 Median:351410.50 stddev:113785.09 (32.4%) stddev-sans-first:114027.68 02:47:55 INFO - PROCESS | 1637 | Values: 784.7 803.9 860.9 878.1 878.8 41660.6 42553.6 43999.6 44079.0 44114.8 42629.6 42794.6 42854.8 42889.0 43017.0 7286.5 9245.4 9420.2 9428.2 9444.0 6496.9 7452.9 7530.7 7539.8 11020.6 11029.8 11037.2 11059.5 11070.7 11161.7 9319.3 10942.9 10968.9 10979.9 11012.4 7253.2 7448.7 10835.1 10882.6 10882.9 40375.8 40663.6 40813.4 40926.8 42806.4 3831.5 3865.2 3873.2 3874.4 3912.5 27618.3 27695.0 27699.6 29807.6 29818.0 2988.5 3078.4 3162.2 3179.2 3255.9 350841.0 351092.0 351729.0 351867.0 351922.0 43293.4 43998.1 53779.0 53903.5 54058.0 37727.8 54982.9 55634.0 59015.0 59151.7 15106.8 15116.6 15178.0 15205.2 15211.3 12729.1 12967.0 12967.2 12968.9 13020.2 13050.4 13074.0 13114.9 13168.4 13237.9 5521.9 5569.2 5590.1 5592.9 5600.5 761.5 937.9 951.1 979.1 989.4 28658.6 29174.6 29510.4 30003.1 30132.0 905.9 968.6 1041.6 1084.8 1099.9 15280.5 15299.9 15371.2 15479.0 15662.8 446717.0 447297.0 447808.0 448657.0 448876.0 58776.4 58783.4 58833.1 58892.4 58897.1 1433.8 1439.6 1474.7 1475.9 1478.1 27362.6 28222.9 29062.6 29073.0 29148.4 46774.3 47138.0 47848.0 50221.5 50237.2 473684.0 476699.0 477013.0 477072.0 477889.0 24598.1 25033.9 25871.9 29725.0 30728.2 35911.1 38918.4 38963.0 39100.6 39583.6 27511.4 28005.3 28605.4 28885.9 28921.7 27491.2 27737.0 27771.0 28692.7 28748.1 32212.0 32860.8 32978.7 35232.6 35826.5 28876.6 29129.4 29494.0 29730.4 30051.0 22491.6 22498.3 23257.0 23811.3 23850.8 02:47:55 INFO - PROCESS | 1637 | 02:47:55 INFO - PROCESS | 1637 | [#2] jquery.html Cycles:180 Average:43536.20 Median:21003.48 stddev:129019.88 (614.3%) stddev-sans-first:129341.13 02:47:55 INFO - PROCESS | 1637 | Values: 385.2 393.5 416.4 425.2 453.3 13012.2 14807.6 20821.6 21330.0 21440.2 21816.9 22060.0 22415.4 22690.3 22775.3 6655.1 7174.8 7509.5 7688.6 7693.5 6300.5 7655.7 7673.8 7723.0 7735.9 7184.9 7757.0 7757.5 7763.2 7779.6 6396.4 7620.0 7622.8 7622.9 7631.6 6849.2 7243.0 7397.4 7401.6 7406.5 25360.9 25378.4 25788.0 26055.3 26076.0 2848.0 2884.7 2966.3 3018.0 3094.5 14976.3 15454.7 15482.5 15608.7 16036.7 1880.9 1887.0 1939.1 1942.7 1996.7 157342.2 157950.0 160764.0 164457.0 166687.0 19581.3 20158.8 20335.8 20352.5 20540.6 26965.7 32028.2 32652.5 32657.0 32773.7 10097.5 10168.5 10380.6 10408.5 10496.4 8553.3 8566.9 8586.7 8660.3 8675.1 9244.4 9389.7 9439.6 9546.0 9569.0 3428.5 3851.3 3908.5 3941.3 3943.0 865.7 978.7 1038.3 1066.1 1082.0 20268.0 20976.3 21030.7 21387.7 21597.4 967.9 1052.8 1073.3 1092.6 1114.9 10154.6 11198.0 11201.9 11233.3 11241.0 757375.0 757478.0 775292.0 787744.0 795653.0 123479.4 139467.9 140602.7 162282.2 165230.0 1185.5 1190.9 1222.0 1225.3 1229.5 17645.5 18823.8 18849.7 18880.5 18931.8 48896.6 58810.8 62543.4 62837.0 63764.7 58349.4 86285.6 88631.7 88761.0 89285.1 10992.9 11688.8 12015.5 12091.8 12097.6 12951.9 13007.9 13044.2 13338.5 13342.8 11034.7 11210.6 11410.7 11665.7 11669.6 8726.7 10504.2 10555.6 10824.5 10828.7 11447.5 11772.7 11782.8 11878.0 11903.8 10178.7 11687.9 11910.3 11978.6 12018.1 11252.2 11324.1 11414.4 11468.0 11657.7 02:47:55 INFO - PROCESS | 1637 | 02:47:55 INFO - PROCESS | 1637 | [#3] mootools.html Cycles:180 Average:6710.04 Median:2425.85 stddev:4126.58 (170.1%) stddev-sans-first:4118.55 02:47:55 INFO - PROCESS | 1637 | Values: 1357.6 1533.4 1534.3 1560.5 1592.0 10537.9 11096.0 11099.3 11103.9 11171.4 10671.3 11031.7 11203.2 11214.9 11229.4 2382.7 2422.1 2424.4 2425.3 2426.4 2339.5 2408.4 2441.0 2442.5 2443.0 2342.4 2404.5 2414.9 2433.1 2437.7 2319.6 2391.8 2392.9 2395.0 2410.9 2375.9 2394.7 2400.0 2401.2 2403.7 10866.3 11117.9 11139.0 11150.5 11153.7 5725.0 5891.8 5894.9 5895.8 5910.0 3525.6 3668.1 3700.7 3750.8 3755.4 1195.6 1209.2 1215.2 1249.3 1262.3 13805.1 14156.5 14407.6 15430.8 15638.1 4570.4 4748.3 4760.7 4762.6 4766.4 10176.6 11311.9 11326.0 11330.6 11354.9 4928.6 5788.3 5998.7 6038.8 6060.1 5161.5 5305.2 5347.4 5392.9 5412.2 4017.5 4024.8 4096.3 4124.9 4126.6 1113.1 1118.4 1118.5 1136.6 1139.1 916.2 928.9 937.5 952.4 990.0 6562.2 6568.8 6679.0 6804.8 6822.4 946.8 984.2 987.0 1008.2 1042.9 3757.6 4057.0 4063.2 4391.5 4472.1 13064.9 13644.9 13645.9 13687.9 13842.1 12019.6 12787.4 12961.9 13543.3 13557.4 9958.0 10214.3 10233.4 10243.8 10253.7 6383.8 6746.0 6787.1 6927.4 6966.4 10999.0 12002.7 12219.9 12582.1 12603.9 11774.5 11808.8 12251.8 12264.2 12534.3 9115.0 9307.7 9311.8 9953.9 10351.8 10253.3 10275.2 10608.4 10608.5 10609.6 8598.5 8631.2 8752.7 8882.6 8956.3 8462.4 8530.9 8554.4 8577.8 8692.5 7856.3 7993.6 8006.9 8010.8 8013.1 4965.9 5013.9 5759.8 5993.8 6096.0 5266.4 5955.6 5990.3 6024.1 6159.2 02:47:55 INFO - PROCESS | 1637 | 02:47:55 INFO - PROCESS | 1637 | [#4] prototype.html Cycles:180 Average:4407.84 Median:4762.01 stddev:1233.65 (25.9%) stddev-sans-first:1199.38 02:47:55 INFO - PROCESS | 1637 | Values: 374.3 378.1 378.2 387.3 389.2 4330.7 4360.0 4461.7 4562.6 4765.0 4143.7 4646.0 4715.9 4817.2 4992.9 3794.1 3868.7 4140.5 4154.7 4165.1 3703.9 3906.8 4000.0 4135.1 4181.7 3874.7 4022.3 4133.0 4222.1 4231.7 3619.5 4081.7 4137.0 4173.4 4198.4 3805.3 3814.8 3818.8 3827.1 3840.6 3969.5 4140.6 4856.6 4883.7 4935.9 3906.7 4481.8 4531.9 4839.3 4842.5 4679.0 4968.4 5130.5 5361.6 5408.0 4336.3 4339.8 4365.3 4378.5 4393.3 4843.9 5024.7 5314.6 5678.6 5742.5 3942.8 4096.6 4140.8 4366.3 4385.6 4065.8 4365.9 4390.6 4420.9 4520.3 3964.2 4746.0 4781.6 4796.9 4858.3 4542.4 5043.5 5140.3 5254.2 5363.7 1395.4 1428.3 1433.6 1501.1 1528.6 923.2 1095.7 1140.5 1144.8 1146.3 4342.4 4600.5 4799.1 4973.1 4980.5 4966.7 5014.9 5454.0 5476.6 5548.7 4352.5 4419.3 4482.9 4550.0 4824.6 2348.5 2522.9 2728.3 2754.3 2868.0 4893.8 5739.8 5750.9 5767.3 5802.3 4619.6 4780.5 5216.4 5434.3 5536.5 4896.3 4969.8 5049.2 5754.5 5777.4 5062.8 5419.7 5517.8 5552.9 5589.0 4474.1 4759.4 5400.4 5444.7 5470.6 5028.5 5219.2 5648.5 5695.5 5753.5 3756.9 3886.3 4292.1 4320.7 4326.5 4834.5 5450.8 5556.9 5563.5 5605.3 4764.6 5430.7 5433.8 5453.9 5465.8 4776.4 5148.4 5350.9 5374.9 5376.0 5158.2 5176.3 5215.6 5228.7 5245.2 4243.7 5182.9 5352.0 5373.3 5438.0 4538.0 4824.5 5126.9 5133.6 5141.1 02:47:55 INFO - PROCESS | 1637 | 02:47:55 INFO - PROCESS | 1637 | [#5] yui.html Cycles:180 Average:18806.04 Median:3607.62 stddev:26033.73 (721.6%) stddev-sans-first:26071.29 02:47:55 INFO - PROCESS | 1637 | Values: 706.2 729.6 754.6 763.0 814.4 14937.5 15012.3 15746.8 15971.8 16135.4 14105.0 14110.3 14616.3 14805.9 14837.0 940.5 965.2 965.7 967.4 969.2 939.6 956.8 961.9 977.0 978.7 1022.7 1025.4 1025.5 1025.6 1026.4 1018.6 1019.1 1019.7 1020.6 1022.5 756.2 757.7 758.7 758.7 759.3 15277.9 15643.0 15675.0 15847.7 16081.1 11838.8 13865.6 13920.4 14109.3 14352.4 10283.8 11666.8 11711.4 11782.5 11884.9 3414.7 3604.8 3610.4 3746.2 3799.6 84326.6 86485.6 111621.0 112238.0 113132.0 10610.5 10860.6 10982.6 11049.9 11183.4 21591.8 22008.3 22127.0 22190.6 22215.2 7724.0 7782.5 7841.5 8007.2 8073.3 4147.8 4178.9 4243.7 4327.8 4363.7 2932.8 3268.8 3428.0 3436.0 3437.7 610.4 621.4 631.4 637.8 644.7 629.3 639.3 639.5 642.5 663.5 9147.1 9831.7 9965.8 9976.2 10887.7 546.4 555.6 580.5 636.5 707.7 4685.4 4977.0 5080.2 5080.3 5102.5 80577.0 84757.6 90512.1 92582.0 98032.0 48101.5 62486.0 77740.4 78626.4 82111.6 56803.1 70273.2 71615.9 73385.6 74721.3 10758.2 10805.4 10909.6 11093.6 11150.5 45808.8 46088.8 46826.8 47141.5 47497.0 57622.0 57976.1 58162.7 58172.0 58441.0 12217.3 12227.6 12432.9 12471.3 12512.1 14046.6 14200.6 14295.5 14451.6 14499.8 12965.7 13008.3 13172.7 13379.0 13399.7 12571.8 13281.7 13331.7 13375.3 13748.4 12157.3 12924.7 12967.0 13371.5 13386.3 8842.4 9203.9 9254.2 9448.7 9460.9 10044.2 10308.8 11189.4 11199.8 11221.0 02:47:55 INFO - PROCESS | 1637 | -------- Summary: end -------- 02:47:55 INFO - PROCESS | 1637 | 02:47:56 INFO - TEST-INFO | 1637: exit 0 02:47:56 INFO - TEST-OK | dromaeo_css | took 1120178ms 02:47:56 INFO - TEST-START | kraken 02:47:56 INFO - operating with platform_type : mac_ 02:47:56 INFO - Initialising browser for kraken test... 02:47:56 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/tmp8HLA36/profile http://localhost:49241/getInfo.html) 02:47:58 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 02:47:58 INFO - PROCESS | 1648 | colorDepth:24 02:47:58 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 02:47:58 INFO - PROCESS | 1648 | __metrics 02:47:58 INFO - PROCESS | 1648 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:47:58 INFO - PROCESS | 1648 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:47:59 INFO - TEST-INFO | 1648: exit 0 02:47:59 INFO - Browser initialized. 02:47:59 INFO - Running cycle 1/1 for kraken test... 02:47:59 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/tmp8HLA36/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:48:11 INFO - PROCESS | 1650 | RSS: Main: 214548480 02:48:11 INFO - PROCESS | 1650 | 02:48:14 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 02:48:15 INFO - PROCESS | 1650 | RSS: Main: 267329536 02:48:15 INFO - PROCESS | 1650 | 02:48:18 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 02:48:18 INFO - PROCESS | 1650 | RSS: Main: 278863872 02:48:18 INFO - PROCESS | 1650 | 02:48:21 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 02:48:22 INFO - PROCESS | 1650 | RSS: Main: 376090624 02:48:22 INFO - PROCESS | 1650 | 02:48:24 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 02:48:25 INFO - PROCESS | 1650 | RSS: Main: 277520384 02:48:25 INFO - PROCESS | 1650 | 02:48:27 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:48:27 INFO - PROCESS | 1650 | RSS: Main: 278835200 02:48:27 INFO - PROCESS | 1650 | 02:48:30 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 02:48:31 INFO - PROCESS | 1650 | RSS: Main: 320483328 02:48:31 INFO - PROCESS | 1650 | 02:48:34 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 02:48:34 INFO - PROCESS | 1650 | RSS: Main: 320024576 02:48:34 INFO - PROCESS | 1650 | 02:48:37 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 02:48:38 INFO - PROCESS | 1650 | RSS: Main: 318402560 02:48:38 INFO - PROCESS | 1650 | 02:48:40 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:48:40 INFO - PROCESS | 1650 | RSS: Main: 294825984 02:48:40 INFO - PROCESS | 1650 | 02:48:42 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:48:43 INFO - PROCESS | 1650 | RSS: Main: 297979904 02:48:43 INFO - PROCESS | 1650 | 02:48:45 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:48:46 INFO - PROCESS | 1650 | RSS: Main: 304861184 02:48:46 INFO - PROCESS | 1650 | 02:48:49 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:48:50 INFO - PROCESS | 1650 | RSS: Main: 318582784 02:48:50 INFO - PROCESS | 1650 | 02:48:53 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:48:53 INFO - PROCESS | 1650 | RSS: Main: 312307712 02:48:53 INFO - PROCESS | 1650 | 02:48:55 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 02:48:55 INFO - PROCESS | 1650 | RSS: Main: 357183488 02:48:55 INFO - PROCESS | 1650 | 02:48:55 INFO - PROCESS | 1650 | __start_tp_report 02:48:55 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 02:48:55 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 02:48:55 INFO - PROCESS | 1650 | |i|pagename|runs| 02:48:55 INFO - PROCESS | 1650 | |0;ai-astar;117;115;116;113;115;115;115;116;115;115 02:48:55 INFO - PROCESS | 1650 | |1;audio-beat-detection;152;111;111;145;110;111;107;91;136;134 02:48:55 INFO - PROCESS | 1650 | |2;audio-dft;182;183;183;184;182;185;182;184;185;183 02:48:55 INFO - PROCESS | 1650 | |3;audio-fft;82;60;63;93;64;61;61;63;76;59 02:48:55 INFO - PROCESS | 1650 | |4;audio-oscillator;86;71;89;69;70;68;82;69;69;82 02:48:55 INFO - PROCESS | 1650 | |5;imaging-gaussian-blur;87;87;88;87;88;88;88;87;87;87 02:48:55 INFO - PROCESS | 1650 | |6;imaging-darkroom;96;95;97;99;95;95;97;99;95;95 02:48:55 INFO - PROCESS | 1650 | |7;imaging-desaturate;84;85;83;82;83;83;85;84;85;84 02:48:55 INFO - PROCESS | 1650 | |8;json-parse-financial;50;52;85;96;98;97;73;64;63;63 02:48:55 INFO - PROCESS | 1650 | |9;json-stringify-tinderbox;54;57;67;65;60;57;58;58;57;58 02:48:55 INFO - PROCESS | 1650 | |10;stanford-crypto-aes;84;85;86;86;83;98;98;94;89;84 02:48:55 INFO - PROCESS | 1650 | |11;stanford-crypto-ccm;164;145;141;142;127;139;145;147;191;166 02:48:55 INFO - PROCESS | 1650 | |12;stanford-crypto-pbkdf2;167;167;167;228;219;218;168;167;166;165 02:48:55 INFO - PROCESS | 1650 | |13;stanford-crypto-sha256-iterative;67;66;67;66;64;68;64;64;78;81 02:48:55 INFO - PROCESS | 1650 | __end_tp_report 02:48:55 INFO - PROCESS | 1650 | __start_cc_report 02:48:55 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,2173 02:48:55 INFO - PROCESS | 1650 | __end_cc_report 02:48:55 INFO - PROCESS | 1650 | __startTimestamp1490780935789__endTimestamp 02:48:55 INFO - PROCESS | 1650 | 02:48:55 INFO - PROCESS | 1650 | ------- Summary: start ------- 02:48:55 INFO - PROCESS | 1650 | Number of tests: 14 02:48:55 INFO - PROCESS | 1650 | 02:48:55 INFO - PROCESS | 1650 | [#0] ai-astar Cycles:10 Average:115.20 Median:115.00 stddev:1.03 (0.9%) stddev-sans-first:0.87 02:48:55 INFO - PROCESS | 1650 | Values: 117.0 115.0 116.0 113.0 115.0 115.0 115.0 116.0 115.0 115.0 02:48:55 INFO - PROCESS | 1650 | 02:48:55 INFO - PROCESS | 1650 | [#1] audio-beat-detection Cycles:10 Average:120.80 Median:135.00 stddev:19.57 (14.5%) stddev-sans-first:17.20 02:48:55 INFO - PROCESS | 1650 | Values: 152.0 111.0 111.0 145.0 110.0 111.0 107.0 91.0 136.0 134.0 02:48:55 INFO - PROCESS | 1650 | 02:48:55 INFO - PROCESS | 1650 | [#2] audio-dft Cycles:10 Average:183.30 Median:183.50 stddev:1.16 (0.6%) stddev-sans-first:1.13 02:48:55 INFO - PROCESS | 1650 | Values: 182.0 183.0 183.0 184.0 182.0 185.0 182.0 184.0 185.0 183.0 02:48:55 INFO - PROCESS | 1650 | 02:48:55 INFO - PROCESS | 1650 | [#3] audio-fft Cycles:10 Average:68.20 Median:63.50 stddev:11.52 (18.1%) stddev-sans-first:11.08 02:48:55 INFO - PROCESS | 1650 | Values: 82.0 60.0 63.0 93.0 64.0 61.0 61.0 63.0 76.0 59.0 02:48:55 INFO - PROCESS | 1650 | 02:48:55 INFO - PROCESS | 1650 | [#4] audio-oscillator Cycles:10 Average:75.50 Median:76.50 stddev:8.24 (10.8%) stddev-sans-first:7.81 02:48:55 INFO - PROCESS | 1650 | Values: 86.0 71.0 89.0 69.0 70.0 68.0 82.0 69.0 69.0 82.0 02:48:55 INFO - PROCESS | 1650 | 02:48:55 INFO - PROCESS | 1650 | [#5] imaging-gaussian-blur Cycles:10 Average:87.40 Median:87.50 stddev:0.52 (0.6%) stddev-sans-first:0.53 02:48:55 INFO - PROCESS | 1650 | Values: 87.0 87.0 88.0 87.0 88.0 88.0 88.0 87.0 87.0 87.0 02:48:55 INFO - PROCESS | 1650 | 02:48:55 INFO - PROCESS | 1650 | [#6] imaging-darkroom Cycles:10 Average:96.30 Median:96.50 stddev:1.64 (1.7%) stddev-sans-first:1.73 02:48:55 INFO - PROCESS | 1650 | Values: 96.0 95.0 97.0 99.0 95.0 95.0 97.0 99.0 95.0 95.0 02:48:55 INFO - PROCESS | 1650 | 02:48:55 INFO - PROCESS | 1650 | [#7] imaging-desaturate Cycles:10 Average:83.80 Median:84.00 stddev:1.03 (1.2%) stddev-sans-first:1.09 02:48:55 INFO - PROCESS | 1650 | Values: 84.0 85.0 83.0 82.0 83.0 83.0 85.0 84.0 85.0 84.0 02:48:55 INFO - PROCESS | 1650 | 02:48:55 INFO - PROCESS | 1650 | [#8] json-parse-financial Cycles:10 Average:74.10 Median:79.00 stddev:18.60 (23.5%) stddev-sans-first:17.56 02:48:55 INFO - PROCESS | 1650 | Values: 50.0 52.0 85.0 96.0 98.0 97.0 73.0 64.0 63.0 63.0 02:48:55 INFO - PROCESS | 1650 | 02:48:55 INFO - PROCESS | 1650 | [#9] json-stringify-tinderbox Cycles:10 Average:59.10 Median:58.00 stddev:3.96 (6.8%) stddev-sans-first:3.74 02:48:55 INFO - PROCESS | 1650 | Values: 54.0 57.0 67.0 65.0 60.0 57.0 58.0 58.0 57.0 58.0 02:48:55 INFO - PROCESS | 1650 | 02:48:55 INFO - PROCESS | 1650 | [#10] stanford-crypto-aes Cycles:10 Average:88.70 Median:87.50 stddev:5.83 (6.7%) stddev-sans-first:5.93 02:48:55 INFO - PROCESS | 1650 | Values: 84.0 85.0 86.0 86.0 83.0 98.0 98.0 94.0 89.0 84.0 02:48:55 INFO - PROCESS | 1650 | 02:48:55 INFO - PROCESS | 1650 | [#11] stanford-crypto-ccm Cycles:10 Average:150.70 Median:146.00 stddev:18.20 (12.5%) stddev-sans-first:18.66 02:48:55 INFO - PROCESS | 1650 | Values: 164.0 145.0 141.0 142.0 127.0 139.0 145.0 147.0 191.0 166.0 02:48:55 INFO - PROCESS | 1650 | 02:48:55 INFO - PROCESS | 1650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.20 Median:167.50 stddev:26.68 (15.9%) stddev-sans-first:27.65 02:48:55 INFO - PROCESS | 1650 | Values: 167.0 167.0 167.0 228.0 219.0 218.0 168.0 167.0 166.0 165.0 02:48:55 INFO - PROCESS | 1650 | 02:48:55 INFO - PROCESS | 1650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:67.00 stddev:6.00 (9.0%) stddev-sans-first:6.34 02:48:55 INFO - PROCESS | 1650 | Values: 67.0 66.0 67.0 66.0 64.0 68.0 64.0 64.0 78.0 81.0 02:48:55 INFO - PROCESS | 1650 | -------- Summary: end -------- 02:48:55 INFO - PROCESS | 1650 | 02:48:56 INFO - TEST-INFO | 1650: exit 0 02:48:56 INFO - TEST-OK | kraken | took 60251ms 02:48:56 INFO - SUITE-END | took 1180s 02:48:56 INFO - Completed test suite (00:19:40) 02:48:56 INFO - javascript benchmark 02:48:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7627.630077217007, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3371.561696979393, 3379.831008449578, 3383.4924761285806, 3387.728981681466, 3427.7257819374436, 5983.461488466037, 5994.520438364926, 5997.580169388145, 5998.580099393044, 6022.518198544111, 5961.731722072506, 5985.670788106663, 6008.939910600892, 6029.155918171448, 6035.215421995134, 5373.489518495737, 5382.273393091941, 5402.567794576444, 5410.513053825155, 5514.393416724157, 5307.416184219733, 5325.227841962913, 5368.677879327252, 5476.644018138828, 5551.444855514456, 5398.8920221595745, 5417.566594672417, 5439.184122381635, 5473.8357849264585, 5505.366882808488, 5446.074167391553, 5446.863828404302, 5473.06957817172, 5473.987312347229, 5476.7535460904155, 5221.425643179247, 5400.189971504266, 5401.621886467949, 5402.864928376783, 5423.5932305076885, 5846.824595262149, 5852.12218167274, 5900.468957793776, 5953.3451320354725, 6030.819075427744, 6346.333634968308, 6396.0, 6405.5836370636225, 6405.8398540036405, 6411.67941602918, 6364.968175159141, 6450.903236451457, 6456.612603243773, 6464.224293084813, 6479.1901012373455, 5857.062869940789, 5986.2517185351835, 6115.266168059817, 6122.234720659918, 6141.355157708376, 6392.105105285264, 6413.230412350548, 6454.580452270588, 6502.414782669583, 6518.315576864456, 6377.330380310001, 6398.200224971879, 6398.456131228804, 6408.423241908251, 6424.775132870327, 6352.110704501373, 6407.519436042316, 6448.419642232127, 6456.22525296958, 6473.805785826433, 6215.160953271251, 6270.529710271748, 6367.713452894631, 6374.107624932513, 6391.3289104643345, 6365.681715914186, 6388.488920886318, 6396.584222025554, 6446.774362897276, 6447.323031081669, 4873.926891096637, 5167.948320516747, 5178.456262092502, 5180.48195180479, 5186.455422180617, 4491.977540112279, 4524.773761311922, 4545.204589196944, 4588.564086411786, 4613.561711637389, 5809.651420914759, 5831.504322132666, 5836.88326233473, 5839.240898683229, 5862.912056319158, 6334.809955701337, 6339.429451349401, 6373.776917807854, 6374.808755737336, 6460.353964603596, 5015.774290156952, 6007.579469437097, 6024.0, 6028.09578563219, 6056.970315046453, 5637.351704553947, 5664.0937450007805, 5673.375928647845, 5692.82921512347, 5700.885982280414, 6337.936620633919, 6385.0, 6444.420002199825, 6614.70233839488, 6626.370494802986, 5402.135658294654, 6388.776392826228, 6418.967905160444, 6424.068510065921, 6430.131932189094, 6505.934940650723, 6567.0, 6571.310012448624, 6572.047053177167, 6582.670866456754, 6183.938160618336, 6385.10608514799, 6401.583897046677, 6404.455621272244, 6408.4232419080645, 5762.827115186551, 6180.042093475518, 6236.6258024518675, 6314.179156709783, 6359.491240700825, 6147.047207682816, 6286.402791734778, 6305.337939516285, 6324.367563243823, 6325.430711236011, 6003.0695242237525, 6319.557630965788, 6319.905201422074, 6350.777722779865, 6351.110844481868, 6037.879242415215, 6063.575549711654, 6090.665013424305, 6091.390860913873, 6093.542984276286, 6196.287426945959, 6294.716737746904, 6323.241211054519, 6377.904331434939, 6382.20222472191, 6244.906326405198, 6245.6252624842655, 6247.531435142473, 6250.437460628384, 6251.562390632794], "value": 5886.257502237511, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [784.7175016993881, 803.9196080391962, 860.8794768732379, 878.0780180810152, 878.7978764884073, 41660.583394166046, 42553.57446425535, 43999.560004399944, 44079.0, 44114.77942610286, 42629.57370426295, 42794.572054279444, 42854.78572607133, 42889.0, 43017.0, 7286.526375785584, 9245.352825302214, 9420.152186303232, 9428.151466368026, 9444.0, 6496.870062598745, 7452.925470745277, 7530.736424225153, 7539.811504712398, 11020.559177632886, 11029.83455248168, 11037.227394082418, 11059.50232239547, 11070.723231919226, 11161.7209569761, 9319.25445964328, 10942.945285273563, 10968.890311096866, 10979.945100274448, 11012.449377531091, 7253.202147763742, 7448.702051917917, 10835.079018283455, 10882.564697412094, 10882.891171088268, 40375.7981210095, 40663.593364066575, 40813.38779918304, 40926.795366022976, 42806.357904631455, 3831.5019047523924, 3865.246276975991, 3873.1672690371706, 3874.4382064600477, 3912.4522566840665, 27618.309542261402, 27695.0, 27699.584506232422, 29807.552886706715, 29818.0, 2988.4770165221, 3078.3843231353594, 3162.177833763238, 3179.205198700325, 3255.886043988473, 350841.0, 351092.0, 351728.99999999744, 351867.0, 351922.0, 43293.35059974103, 43998.12003759971, 53779.0, 53903.460965389844, 54058.0, 37727.81136094302, 54982.900341993736, 55634.0, 59015.0, 59151.70424147852, 15106.773398399033, 15116.622084447978, 15178.013429127072, 15205.163715995504, 15211.315490802941, 12729.108962372546, 12967.0, 12967.22196668184, 12968.870311296767, 13020.153690010118, 13050.412731427108, 13074.019448541207, 13114.885234755153, 13168.407421666048, 13237.933810330887, 5521.944780552143, 5569.19246709233, 5590.077637189818, 5592.888142237132, 5600.523955463831, 761.5240474703311, 937.9484128373005, 951.1059603972383, 979.0796651147898, 989.3816364772017, 28658.570121448196, 29174.562381564294, 29510.409791804042, 30003.099907002827, 30132.0, 905.9139381758722, 968.6222373274429, 1041.6458404142477, 1084.804735147681, 1099.8515200447998, 15280.541583752505, 15299.923500382427, 15371.231438428258, 15479.0, 15662.843371566367, 446717.0, 447297.0, 447808.0, 448657.0, 448876.0, 58776.41223587795, 58783.412165878646, 58833.11750323749, 58892.41107588955, 58897.11654325188, 1433.8000575079463, 1439.5897169306697, 1474.7198032373815, 1475.8671719545507, 1478.0540454109378, 27362.589561156998, 28222.85888570544, 29062.564061539517, 29072.982445614303, 29148.417031659672, 46774.298385524926, 47138.0, 47848.04303913972, 50221.49778502168, 50237.24644130414, 473684.0, 476699.0, 477013.0, 477072.0, 477889.0, 24598.13906513335, 25033.87483062573, 25871.870640646677, 29724.959626412972, 30728.231794205323, 35911.11731676378, 38918.4162237561, 38963.02592435212, 39100.6089939097, 39583.60416395914, 27511.449771004867, 28005.299867503476, 28605.427891442472, 28885.85557072201, 28921.710782892744, 27491.17526474209, 27737.0, 27771.0, 28692.71307286984, 28748.137555873356, 32212.0, 32860.849870254424, 32978.67021329756, 35232.64767352396, 35826.492145549564, 28876.566851497664, 29129.417411652073, 29494.0, 29730.405391892473, 30051.0, 22491.550168996855, 22498.27535721162, 23256.95343709503, 23811.285661430185, 23850.761492384852], "value": 18596.662799643065, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.1776457263741, 393.5297319702956, 416.4232537934959, 425.2175996167052, 453.34718006071273, 13012.219266843984, 14807.62980925476, 20821.583568328624, 21330.0, 21440.24959126431, 21816.89091554544, 22060.0, 22415.439614009658, 22690.319290421274, 22775.316740497812, 6655.134832471784, 7174.8206294842785, 7509.535640550095, 7688.5771282579435, 7693.538387696756, 6300.464460520861, 7655.732049378273, 7673.769786906401, 7722.961385193094, 7735.883961740578, 7184.892226616605, 7757.030371203599, 7757.456978011542, 7763.184865589088, 7779.649915753805, 6396.424321811036, 7620.047494063242, 7622.771316860503, 7622.923770762277, 7631.580263085528, 6849.212340580847, 7242.963785181093, 7397.445191610651, 7401.555906645618, 7406.518576292578, 25360.873195633903, 25378.365540861443, 25788.0, 26055.348616284555, 26076.0, 2847.957280640792, 2884.7115288470986, 2966.332575170591, 3018.0, 3094.5048792193365, 14976.251187440694, 15454.690906181813, 15482.5355239343, 15608.687826243411, 16036.679266414723, 1880.8683392162554, 1886.9716954245698, 1939.0789375046882, 1942.7280180774703, 1996.6605677034938, 157342.21328893283, 157950.0, 160764.0, 164457.0, 166687.0, 19581.314653987043, 20158.798412015985, 20335.79664203339, 20352.49118772013, 20540.589188216152, 26965.730342696323, 32028.199295017344, 32652.510212346835, 32657.0, 32773.67226327706, 10097.495125243708, 10168.542415591317, 10380.636677716244, 10408.47957602117, 10496.422696751599, 8553.272971797342, 8566.91433085661, 8586.656533738706, 8660.30717542595, 8675.089115642893, 9244.399114057565, 9389.671361502315, 9439.622415103318, 9545.952270238604, 9569.0, 3428.5371474850576, 3851.345271303885, 3908.4918960534947, 3941.2905676977844, 3943.0, 865.6926790989235, 978.7161723100363, 1038.2939601071344, 1066.072516910293, 1081.983770243447, 20268.0, 20976.26583069585, 21030.684539731916, 21387.67918481224, 21597.385141134106, 967.9467629280457, 1052.8052310322614, 1073.270176280137, 1092.5520536579963, 1114.9108071354271, 10154.593816247267, 11198.0, 11201.943990279997, 11233.269837460539, 11240.988311052044, 757375.0, 757478.0, 775292.0, 787744.0, 795653.0, 123479.3826030882, 139467.90798138035, 140602.67287972066, 162282.18858905867, 165230.0, 1185.4843143232722, 1190.8809119088196, 1222.0, 1225.2954551133134, 1229.520487010049, 17645.470635880945, 18823.811761882753, 18849.71725424147, 18880.52798680044, 18931.810681893006, 48896.555172241955, 58810.823783523236, 62543.374566255574, 62837.0, 63764.68117659382, 58349.4165058344, 86285.56857215674, 88631.67052494088, 88761.0, 89285.10714892768, 10992.890071099187, 11688.831116888243, 12015.45930433115, 12091.818622720843, 12097.637070887888, 12951.935240324116, 13007.869921300666, 13044.239027731515, 13338.466461341826, 13342.799858002332, 11034.668959931216, 11210.607628732956, 11410.657680269605, 11665.650030499099, 11669.649910502698, 8726.65093396257, 10504.159667226757, 10555.577776889146, 10824.458777061272, 10828.729281768019, 11447.484863181011, 11772.70568235801, 11782.764344713229, 11878.0, 11903.82144267854, 10178.694639160836, 11687.94808467208, 11910.344931028876, 11978.64064078079, 12018.098642602015, 11252.156088293246, 11324.094072474347, 11414.429278536207, 11468.0, 11657.708557286136], "value": 11652.984334008132, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1357.647011776938, 1533.4249656378859, 1534.2558858953412, 1560.4538411555957, 1591.9761203581945, 10537.894621053787, 11096.0, 11099.278546894466, 11103.944480277598, 11171.441427928612, 10671.306365086284, 11031.72420689483, 11203.159763017766, 11214.943925280362, 11229.382383968878, 2382.7498112698136, 2422.1159276863996, 2424.442378252994, 2425.320910145162, 2426.38127277544, 2339.543788961153, 2408.397900524869, 2441.0, 2442.4992876460374, 2442.9755702443013, 2342.390978345625, 2404.471016376403, 2414.9275521734376, 2433.1362366359954, 2437.731849496554, 2319.6404557293645, 2391.7727815857465, 2392.9042838286446, 2395.0180426025245, 2410.927672169838, 2375.904963801446, 2394.7485514021128, 2400.0279886645935, 2401.243608263409, 2403.65147053678, 10866.293690910145, 11117.944410277978, 11138.997490225918, 11150.49822757978, 11153.665390038312, 5725.0, 5891.79378721747, 5894.911576326359, 5895.793647222326, 5909.9953007988315, 3525.5593050868642, 3668.137987572918, 3700.703943684499, 3750.8499660013567, 3755.380362240227, 1195.6233786357357, 1209.1898428053225, 1215.2161855603174, 1249.3440943504643, 1262.3246563088794, 13805.102668326526, 14156.504522341771, 14407.567772966828, 15430.845691543165, 15638.13990230537, 4570.405847239837, 4748.287756836502, 4760.738159401266, 4762.571368576775, 4766.404199475066, 10176.643817466502, 11311.886881131248, 11326.0, 11330.60342887995, 11354.943225283821, 4928.6303527235605, 5788.334341550775, 5998.670073145931, 6038.818835434856, 6060.121282414113, 5161.509656582619, 5305.230741542532, 5347.438518955531, 5392.91910621341, 5412.188171774265, 4017.4777278953547, 4024.7786371749835, 4096.283150448659, 4124.876253712393, 4126.628603425646, 1113.1206346985791, 1118.3792994887754, 1118.5246270335076, 1136.5567428702811, 1139.0773473486502, 916.1800188830958, 928.8792456980684, 937.5218638494281, 952.3809523809579, 989.9950500247453, 6562.212534495891, 6568.8357791055605, 6678.966605166943, 6804.795856124324, 6822.420094292041, 946.7739277635478, 984.17329443268, 986.9753256168653, 1008.193445243802, 1042.890496497872, 3757.5866654667966, 4056.9797151014054, 4063.187362527506, 4391.494978077498, 4472.08322293929, 13064.934675326753, 13644.93177534106, 13645.863541364459, 13687.863121368859, 13842.100263482842, 12019.579314723942, 12787.360631968364, 12961.935190324177, 13543.255120968244, 13557.389917453542, 9957.950210248902, 10214.285000049926, 10233.385996840214, 10243.84634230487, 10253.74365640865, 6383.808485745435, 6746.0, 6787.117674702455, 6927.411170050602, 6966.407855332353, 10999.0, 12002.699932501757, 12219.877801221874, 12582.119251652297, 12603.873961260637, 11774.52901883915, 11808.822867657163, 12251.754964900474, 12264.202826816228, 12534.310612916377, 9115.0, 9307.674231401868, 9311.76720581991, 9953.900460995297, 10351.792964140826, 10253.33353332031, 10275.229357798045, 10608.416537090534, 10608.469576521298, 10609.628662996758, 8598.527081010605, 8631.223189912938, 8752.737417877473, 8882.600282987152, 8956.328275379243, 8462.449940753831, 8530.872036919327, 8554.443961142506, 8577.82844343122, 8692.478451292942, 7856.25365590268, 7993.600319984093, 8006.879896801436, 8010.759677209693, 8013.118556958846, 4965.882676397781, 5013.949860501494, 5759.769609215752, 5993.820185394445, 6095.994160963392, 5266.447023062523, 5955.583109182316, 5990.31111422192, 6024.0662697282, 6159.23009623797], "value": 5152.808738467785, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.2925870105501, 378.1133242546228, 378.20388083085106, 387.27579426472516, 389.16329890734914, 4330.653547716183, 4359.978200108999, 4461.709988850731, 4562.56279272029, 4765.023170250095, 4143.73065750726, 4646.047560250149, 4715.915339471923, 4817.22924332107, 4992.850214493562, 3794.146317078663, 3868.729188956774, 4140.50313962325, 4154.6676265898805, 4165.146145040259, 3703.925861500162, 3906.8046597670145, 3999.960000399988, 4135.139187365682, 4181.728187667807, 3874.651281384675, 4022.2558826617023, 4132.958670413287, 4222.057853387446, 4231.724937879043, 3619.529461170044, 4081.6938429787074, 4136.9864383226, 4173.353130264783, 4198.391233271189, 3805.296020236265, 3814.8474061037805, 3818.7851046393025, 3827.110531548663, 3840.635139661728, 3969.503812023497, 4140.565240649748, 4856.587190088847, 4883.682560633583, 4935.925961110586, 3906.7069969752383, 4481.795516205929, 4531.864044078683, 4839.3466881970835, 4842.481909407089, 4679.0, 4968.428630707443, 5130.486506480597, 5361.5978801589645, 5408.0, 4336.3278691802825, 4339.7830108494445, 4365.275716092126, 4378.474583050022, 4393.319035549495, 4843.9031219375765, 5024.673396229234, 5314.591633217201, 5678.5741069419955, 5742.540596752292, 3942.7580312201567, 4096.569860164699, 4140.799168241237, 4366.257736184856, 4385.627221686129, 4065.79671016448, 4365.869023929287, 4390.62679672225, 4420.889477763018, 4520.32195170727, 3964.2269757397607, 4745.952540474551, 4781.593564546983, 4796.904061918812, 4858.3441235432765, 4542.432195975503, 5043.470435604282, 5140.254663073833, 5254.238135470412, 5363.731813409314, 1395.406952045397, 1428.2929949674976, 1433.6200906759716, 1501.14434772181, 1528.5631506383963, 923.2244914272044, 1095.70963694621, 1140.4981808004618, 1144.8339990701302, 1146.2893006335958, 4342.392065110887, 4600.53994600544, 4799.0641824844515, 4973.129702302155, 4980.526849949249, 4966.701997880066, 5014.949850501448, 5453.972730136324, 5476.561875049986, 5548.69482178484, 4352.477702675636, 4419.348390965395, 4482.910341793146, 4549.977250113794, 4824.611817150463, 2348.5302939411845, 2522.8681763909467, 2728.3315587681145, 2754.2701184186208, 2867.9818664373847, 4893.84994526286, 5739.827805165852, 5750.884982300414, 5767.279090113736, 5802.33273173582, 4619.597809139229, 4780.521947805261, 5216.40011398694, 5434.281664874341, 5536.501714845684, 4896.3389942358035, 4969.751512424365, 5049.192129259301, 5754.539636829044, 5777.422257774189, 5062.797488100435, 5419.674819510842, 5517.751701173376, 5552.944470555404, 5589.0, 4474.127545128668, 4759.428868535798, 5400.378956419905, 5444.727763611882, 5470.617056805985, 5028.472010438997, 5219.217117432416, 5648.491635752802, 5695.487406133468, 5753.453421924911, 3756.9248615027, 3886.2616102941483, 4292.098659281586, 4320.654347652243, 4326.459192600925, 4834.540718631724, 5450.836474905759, 5556.916646250229, 5563.527100196528, 5605.32736071674, 4764.595009424099, 5430.67415955044, 5433.821214589351, 5453.864028183731, 5465.836024919259, 4776.379070720784, 5148.3564554430695, 5350.892982140414, 5374.892502149857, 5375.973120134374, 5158.174692049254, 5176.327077479904, 5215.556677682288, 5228.660137091229, 5245.239440281214, 4243.6605071593585, 5182.870428239325, 5352.0366334060245, 5373.328333958255, 5438.0, 4537.977310113428, 4824.480288709045, 5126.948730512796, 5133.589312855037, 5141.100307446257], "value": 4052.435688118854, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.2372637551445, 729.6133049483774, 754.6302311867183, 762.9580373079482, 814.4095530740213, 14937.477188298426, 15012.324445399956, 15746.763798543017, 15971.84028159721, 16135.43525976591, 14105.0, 14110.294485275746, 14616.342264598092, 14805.925970370134, 14837.0, 940.4921342475055, 965.1940629574314, 965.6620182935986, 967.3567077893192, 969.190725744001, 939.6006697153716, 956.8325543029977, 961.9470929098896, 977.008336538414, 978.6770365779312, 1022.6829682798357, 1025.446259020132, 1025.4975062219496, 1025.6205204074465, 1026.399556259589, 1018.6434747838272, 1019.1133713669118, 1019.7042857571332, 1020.637673625867, 1022.468316475436, 756.2437562437563, 757.7044952468542, 758.6699785593285, 758.7078974594766, 759.3204082346324, 15277.923610381988, 15643.0, 15674.98112622676, 15847.683046339123, 16081.11553864537, 11838.763224735543, 13865.55039622966, 13920.373583188679, 14109.294535273195, 14352.354144063542, 10283.845742313872, 11666.766664666744, 11711.355875426849, 11782.469788859522, 11884.881151188463, 3414.6926776590226, 3604.819759012039, 3610.4223324268255, 3746.2320224353944, 3799.5820459749407, 84326.57836710777, 86485.56757216237, 111621.0, 112238.0, 113132.0, 10610.457917727275, 10860.565577376974, 10982.609953270725, 11049.889501105046, 11183.44082795857, 21591.78408215929, 22008.339749807532, 22127.0, 22190.556188876133, 22215.222467213895, 7723.95726576905, 7782.533048017137, 7841.529508229524, 8007.239312265326, 8073.273405393543, 4147.834086636561, 4178.8537401190815, 4243.6605071594195, 4327.8485253016, 4363.650907927358, 2932.7535797286496, 3268.836558172082, 3428.0, 3435.9656403435647, 3437.74216933731, 610.4444955090846, 621.3631028196045, 631.4474834519796, 637.7640273098983, 644.713102669317, 629.3329071184559, 639.3159319528061, 639.5235549515547, 642.5181114164377, 663.5056882622478, 9147.131022552847, 9831.71739648733, 9965.750856228653, 9976.201903847676, 10887.727806804893, 546.350022930747, 555.6332820338557, 580.4862696513616, 636.5480508838776, 707.7063018847224, 4685.4143232095985, 4977.0, 5080.237964305384, 5080.314157588752, 5102.515261050195, 80577.0, 84757.57621211854, 90512.09487905168, 92582.0, 98032.0, 48101.51898480971, 62486.0, 77740.445191097, 78626.42747145025, 82111.58944205241, 56803.14795277992, 70273.24316892118, 71615.92576111363, 73385.63307183537, 74721.25278747252, 10758.246922715647, 10805.405702686114, 10909.560389904042, 11093.556257749922, 11150.498227579941, 45808.77095614634, 46088.8477788058, 46826.76586617045, 47141.52858471371, 47497.0, 57622.0, 57976.130358045506, 58162.709186453794, 58172.0, 58441.0, 12217.266963982189, 12227.572034978733, 12432.937835310766, 12471.314077725812, 12512.0615953802, 14046.648833779238, 14200.644983875485, 14295.499657511937, 14451.638709032359, 14499.78250326267, 12965.67850348765, 13008.284544350152, 13172.670683232996, 13379.0, 13399.732005359643, 12571.776665967684, 13281.734365312834, 13331.66670833237, 13375.264360460269, 13748.381322840696, 12157.27056376585, 12924.676883077622, 12967.0, 13371.53199638008, 13386.26375549354, 8842.381033327605, 9203.861942071007, 9254.167124958785, 9448.716538503855, 9460.858087128836, 10044.196464282986, 10308.793824123626, 11189.384583847966, 11199.776004479701, 11221.0], "value": 7393.042115590603, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1454.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 115.0, 116.0, 113.0, 115.0, 115.0, 115.0, 116.0, 115.0, 115.0], "value": 115.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 111.0, 111.0, 145.0, 110.0, 111.0, 107.0, 91.0, 136.0, 134.0], "value": 120.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 183.0, 183.0, 184.0, 182.0, 185.0, 182.0, 184.0, 185.0, 183.0], "value": 183.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 60.0, 63.0, 93.0, 64.0, 61.0, 61.0, 63.0, 76.0, 59.0], "value": 68.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 71.0, 89.0, 69.0, 70.0, 68.0, 82.0, 69.0, 69.0, 82.0], "value": 75.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 88.0, 87.0, 88.0, 88.0, 88.0, 87.0, 87.0, 87.0], "value": 87.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 97.0, 99.0, 95.0, 95.0, 97.0, 99.0, 95.0, 95.0], "value": 96.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 83.0, 82.0, 83.0, 83.0, 85.0, 84.0, 85.0, 84.0], "value": 83.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 52.0, 85.0, 96.0, 98.0, 97.0, 73.0, 64.0, 63.0, 63.0], "value": 74.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 57.0, 67.0, 65.0, 60.0, 57.0, 58.0, 58.0, 57.0, 58.0], "value": 59.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 86.0, 86.0, 83.0, 98.0, 98.0, 94.0, 89.0, 84.0], "value": 88.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 145.0, 141.0, 142.0, 127.0, 139.0, 145.0, 147.0, 191.0, 166.0], "value": 150.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 167.0, 167.0, 228.0, 219.0, 218.0, 168.0, 167.0, 166.0, 165.0], "value": 183.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 66.0, 64.0, 68.0, 64.0, 64.0, 78.0, 81.0], "value": 68.5, "unit": "score"}]}]} 02:48:57 INFO - Return code: 0 02:48:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:48:57 ERROR - # TBPL SUCCESS # 02:48:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:48:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:48:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:48:57 INFO - 2017-03-29 02:48:57.101 screenresolution[1654:9928] starting screenresolution argv=screenresolution get 02:48:57 INFO - 2017-03-29 02:48:57.103 screenresolution[1654:9928] Display 0: 1600x1200x32@60 02:48:57 INFO - 2017-03-29 02:48:57.110 screenresolution[1655:9931] starting screenresolution argv=screenresolution list 02:48:57 INFO - Available Modes on Display 0 02:48:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:48:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:48:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:48:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:48:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:48:57 INFO - Intel Iris: 02:48:57 INFO - Chipset Model: Intel Iris 02:48:57 INFO - Type: GPU 02:48:57 INFO - Bus: Built-In 02:48:57 INFO - VRAM (Dynamic, Max): 1536 MB 02:48:57 INFO - Vendor: Intel (0x8086) 02:48:57 INFO - Device ID: 0x0a2e 02:48:57 INFO - Revision ID: 0x0009 02:48:57 INFO - Displays: 02:48:57 INFO - Display: 02:48:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:48:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:48:57 INFO - Display Serial Number: 1600x1200 60 02:48:57 INFO - Main Display: Yes 02:48:57 INFO - Mirror: Off 02:48:57 INFO - Online: Yes 02:48:57 INFO - Rotation: Supported 02:48:57 INFO - Return code: 0 02:48:57 INFO - Running post-action listener: _resource_record_post_action 02:48:57 INFO - [mozharness: 2017-03-29 09:48:57.348372Z] Finished run-tests step (success) 02:48:57 INFO - Running post-run listener: _resource_record_post_run 02:48:57 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 37958656; Write bytes: 509791232; Read time: 242; Write time: 1579 02:48:57 INFO - TinderboxPrint: CPU usage
53.8% 02:48:57 INFO - TinderboxPrint: I/O read bytes / time
37,958,656 / 242 02:48:57 INFO - TinderboxPrint: I/O write bytes / time
509,791,232 / 1,579 02:48:57 INFO - TinderboxPrint: CPU idle
2,218.1 (46.2%) 02:48:57 INFO - TinderboxPrint: CPU system
956.2 (19.9%) 02:48:57 INFO - TinderboxPrint: CPU user
1,631.5 (33.9%) 02:48:57 INFO - TinderboxPrint: Swap in / out
246,071,296 / 0 02:48:57 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 203674112; Write bytes: 201020928; Read time: 15590; Write time: 411 02:48:57 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 35906560; Write bytes: 297809408; Read time: 222; Write time: 1132 02:48:57 INFO - Running post-run listener: _upload_blobber_files 02:48:57 INFO - Blob upload gear active. 02:48:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:48:57 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 02:48:57 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'] 02:48:57 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 02:48:58 INFO - (blobuploader) - INFO - Open directory for files ... 02:48:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:48:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:48:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:48:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:48:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:48:59 INFO - (blobuploader) - INFO - Done attempting. 02:48:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:48:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:48:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:49:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:49:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:49:00 INFO - (blobuploader) - INFO - Done attempting. 02:49:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:49:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:49:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:49:01 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:49:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:49:01 INFO - (blobuploader) - INFO - Done attempting. 02:49:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:49:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:49:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:49:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:49:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:49:03 INFO - (blobuploader) - INFO - Done attempting. 02:49:03 INFO - (blobuploader) - INFO - Iteration through files over. 02:49:03 INFO - Return code: 0 02:49:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:49:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:49:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/22701ec0b5fafe53be0c63f69dbceaac9e8a0daa31a6fdec2df583c324ae708a896f8ea8720b996128924eb93c49fa99abeb19587e2fdd3b3957f68c18607ac2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5811cb57cadbac6f75e1e1f1e4988b94ed89fd0cf65eefea44fbf8317dc21c03223677cca7866283af3fa06d270a7619c735f023f777fe7f60cd0a40c34fd122", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ee61b35a2ec0a98de36d68dccdee705ef49508e0b70576c2ab611b1fe575cc18160d7cdbe80b72ee2af48d6005430eebbf04d72b177429bec21b3a5eb1f84287", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c322b07be7ce780e143ea0f0140e5ccbd274de5c2b8916bbfa24effabdfe9631a4f80737788fb8e0cca31d7b6b097d782b78419b86c11e170d36fa70a552b7aa"} 02:49:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:49:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:49:03 INFO - Contents: 02:49:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/22701ec0b5fafe53be0c63f69dbceaac9e8a0daa31a6fdec2df583c324ae708a896f8ea8720b996128924eb93c49fa99abeb19587e2fdd3b3957f68c18607ac2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5811cb57cadbac6f75e1e1f1e4988b94ed89fd0cf65eefea44fbf8317dc21c03223677cca7866283af3fa06d270a7619c735f023f777fe7f60cd0a40c34fd122", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ee61b35a2ec0a98de36d68dccdee705ef49508e0b70576c2ab611b1fe575cc18160d7cdbe80b72ee2af48d6005430eebbf04d72b177429bec21b3a5eb1f84287", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c322b07be7ce780e143ea0f0140e5ccbd274de5c2b8916bbfa24effabdfe9631a4f80737788fb8e0cca31d7b6b097d782b78419b86c11e170d36fa70a552b7aa"} 02:49:03 INFO - Running post-run listener: copy_logs_to_upload_dir 02:49:03 INFO - Copying logs to upload dir... 02:49:03 INFO - mkdir: /builds/slave/test/build/upload/logs 02:49:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1283.144715 ========= master_lag: 1.96 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-03-29 02:49:05.682591) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-29 02:49:05.683763) ========= 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.mxd8XoBvWZ/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.XkcFxGVKTy/Listeners TMPDIR=/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/22701ec0b5fafe53be0c63f69dbceaac9e8a0daa31a6fdec2df583c324ae708a896f8ea8720b996128924eb93c49fa99abeb19587e2fdd3b3957f68c18607ac2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5811cb57cadbac6f75e1e1f1e4988b94ed89fd0cf65eefea44fbf8317dc21c03223677cca7866283af3fa06d270a7619c735f023f777fe7f60cd0a40c34fd122", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ee61b35a2ec0a98de36d68dccdee705ef49508e0b70576c2ab611b1fe575cc18160d7cdbe80b72ee2af48d6005430eebbf04d72b177429bec21b3a5eb1f84287", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c322b07be7ce780e143ea0f0140e5ccbd274de5c2b8916bbfa24effabdfe9631a4f80737788fb8e0cca31d7b6b097d782b78419b86c11e170d36fa70a552b7aa"} build_url:https://queue.taskcluster.net/v1/task/BpvuIEGERui6qrnZGEemBQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011217 build_url: 'https://queue.taskcluster.net/v1/task/BpvuIEGERui6qrnZGEemBQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/22701ec0b5fafe53be0c63f69dbceaac9e8a0daa31a6fdec2df583c324ae708a896f8ea8720b996128924eb93c49fa99abeb19587e2fdd3b3957f68c18607ac2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5811cb57cadbac6f75e1e1f1e4988b94ed89fd0cf65eefea44fbf8317dc21c03223677cca7866283af3fa06d270a7619c735f023f777fe7f60cd0a40c34fd122", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ee61b35a2ec0a98de36d68dccdee705ef49508e0b70576c2ab611b1fe575cc18160d7cdbe80b72ee2af48d6005430eebbf04d72b177429bec21b3a5eb1f84287", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c322b07be7ce780e143ea0f0140e5ccbd274de5c2b8916bbfa24effabdfe9631a4f80737788fb8e0cca31d7b6b097d782b78419b86c11e170d36fa70a552b7aa"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-29 02:49:05.722078) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 02:49:05.722423) ========= 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.mxd8XoBvWZ/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.XkcFxGVKTy/Listeners TMPDIR=/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005260 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 02:49:05.778080) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-29 02:49:05.778398) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-29 02:49:05.778735) ========= ========= Total master_lag: 2.11 =========