builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0360 starttime: 1493328826.25 results: success (0) buildid: 20170427130024 builduid: 2b8e7122be1a4fdba7ea4e9cef99dda4 revision: 2cca333f546f38860f84940d4c72d7470a3410f4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-27 14:33:46.253936) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-27 14:33:46.254428) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-27 14:33:46.254714) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-27 14:33:46.282928) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 14:33:46.283345) ========= 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.4DDkWCO3Qi/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.DXafM68OwS/Listeners TMPDIR=/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/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-04-27 14:33:46-- 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% 67.5M=0s 2017-04-27 14:33:46 (67.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.143060 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 14:33:46.451007) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 14:33:46.451344) ========= 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.4DDkWCO3Qi/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.DXafM68OwS/Listeners TMPDIR=/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/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.031344 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 14:33:46.505888) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-27 14:33:46.506268) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2cca333f546f38860f84940d4c72d7470a3410f4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 2cca333f546f38860f84940d4c72d7470a3410f4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4DDkWCO3Qi/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.DXafM68OwS/Listeners TMPDIR=/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/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-04-27 14:33:46,615 truncating revision to first 12 chars 2017-04-27 14:33:46,615 Setting DEBUG logging. 2017-04-27 14:33:46,615 attempt 1/10 2017-04-27 14:33:46,615 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2cca333f546f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-27 14:33:47,649 unpacking tar archive at: mozilla-central-2cca333f546f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.306536 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-27 14:33:47.837347) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-27 14:33:47.837685) ========= script_repo_revision: 2cca333f546f38860f84940d4c72d7470a3410f4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-27 14:33:47.838084) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-27 14:33:47.838430) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-27 14:33:47.858883) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-04-27 14:33:47.859259) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4DDkWCO3Qi/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.DXafM68OwS/Listeners TMPDIR=/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/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 14:33:48 INFO - MultiFileLogger online at 20170427 14:33:48 in /builds/slave/test 14:33:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 14:33:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:33:48 INFO - {'append_to_log': False, 14:33:48 INFO - 'base_work_dir': '/builds/slave/test', 14:33:48 INFO - 'blob_upload_branch': 'Firefox', 14:33:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:33:48 INFO - 'branch': 'Firefox', 14:33:48 INFO - 'buildbot_json_path': 'buildprops.json', 14:33:48 INFO - 'config_files': ('talos/mac_config.py',), 14:33:48 INFO - 'default_actions': ('clobber', 14:33:48 INFO - 'read-buildbot-config', 14:33:48 INFO - 'download-and-extract', 14:33:48 INFO - 'populate-webroot', 14:33:48 INFO - 'create-virtualenv', 14:33:48 INFO - 'install', 14:33:48 INFO - 'run-tests'), 14:33:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:33:48 INFO - 'download_minidump_stackwalk': True, 14:33:48 INFO - 'download_symbols': 'ondemand', 14:33:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:33:48 INFO - 'tooltool.py': '/tools/tooltool.py', 14:33:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:33:48 INFO - '/tools/misc-python/virtualenv.py')}, 14:33:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:33:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:33:48 INFO - 'gecko_profile': False, 14:33:48 INFO - 'gecko_profile_interval': 0, 14:33:48 INFO - 'installer_path': 'installer.exe', 14:33:48 INFO - 'log_level': 'info', 14:33:48 INFO - 'log_name': 'talos', 14:33:48 INFO - 'log_to_console': True, 14:33:48 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:33:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:33:48 INFO - 'opt_config_files': (), 14:33:48 INFO - 'pip_index': False, 14:33:48 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:33:48 INFO - 'cmd': ('bash', 14:33:48 INFO - '-c', 14:33:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:33:48 INFO - 'enabled': True, 14:33:48 INFO - 'halt_on_failure': False, 14:33:48 INFO - 'name': 'check_screen_resolution'},), 14:33:48 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:33:48 INFO - 'cmd': ('bash', 14:33:48 INFO - '-c', 14:33:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:33:48 INFO - 'enabled': True, 14:33:48 INFO - 'halt_on_failure': False, 14:33:48 INFO - 'name': 'check_screen_resolution'},), 14:33:48 INFO - 'run_cmd_checks_enabled': True, 14:33:48 INFO - 'suite': 'dromaeojs', 14:33:48 INFO - 'system_bits': '32', 14:33:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:33:48 INFO - 'title': 't-yosemite-r7-0360', 14:33:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:33:48 INFO - 'use_talos_json': True, 14:33:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:33:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:33:48 INFO - 'work_dir': 'build'} 14:33:48 INFO - [mozharness: 2017-04-27 21:33:48.077394Z] Running clobber step. 14:33:48 INFO - Running pre-action listener: _resource_record_pre_action 14:33:48 INFO - Running main action method: clobber 14:33:48 INFO - rmtree: /builds/slave/test/build 14:33:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:33:50 INFO - Running post-action listener: _resource_record_post_action 14:33:50 INFO - [mozharness: 2017-04-27 21:33:50.729311Z] Finished clobber step (success) 14:33:50 INFO - [mozharness: 2017-04-27 21:33:50.729477Z] Running read-buildbot-config step. 14:33:50 INFO - Running pre-action listener: _resource_record_pre_action 14:33:50 INFO - Running main action method: read_buildbot_config 14:33:50 INFO - Using buildbot properties: 14:33:50 INFO - { 14:33:50 INFO - "project": "", 14:33:50 INFO - "product": "firefox", 14:33:50 INFO - "script_repo_revision": "production", 14:33:50 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 14:33:50 INFO - "repository": "", 14:33:50 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 14:33:50 INFO - "buildid": "20170427130024", 14:33:50 INFO - "pgo_build": "False", 14:33:50 INFO - "basedir": "/builds/slave/test", 14:33:50 INFO - "buildnumber": 37, 14:33:50 INFO - "slavename": "t-yosemite-r7-0360", 14:33:50 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 14:33:50 INFO - "platform": "yosemite_r7", 14:33:50 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 14:33:50 INFO - "branch": "mozilla-central", 14:33:50 INFO - "repo_path": "mozilla-central", 14:33:50 INFO - "revision": "2cca333f546f38860f84940d4c72d7470a3410f4", 14:33:50 INFO - "stage_platform": "macosx64", 14:33:50 INFO - "builduid": "2b8e7122be1a4fdba7ea4e9cef99dda4", 14:33:50 INFO - "slavebuilddir": "test" 14:33:50 INFO - } 14:33:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 14:33:50 INFO - Running post-action listener: _resource_record_post_action 14:33:50 INFO - [mozharness: 2017-04-27 21:33:50.732993Z] Finished read-buildbot-config step (success) 14:33:50 INFO - [mozharness: 2017-04-27 21:33:50.733094Z] Running download-and-extract step. 14:33:50 INFO - Running pre-action listener: _resource_record_pre_action 14:33:50 INFO - Running main action method: download_and_extract 14:33:50 INFO - mkdir: /builds/slave/test/build/tests 14:33:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:33:50 INFO - trying https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 14:33:50 INFO - Downloading https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 14:33:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 14:33:52 INFO - Downloaded 1325 bytes. 14:33:52 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 14:33:52 INFO - Using the following test package requirements: 14:33:52 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:33:52 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 14:33:52 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 14:33:52 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:33:52 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 14:33:52 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:33:52 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 14:33:52 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:33:52 INFO - u'jsshell-mac.zip'], 14:33:52 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:33:52 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 14:33:52 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 14:33:52 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:33:52 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 14:33:52 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:33:52 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 14:33:52 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:33:52 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 14:33:52 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:33:52 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 14:33:52 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:33:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 14:33:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:33:52 INFO - Fetch https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 14:33:53 INFO - Content-Length response header: 52695432 14:33:53 INFO - Bytes received: 52695432 14:34:09 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 14:34:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 14:34:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:34:09 INFO - Fetch https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 14:34:11 INFO - Content-Length response header: 52695432 14:34:11 INFO - Bytes received: 52695432 14:34:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 14:34:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 14:34:26 INFO - Fetch https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 14:34:27 INFO - Content-Length response header: 14408809 14:34:27 INFO - Bytes received: 14408809 14:34:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:34:27 INFO - trying https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 14:34:27 INFO - Downloading https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 14:34:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 14:34:30 INFO - Downloaded 71238474 bytes. 14:34:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 14:34:30 INFO - mkdir: /builds/slave/test/properties 14:34:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:34:30 INFO - Writing to file /builds/slave/test/properties/build_url 14:34:30 INFO - Contents: 14:34:30 INFO - build_url:https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 14:34:31 INFO - Running post-action listener: _resource_record_post_action 14:34:31 INFO - Running post-action listener: set_extra_try_arguments 14:34:31 INFO - [mozharness: 2017-04-27 21:34:31.003801Z] Finished download-and-extract step (success) 14:34:31 INFO - [mozharness: 2017-04-27 21:34:31.003939Z] Running populate-webroot step. 14:34:31 INFO - Running pre-action listener: _resource_record_pre_action 14:34:31 INFO - Running main action method: populate_webroot 14:34:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:34:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:34:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:34:31 INFO - '--tppagecycles', 14:34:31 INFO - '7'], 14:34:31 INFO - 'tests': ['tsvgm']}}, 14:34:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:34:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:34:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:34:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:34:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:34:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:34:31 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:34:31 INFO - 'talos_options': ['--disable-e10s'], 14:34:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:34:31 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:34:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:34:31 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:34:31 INFO - 'talos_options': ['--disable-e10s'], 14:34:31 INFO - 'tests': ['damp', 'tps']}, 14:34:31 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:34:31 INFO - 'tests': ['damp', 'tps']}, 14:34:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:34:31 INFO - 'tests': ['dromaeo_dom']}, 14:34:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:34:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:34:31 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 14:34:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 14:34:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:34:31 INFO - 'tests': ['a11yr', 14:34:31 INFO - 'ts_paint', 14:34:31 INFO - 'tpaint', 14:34:31 INFO - 'sessionrestore', 14:34:31 INFO - 'sessionrestore_no_auto_restore', 14:34:31 INFO - 'tabpaint']}, 14:34:31 INFO - 'other-e10s': {'tests': ['a11yr', 14:34:31 INFO - 'ts_paint', 14:34:31 INFO - 'tpaint', 14:34:31 INFO - 'sessionrestore', 14:34:31 INFO - 'sessionrestore_no_auto_restore', 14:34:31 INFO - 'tabpaint']}, 14:34:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:34:31 INFO - 'ts_paint', 14:34:31 INFO - 'tpaint', 14:34:31 INFO - 'sessionrestore', 14:34:31 INFO - 'sessionrestore_no_auto_restore', 14:34:31 INFO - 'tabpaint']}, 14:34:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:34:31 INFO - 'ts_paint', 14:34:31 INFO - 'tpaint', 14:34:31 INFO - 'sessionrestore', 14:34:31 INFO - 'sessionrestore_no_auto_restore', 14:34:31 INFO - 'tabpaint']}, 14:34:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:34:31 INFO - 'tests': ['a11yr', 14:34:31 INFO - 'ts_paint', 14:34:31 INFO - 'tpaint', 14:34:31 INFO - 'sessionrestore', 14:34:31 INFO - 'sessionrestore_no_auto_restore', 14:34:31 INFO - 'tabpaint']}, 14:34:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:34:31 INFO - 'tests': ['a11yr', 14:34:31 INFO - 'ts_paint', 14:34:31 INFO - 'tpaint', 14:34:31 INFO - 'sessionrestore', 14:34:31 INFO - 'sessionrestore_no_auto_restore', 14:34:31 INFO - 'tabpaint']}, 14:34:31 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 14:34:31 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 14:34:31 INFO - 'bloom_basic_ref']}, 14:34:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:34:31 INFO - 'tests': ['tsvgx', 14:34:31 INFO - 'tsvgr_opacity', 14:34:31 INFO - 'tart', 14:34:31 INFO - 'tscrollx', 14:34:31 INFO - 'cart', 14:34:31 INFO - 'tsvg_static']}, 14:34:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:34:31 INFO - 'tsvgr_opacity', 14:34:31 INFO - 'tart', 14:34:31 INFO - 'tscrollx', 14:34:31 INFO - 'cart', 14:34:31 INFO - 'tsvg_static']}, 14:34:31 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:34:31 INFO - 'talos_options': ['--disable-e10s'], 14:34:31 INFO - 'tests': ['tp5o']}, 14:34:31 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:34:31 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:34:31 INFO - 'talos_options': ['--disable-e10s', 14:34:31 INFO - '--xperf_path', 14:34:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:34:31 INFO - 'tests': ['tp5n']}, 14:34:31 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:34:31 INFO - 'talos_options': ['--xperf_path', 14:34:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:34:31 INFO - 'tests': ['tp5n']}}, 14:34:31 INFO - 'talos.zip': {'path': '', 14:34:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:34:31 INFO - Running post-action listener: _resource_record_post_action 14:34:31 INFO - [mozharness: 2017-04-27 21:34:31.023183Z] Finished populate-webroot step (success) 14:34:31 INFO - [mozharness: 2017-04-27 21:34:31.023309Z] Running create-virtualenv step. 14:34:31 INFO - Running pre-action listener: _resource_record_pre_action 14:34:31 INFO - Running main action method: create_virtualenv 14:34:31 INFO - Creating virtualenv /builds/slave/test/build/venv 14:34:31 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 14:34:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:34:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:34:31 INFO - Using real prefix '/tools/python27' 14:34:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:34:31 INFO - Installing distribute.............................................................................................................................................................................................done. 14:34:34 INFO - Installing pip.................done. 14:34:34 INFO - Return code: 0 14:34:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:34:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:34:35 INFO - Reading from file tmpfile_stdout 14:34:35 INFO - Output received: 14:34:35 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) 14:34:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:34:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:34:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:34:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:35 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 0x108776b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108779768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff39857b050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108554d30>, '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 0x10847adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108549be8>, '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.4DDkWCO3Qi/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.DXafM68OwS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/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 14:34:35 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 14:34:35 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 14:34:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4DDkWCO3Qi/Render', 14:34:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:34:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:34:35 INFO - 'HOME': '/Users/cltbld', 14:34:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:34:35 INFO - 'LOGNAME': 'cltbld', 14:34:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:35 INFO - 'MOZ_NO_REMOTE': '1', 14:34:35 INFO - 'NO_EM_RESTART': '1', 14:34:35 INFO - 'PAGER': '/bin/cat', 14:34:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:34:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:35 INFO - 'PWD': '/builds/slave/test', 14:34:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:34:35 INFO - 'SHELL': '/bin/bash', 14:34:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DXafM68OwS/Listeners', 14:34:35 INFO - 'TMPDIR': '/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/', 14:34:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:34:35 INFO - 'USER': 'cltbld', 14:34:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:34:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:34:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:35 INFO - 'XPC_FLAGS': '0x0', 14:34:35 INFO - 'XPC_SERVICE_NAME': '0', 14:34:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:34:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:35 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 14:34:35 INFO - Cleaning up... 14:34:35 INFO - Return code: 0 14:34:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:34:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:34:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:34:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:35 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 0x108776b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108779768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff39857b050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108554d30>, '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 0x10847adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108549be8>, '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.4DDkWCO3Qi/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.DXafM68OwS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/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 14:34:35 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 14:34:35 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 14:34:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4DDkWCO3Qi/Render', 14:34:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:34:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:34:35 INFO - 'HOME': '/Users/cltbld', 14:34:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:34:35 INFO - 'LOGNAME': 'cltbld', 14:34:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:35 INFO - 'MOZ_NO_REMOTE': '1', 14:34:35 INFO - 'NO_EM_RESTART': '1', 14:34:35 INFO - 'PAGER': '/bin/cat', 14:34:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:34:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:35 INFO - 'PWD': '/builds/slave/test', 14:34:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:34:35 INFO - 'SHELL': '/bin/bash', 14:34:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DXafM68OwS/Listeners', 14:34:35 INFO - 'TMPDIR': '/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/', 14:34:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:34:35 INFO - 'USER': 'cltbld', 14:34:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:34:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:34:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:35 INFO - 'XPC_FLAGS': '0x0', 14:34:35 INFO - 'XPC_SERVICE_NAME': '0', 14:34:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:34:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:35 INFO - Downloading/unpacking psutil>=3.1.1 14:34:35 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 14:34:35 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 14:34:35 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 14:34:35 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 14:34:35 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 14:34:35 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 14:34:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:34:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:34:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:34:39 INFO - Installing collected packages: psutil 14:34:39 INFO - Running setup.py install for psutil 14:34:39 INFO - building 'psutil._psutil_osx' extension 14:34:39 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 14:34:39 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 14:34:39 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 14:34:39 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 14:34:39 INFO - building 'psutil._psutil_posix' extension 14:34:39 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 14:34:39 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:34:39 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:34:39 INFO - ^ 14:34:40 INFO - 1 warning generated. 14:34:40 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 14:34:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:34:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:34:40 INFO - Successfully installed psutil 14:34:40 INFO - Cleaning up... 14:34:40 INFO - Return code: 0 14:34:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:34:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:34:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:34:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:40 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 0x108776b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108779768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff39857b050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108554d30>, '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 0x10847adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108549be8>, '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.4DDkWCO3Qi/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.DXafM68OwS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/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 14:34:40 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 14:34:40 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 14:34:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4DDkWCO3Qi/Render', 14:34:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:34:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:34:40 INFO - 'HOME': '/Users/cltbld', 14:34:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:34:40 INFO - 'LOGNAME': 'cltbld', 14:34:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:40 INFO - 'MOZ_NO_REMOTE': '1', 14:34:40 INFO - 'NO_EM_RESTART': '1', 14:34:40 INFO - 'PAGER': '/bin/cat', 14:34:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:34:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:40 INFO - 'PWD': '/builds/slave/test', 14:34:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:34:40 INFO - 'SHELL': '/bin/bash', 14:34:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DXafM68OwS/Listeners', 14:34:40 INFO - 'TMPDIR': '/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/', 14:34:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:34:40 INFO - 'USER': 'cltbld', 14:34:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:34:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:34:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:40 INFO - 'XPC_FLAGS': '0x0', 14:34:40 INFO - 'XPC_SERVICE_NAME': '0', 14:34:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:34:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:34:40 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 14:34:40 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 14:34:40 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 14:34:40 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 14:34:40 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 14:34:40 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 14:34:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:34:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:34:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:34:43 INFO - Installing collected packages: mozsystemmonitor 14:34:43 INFO - Running setup.py install for mozsystemmonitor 14:34:43 INFO - Successfully installed mozsystemmonitor 14:34:43 INFO - Cleaning up... 14:34:43 INFO - Return code: 0 14:34:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:34: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')]} 14:34:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34: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')]} 14:34:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108776b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108779768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff39857b050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108554d30>, '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 0x10847adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108549be8>, '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.4DDkWCO3Qi/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.DXafM68OwS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/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 14:34:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:34:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:34:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4DDkWCO3Qi/Render', 14:34:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:34:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:34:44 INFO - 'HOME': '/Users/cltbld', 14:34:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:34:44 INFO - 'LOGNAME': 'cltbld', 14:34:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:44 INFO - 'MOZ_NO_REMOTE': '1', 14:34:44 INFO - 'NO_EM_RESTART': '1', 14:34:44 INFO - 'PAGER': '/bin/cat', 14:34:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:34:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:44 INFO - 'PWD': '/builds/slave/test', 14:34:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:34:44 INFO - 'SHELL': '/bin/bash', 14:34:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DXafM68OwS/Listeners', 14:34:44 INFO - 'TMPDIR': '/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/', 14:34:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:34:44 INFO - 'USER': 'cltbld', 14:34:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:34:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:34:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:44 INFO - 'XPC_FLAGS': '0x0', 14:34:44 INFO - 'XPC_SERVICE_NAME': '0', 14:34:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:34:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:44 INFO - Downloading/unpacking jsonschema==2.5.1 14:34:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:34:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:34:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:34:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:34:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:34:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:34:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:34:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:34:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:34:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:34:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:34:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:34:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:34:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:34:47 INFO - Downloading functools32-3.2.3-2.tar.gz 14:34:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:34:48 INFO - warning: no files found matching '*.txt' 14:34:48 INFO - no previously-included directories found matching 'build' 14:34:48 INFO - no previously-included directories found matching 'dist' 14:34:48 INFO - no previously-included directories found matching '.git*' 14:34:48 INFO - Installing collected packages: jsonschema, functools32 14:34:48 INFO - Running setup.py install for functools32 14:34:48 INFO - warning: no files found matching '*.txt' 14:34:48 INFO - no previously-included directories found matching 'build' 14:34:48 INFO - no previously-included directories found matching 'dist' 14:34:48 INFO - no previously-included directories found matching '.git*' 14:34:48 INFO - Successfully installed jsonschema functools32 14:34:48 INFO - Cleaning up... 14:34:48 INFO - Return code: 0 14:34:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:34:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:34:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108776b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108779768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff39857b050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108554d30>, '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 0x10847adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108549be8>, '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.4DDkWCO3Qi/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.DXafM68OwS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/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 14:34:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:34:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:34:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4DDkWCO3Qi/Render', 14:34:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:34:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:34:48 INFO - 'HOME': '/Users/cltbld', 14:34:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:34:48 INFO - 'LOGNAME': 'cltbld', 14:34:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:48 INFO - 'MOZ_NO_REMOTE': '1', 14:34:48 INFO - 'NO_EM_RESTART': '1', 14:34:48 INFO - 'PAGER': '/bin/cat', 14:34:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:34:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:48 INFO - 'PWD': '/builds/slave/test', 14:34:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:34:48 INFO - 'SHELL': '/bin/bash', 14:34:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DXafM68OwS/Listeners', 14:34:48 INFO - 'TMPDIR': '/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/', 14:34:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:34:48 INFO - 'USER': 'cltbld', 14:34:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:34:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:34:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:48 INFO - 'XPC_FLAGS': '0x0', 14:34:48 INFO - 'XPC_SERVICE_NAME': '0', 14:34:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:34:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:34:48 INFO - Cleaning up... 14:34:48 INFO - Return code: 0 14:34:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:34:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:34:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108776b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108779768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff39857b050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108554d30>, '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 0x10847adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108549be8>, '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.4DDkWCO3Qi/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.DXafM68OwS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/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 14:34:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:34:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:34:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4DDkWCO3Qi/Render', 14:34:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:34:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:34:48 INFO - 'HOME': '/Users/cltbld', 14:34:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:34:48 INFO - 'LOGNAME': 'cltbld', 14:34:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:48 INFO - 'MOZ_NO_REMOTE': '1', 14:34:48 INFO - 'NO_EM_RESTART': '1', 14:34:48 INFO - 'PAGER': '/bin/cat', 14:34:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:34:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:48 INFO - 'PWD': '/builds/slave/test', 14:34:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:34:48 INFO - 'SHELL': '/bin/bash', 14:34:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DXafM68OwS/Listeners', 14:34:48 INFO - 'TMPDIR': '/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/', 14:34:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:34:48 INFO - 'USER': 'cltbld', 14:34:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:34:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:34:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:48 INFO - 'XPC_FLAGS': '0x0', 14:34:48 INFO - 'XPC_SERVICE_NAME': '0', 14:34:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:34:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:48 INFO - Downloading/unpacking blobuploader==1.2.4 14:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:34:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:34:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:34:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:34:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:34:51 INFO - Downloading blobuploader-1.2.4.tar.gz 14:34:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:34:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:34: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 14:34: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 14:34: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 14:34: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 14:34: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 14:34: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 14:34:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:34:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:34:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:34:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:34:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:34:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:34:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:34:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:34:52 INFO - Downloading docopt-0.6.1.tar.gz 14:34:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:34:52 INFO - Installing collected packages: blobuploader, requests, docopt 14:34:52 INFO - Running setup.py install for blobuploader 14:34:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:34:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:34:53 INFO - Running setup.py install for requests 14:34:53 INFO - Running setup.py install for docopt 14:34:53 INFO - Successfully installed blobuploader requests docopt 14:34:53 INFO - Cleaning up... 14:34:53 INFO - Return code: 0 14:34:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:34:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:34:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:34:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108776b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108779768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff39857b050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108554d30>, '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 0x10847adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108549be8>, '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.4DDkWCO3Qi/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.DXafM68OwS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/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 14:34:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:34:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:34:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4DDkWCO3Qi/Render', 14:34:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:34:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:34:53 INFO - 'HOME': '/Users/cltbld', 14:34:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:34:53 INFO - 'LOGNAME': 'cltbld', 14:34:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:53 INFO - 'MOZ_NO_REMOTE': '1', 14:34:53 INFO - 'NO_EM_RESTART': '1', 14:34:53 INFO - 'PAGER': '/bin/cat', 14:34:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:34:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:53 INFO - 'PWD': '/builds/slave/test', 14:34:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:34:53 INFO - 'SHELL': '/bin/bash', 14:34:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DXafM68OwS/Listeners', 14:34:53 INFO - 'TMPDIR': '/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/', 14:34:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:34:53 INFO - 'USER': 'cltbld', 14:34:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:34:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:34:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:53 INFO - 'XPC_FLAGS': '0x0', 14:34:53 INFO - 'XPC_SERVICE_NAME': '0', 14:34:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:34:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:34:54 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-UEdYDR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:34:54 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-3l2V9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:34:54 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-n37N81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:34:54 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-DK6WiM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:34:54 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-QSVufg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:34:54 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-W6crDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:34:54 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-U4cCnO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:34:54 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-8vMEuK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:34:54 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-hR86Mi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:34:54 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-qg8fi6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:34:55 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-oilHkX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:34:55 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-BxyKij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:34:55 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-yNriGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:34:55 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-1OZTXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:34:55 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-zT28IF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:34:55 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-1LT77e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:34:55 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-UknGFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:34:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:34:55 INFO - Running setup.py install for manifestparser 14:34:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:34:55 INFO - Running setup.py install for mozcrash 14:34:56 INFO - Running setup.py install for mozdebug 14:34:56 INFO - Running setup.py install for mozdevice 14:34:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:34:56 INFO - Running setup.py install for mozfile 14:34:56 INFO - Running setup.py install for mozhttpd 14:34:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:34:56 INFO - Running setup.py install for mozinfo 14:34:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:34:56 INFO - Running setup.py install for mozInstall 14:34:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:34:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:34:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:34:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:34:56 INFO - Running setup.py install for mozleak 14:34:57 INFO - Running setup.py install for mozlog 14:34:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:34:57 INFO - Running setup.py install for moznetwork 14:34:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:34:57 INFO - Running setup.py install for mozprocess 14:34:57 INFO - Running setup.py install for mozprofile 14:34:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:34:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:34:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:34:57 INFO - Running setup.py install for mozrunner 14:34:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:34:57 INFO - Running setup.py install for mozscreenshot 14:34:58 INFO - Running setup.py install for moztest 14:34:58 INFO - Running setup.py install for mozversion 14:34:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:34:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:34:58 INFO - Cleaning up... 14:34:58 INFO - Return code: 0 14:34:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:34:58 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')]} 14:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:58 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')]} 14:34:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:58 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 0x108776b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108779768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff39857b050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108554d30>, '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 0x10847adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108549be8>, '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.4DDkWCO3Qi/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.DXafM68OwS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/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 14:34:58 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 14:34:58 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 14:34:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4DDkWCO3Qi/Render', 14:34:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:34:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:34:58 INFO - 'HOME': '/Users/cltbld', 14:34:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:34:58 INFO - 'LOGNAME': 'cltbld', 14:34:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:58 INFO - 'MOZ_NO_REMOTE': '1', 14:34:58 INFO - 'NO_EM_RESTART': '1', 14:34:58 INFO - 'PAGER': '/bin/cat', 14:34:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:34:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:58 INFO - 'PWD': '/builds/slave/test', 14:34:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:34:58 INFO - 'SHELL': '/bin/bash', 14:34:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DXafM68OwS/Listeners', 14:34:58 INFO - 'TMPDIR': '/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/', 14:34:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:34:58 INFO - 'USER': 'cltbld', 14:34:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:34:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:34:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:58 INFO - 'XPC_FLAGS': '0x0', 14:34:58 INFO - 'XPC_SERVICE_NAME': '0', 14:34:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:34:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:34:58 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-JsGGjc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:34:58 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)) 14:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:34:58 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-ox7SDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:34:58 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)) 14:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:34:58 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-ynij3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:34:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:34:58 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-yvnIcJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:34:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 14:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:34:59 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-HvDMBJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:34:59 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)) 14:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:34:59 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-4llXnl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:34:59 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)) 14:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:34:59 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-hMgeqO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:34:59 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)) 14:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:34:59 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-FYidu6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:34:59 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)) 14:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:34:59 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-DgUPQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:34:59 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)) 14:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:34:59 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-HBkVFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:34:59 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)) 14:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:34:59 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-jAKnNn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:34:59 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)) 14:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:34:59 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-xci0My-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:34:59 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)) 14:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:34:59 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-hjDdDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:34:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:35:00 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-VMa6q2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:35:00 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)) 14:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:35:00 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-xpkRZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:35:00 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)) 14:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:35:00 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-EZveq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:35:00 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)) 14:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:35:00 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-XSIqQS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:35:00 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)) 14:35:00 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)) 14:35:00 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)) 14:35:00 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)) 14:35:00 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:35:00 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:35:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:35:00 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 14:35:00 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 14:35:00 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 14:35:00 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 14:35:00 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 14:35:00 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 14:35:02 INFO - Downloading blessings-1.6.tar.gz 14:35:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:35:03 INFO - Installing collected packages: blessings 14:35:03 INFO - Running setup.py install for blessings 14:35:03 INFO - Successfully installed blessings 14:35:03 INFO - Cleaning up... 14:35:03 INFO - Return code: 0 14:35:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:35:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:35:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:35:03 INFO - Reading from file tmpfile_stdout 14:35:03 INFO - Current package versions: 14:35:03 INFO - blessings == 1.6 14:35:03 INFO - blobuploader == 1.2.4 14:35:03 INFO - docopt == 0.6.1 14:35:03 INFO - functools32 == 3.2.3-2 14:35:03 INFO - jsonschema == 2.5.1 14:35:03 INFO - manifestparser == 1.1 14:35:03 INFO - mozInstall == 1.12 14:35:03 INFO - mozcrash == 1.0 14:35:03 INFO - mozdebug == 0.1 14:35:03 INFO - mozdevice == 0.50 14:35:03 INFO - mozfile == 1.2 14:35:03 INFO - mozhttpd == 0.7 14:35:03 INFO - mozinfo == 0.9 14:35:03 INFO - mozleak == 0.1 14:35:03 INFO - mozlog == 3.4 14:35:03 INFO - moznetwork == 0.27 14:35:03 INFO - mozprocess == 0.25 14:35:03 INFO - mozprofile == 0.28 14:35:03 INFO - mozrunner == 6.13 14:35:03 INFO - mozscreenshot == 0.1 14:35:03 INFO - mozsystemmonitor == 0.3 14:35:03 INFO - moztest == 0.8 14:35:03 INFO - mozversion == 1.4 14:35:03 INFO - psutil == 3.1.1 14:35:03 INFO - requests == 1.2.3 14:35:03 INFO - wsgiref == 0.1.2 14:35:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:35:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:03 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 0x108776b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108779768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff39857b050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108554d30>, '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 0x10847adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108549be8>, '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.4DDkWCO3Qi/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.DXafM68OwS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/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 14:35:03 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 14:35:03 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 14:35:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4DDkWCO3Qi/Render', 14:35:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:35:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:35:03 INFO - 'HOME': '/Users/cltbld', 14:35:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:35:03 INFO - 'LOGNAME': 'cltbld', 14:35:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:03 INFO - 'MOZ_NO_REMOTE': '1', 14:35:03 INFO - 'NO_EM_RESTART': '1', 14:35:03 INFO - 'PAGER': '/bin/cat', 14:35:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:35:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:03 INFO - 'PWD': '/builds/slave/test', 14:35:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:35:03 INFO - 'SHELL': '/bin/bash', 14:35:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DXafM68OwS/Listeners', 14:35:03 INFO - 'TMPDIR': '/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/', 14:35:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:35:03 INFO - 'USER': 'cltbld', 14:35:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:35:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:35:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:03 INFO - 'XPC_FLAGS': '0x0', 14:35:03 INFO - 'XPC_SERVICE_NAME': '0', 14:35:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:35:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:03 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)) 14:35:03 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)) 14:35:03 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)) 14:35:03 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)) 14:35:03 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)) 14:35:03 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)) 14:35:03 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)) 14:35:03 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)) 14:35:03 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)) 14:35:03 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)) 14:35:03 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)) 14:35:03 INFO - Cleaning up... 14:35:03 INFO - Return code: 0 14:35:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:35:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108776b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108779768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff39857b050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108554d30>, '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 0x10847adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108549be8>, '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.4DDkWCO3Qi/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.DXafM68OwS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/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 14:35:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:35:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:35:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4DDkWCO3Qi/Render', 14:35:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:35:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:35:03 INFO - 'HOME': '/Users/cltbld', 14:35:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:35:03 INFO - 'LOGNAME': 'cltbld', 14:35:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:03 INFO - 'MOZ_NO_REMOTE': '1', 14:35:03 INFO - 'NO_EM_RESTART': '1', 14:35:03 INFO - 'PAGER': '/bin/cat', 14:35:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:35:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:03 INFO - 'PWD': '/builds/slave/test', 14:35:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:35:03 INFO - 'SHELL': '/bin/bash', 14:35:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DXafM68OwS/Listeners', 14:35:03 INFO - 'TMPDIR': '/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/', 14:35:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:35:03 INFO - 'USER': 'cltbld', 14:35:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:35:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:35:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:03 INFO - 'XPC_FLAGS': '0x0', 14:35:03 INFO - 'XPC_SERVICE_NAME': '0', 14:35:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:35:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:35:04 INFO - Cleaning up... 14:35:04 INFO - Return code: 0 14:35:04 INFO - Running post-action listener: _resource_record_post_action 14:35:04 INFO - Running post-action listener: _start_resource_monitoring 14:35:04 INFO - Starting resource monitoring. 14:35:04 INFO - [mozharness: 2017-04-27 21:35:04.202820Z] Finished create-virtualenv step (success) 14:35:04 INFO - [mozharness: 2017-04-27 21:35:04.203811Z] Running install step. 14:35:04 INFO - Running pre-action listener: _resource_record_pre_action 14:35:04 INFO - Running main action method: install 14:35:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:35:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:35:04 INFO - Reading from file tmpfile_stdout 14:35:04 INFO - Detecting whether we're running mozinstall >=1.0... 14:35:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:35:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:35:04 INFO - Reading from file tmpfile_stdout 14:35:04 INFO - Output received: 14:35:04 INFO - Usage: mozinstall [options] installer 14:35:04 INFO - Options: 14:35:04 INFO - -h, --help show this help message and exit 14:35:04 INFO - -d DEST, --destination=DEST 14:35:04 INFO - Directory to install application into. [default: 14:35:04 INFO - "/builds/slave/test"] 14:35:04 INFO - --app=APP Application being installed. [default: firefox] 14:35:04 INFO - mkdir: /builds/slave/test/build/application 14:35:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:35:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 14:35:24 INFO - Reading from file tmpfile_stdout 14:35:24 INFO - Output received: 14:35:24 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:35:24 INFO - Running post-action listener: _resource_record_post_action 14:35:24 INFO - [mozharness: 2017-04-27 21:35:24.351257Z] Finished install step (success) 14:35:24 INFO - [mozharness: 2017-04-27 21:35:24.351418Z] Running run-tests step. 14:35:24 INFO - Running pre-action listener: _resource_record_pre_action 14:35:24 INFO - Running main action method: run_tests 14:35:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:35:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:35:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:35:24 INFO - 2017-04-27 14:35:24.365 screenresolution[1623:7257] starting screenresolution argv=screenresolution get 14:35:24 INFO - 2017-04-27 14:35:24.368 screenresolution[1623:7257] Display 0: 1600x1200x32@60 14:35:24 INFO - 2017-04-27 14:35:24.374 screenresolution[1624:7259] starting screenresolution argv=screenresolution list 14:35:24 INFO - Available Modes on Display 0 14:35:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:35:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:35:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:35:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:35:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:35:24 INFO - Intel Iris: 14:35:24 INFO - Chipset Model: Intel Iris 14:35:24 INFO - Type: GPU 14:35:24 INFO - Bus: Built-In 14:35:24 INFO - VRAM (Dynamic, Max): 1536 MB 14:35:24 INFO - Vendor: Intel (0x8086) 14:35:24 INFO - Device ID: 0x0a2e 14:35:24 INFO - Revision ID: 0x0009 14:35:24 INFO - Displays: 14:35:24 INFO - Display: 14:35:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:35:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:35:24 INFO - Display Serial Number: 1600x1200 60 14:35:24 INFO - Main Display: Yes 14:35:24 INFO - Mirror: Off 14:35:24 INFO - Online: Yes 14:35:24 INFO - Rotation: Supported 14:35:24 INFO - Return code: 0 14:35:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:35:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:35:24 INFO - Python 2.7.3 14:35:24 INFO - Return code: 0 14:35:24 INFO - grabbing minidump binary from tooltool 14:35:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:24 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 0x108554d30>, '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 0x10847adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108549be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:35:24 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 14:35:24 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 14:35:24 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 14:35:24 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:35:24 INFO - Return code: 0 14:35:24 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:35:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:35:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:35:24 INFO - ENV: RUST_BACKTRACE is now 1 14:35:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:35:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:35:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0360', '--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 14:35:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0360 --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 14:35:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4DDkWCO3Qi/Render', 14:35:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:35:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:35:24 INFO - 'HOME': '/Users/cltbld', 14:35:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:35:24 INFO - 'LOGNAME': 'cltbld', 14:35:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:35:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:35:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:24 INFO - 'MOZ_NO_REMOTE': '1', 14:35:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:35:24 INFO - 'NO_EM_RESTART': '1', 14:35:24 INFO - 'PAGER': '/bin/cat', 14:35:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:35:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:24 INFO - 'PWD': '/builds/slave/test', 14:35:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:35:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:35:24 INFO - 'RUST_BACKTRACE': '1', 14:35:24 INFO - 'SHELL': '/bin/bash', 14:35:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DXafM68OwS/Listeners', 14:35:24 INFO - 'TMPDIR': '/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/', 14:35:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:35:24 INFO - 'USER': 'cltbld', 14:35:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:35:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:35:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:24 INFO - 'XPC_FLAGS': '0x0', 14:35:24 INFO - 'XPC_SERVICE_NAME': '0', 14:35:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:35:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0360', '--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 14:35:24 INFO - mozversion application_buildid: 20170427130024 14:35:24 INFO - mozversion application_changeset: 2cca333f546f38860f84940d4c72d7470a3410f4 14:35:24 INFO - mozversion application_display_name: Nightly 14:35:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:35:24 INFO - mozversion application_name: Firefox 14:35:24 INFO - mozversion application_remotingname: firefox 14:35:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:35:24 INFO - mozversion application_vendor: Mozilla 14:35:24 INFO - mozversion application_version: 55.0a1 14:35:24 INFO - mozversion platform_buildid: 20170427130024 14:35:24 INFO - mozversion platform_changeset: 2cca333f546f38860f84940d4c72d7470a3410f4 14:35:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:35:24 INFO - mozversion platform_version: 55.0a1 14:35:24 INFO - using testdate: 1493328924 14:35:24 INFO - actual date: 1493328924 14:35:24 INFO - starting webserver on 'localhost:49228' 14:35:24 INFO - SUITE-START | Running 2 tests 14:35:24 INFO - TEST-START | dromaeo_css 14:35:24 INFO - operating with platform_type : mac_ 14:35:24 INFO - Initialising browser for dromaeo_css test... 14:35:24 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/tmpcuxnlH/profile http://localhost:49228/getInfo.html) 14:35:27 INFO - PID 1634 | __metrics Screen width/height:1600/1200 14:35:27 INFO - PID 1634 | colorDepth:24 14:35:27 INFO - PID 1634 | Browser inner width/height: 1024/689 14:35:27 INFO - PID 1634 | __metrics 14:35:27 INFO - PID 1634 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:35:27 INFO - PID 1634 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:35:28 INFO - TEST-INFO | 1634: exit 0 14:35:28 INFO - Browser initialized. 14:35:28 INFO - Running cycle 1/1 for dromaeo_css test... 14:35:28 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/tmpcuxnlH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:35:40 INFO - PID 1636 | RSS: Main: 241455104 14:35:40 INFO - PID 1636 | 14:38:45 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49228/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49228/tests/dromaeo/cssquery-ext.html) 14:38:47 INFO - PID 1636 | RSS: Main: 389472256 14:38:47 INFO - PID 1636 | 14:40:30 INFO - PID 1636 | ************************* 14:40:30 INFO - PID 1636 | A coding exception was thrown and uncaught in a Task. 14:40:30 INFO - PID 1636 | 14:40:30 ERROR - PID 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:40:30 INFO - PID 1636 | Full stack: 14:40:30 INFO - PID 1636 | ************************* 14:40:30 INFO - PID 1636 | ************************* 14:40:30 INFO - PID 1636 | A coding exception was thrown and uncaught in a Task. 14:40:30 INFO - PID 1636 | 14:40:30 ERROR - PID 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:40:30 INFO - PID 1636 | Full stack: 14:40:30 INFO - PID 1636 | ************************* 14:40:30 INFO - PID 1636 | ************************* 14:40:30 INFO - PID 1636 | A coding exception was thrown and uncaught in a Task. 14:40:30 INFO - PID 1636 | 14:40:30 ERROR - PID 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:40:30 INFO - PID 1636 | Full stack: 14:40:30 INFO - PID 1636 | ************************* 14:40:30 INFO - PID 1636 | ************************* 14:40:30 INFO - PID 1636 | A coding exception was thrown and uncaught in a Task. 14:40:30 INFO - PID 1636 | 14:40:30 ERROR - PID 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:40:30 INFO - PID 1636 | Full stack: 14:40:30 INFO - PID 1636 | ************************* 14:41:50 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49228/tests/dromaeo/cssquery-ext.html (next: http://localhost:49228/tests/dromaeo/cssquery-jquery.html) 14:41:50 INFO - PID 1636 | RSS: Main: 370188288 14:41:50 INFO - PID 1636 | 14:44:53 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49228/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49228/tests/dromaeo/cssquery-mootools.html) 14:44:53 INFO - PID 1636 | RSS: Main: 339550208 14:44:53 INFO - PID 1636 | 14:47:55 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49228/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49228/tests/dromaeo/cssquery-prototype.html) 14:47:56 INFO - PID 1636 | RSS: Main: 324255744 14:47:56 INFO - PID 1636 | 14:51:00 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49228/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49228/tests/dromaeo/cssquery-yui.html) 14:51:00 INFO - PID 1636 | RSS: Main: 333918208 14:51:00 INFO - PID 1636 | 14:54:03 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49228/tests/dromaeo/cssquery-yui.html (next: http://localhost:49228/tests/dromaeo/cssquery-dojo.html) 14:54:03 INFO - PID 1636 | RSS: Main: 376107008 14:54:03 INFO - PID 1636 | 14:54:03 INFO - PID 1636 | __start_tp_report 14:54:03 INFO - PID 1636 | _x_x_mozilla_page_load 14:54:03 INFO - PID 1636 | _x_x_mozilla_page_load_details 14:54:03 INFO - PID 1636 | |i|pagename|runs| 14:54:03 INFO - PID 1636 | |0;dojo.html;3504.071421073416;3514.5958214805296;3532.046347486177;3540.8583656653736;3587.1749497615547;5995.220621319233;6106.877862442749;6169.5989760665525;6177.135201071848;6183.78356757513;6109.495762817165;6129.938700612993;6167.167432396625;6185.814425567229;6187.412195841388;5160.8709782255555;5336.839894803162;5338.119210330291;5351.197320401932;5388.892222155555;5461.453854614527;5466.562674986011;5488.9725551372185;5516.862078448051;5520.227168196456;5269.578433725293;5421.457854214586;5441.673499589998;5464.9453505465035;5478.315210598676;5316.20256961455;5338.172583249602;5407.026735187665;5462.945370546284;5472;5392.137258038695;5398.2982212312545;5411.702356370398;5425.810096646638;5443.42844001382;6170.382961703794;6177.474914632262;6184.721687524072;6189.2572891252885;6233.438990490832;6275.372462753734;6340.619562826245;6367.172267605228;6550.475961923034;6571.44142747867;6584.144061272004;6655.301193374675;6659;6674.399304062657;6682.599044057323;6151.876962460726;6180.81457556265;6238.220222472191;6239.407256310643;6250.562460627803;6449.064885591657;6778.254392016875;6780.491463140284;6786.524943254023;6797.66011699423;5241.764120614582;6323.988161894074;6334.144890439824;6393.392627700361;6405.903911441332;6614.900776488356;6615.206175259;6617.966910165418;6625.801225963132;6635.469162466991;6073.878522429615;6121.234845644294;6476.740930362733;6490.0589414534625;6508.869822603521;5239.816606418757;5280.603954703336;6310.810675679737;6343.492520598341;6429;5206.088934436459;5233.581313494911;5234.398044224963;5239.73801309933;5282.498162674539;4628.907421851544;4676.766161691902;4685.906281874343;4699.130660827758;4726.787294571753;6060.575759696867;6087.391260873877;6118.771466971993;6124.777645458507;6215.409536094064;6345.904811427832;6411.551191416556;6419.839504012437;6432.2281326241155;6432.581882177644;6094.421030002142;6094.421030002142;6096.725647345791;6107.175531303306;6115.816525504242;5655.688937108416;5666.744996475169;5675.687837168995;5682.829515114553;5685;6559.983202603604;6561.015847622894;6573.539852210395;6730.629815360202;6838.897416538656;6569.047488114101;6619.172603424572;6659.101021362054;6690.264070952288;6707.42986846104;5703.657780533182;6504.252011018793;6728.697208625722;6815.352541508549;6817.7272909083085;6266.185395898504;6347.0479428086155;6525.282218956006;6550.246721627074;6554.967225163844;6419.325970773189;6532.608043517404;6547.672616369257;6548.770793022221;6606.141201643755;6231.813045608639;6367.981123020295;6373.267074286517;6386.68066596659;6396.008618664115;6383.648899310582;6384.840378990377;6386.616802991835;6387.936120638734;6390.90413643805;6165.475934545434;6253.374662533893;6258.843528911813;6284.340144284784;6293.465055470337;5348.5186333230195;6390.936090639034;6408.455281301141;6414.03789431589;6423.132877061536;6183;6269.279032911274;6273.592216505913;6275.937240627535;6281.371862813682 14:54:03 INFO - PID 1636 | |1;ext.html;797.9521228726276;1113.0427832064422;1116.2576886370564;1116.8492253545771;1243.8009918413045;33663;34703.305933881304;37436.43845342315;37592;37595;37332.06669833256;37576.62423375772;37666.86999390016;37719.622803771956;37738.24523509528;7822.647980840876;7977.800554986114;7984.760457186265;7985.081715602722;7989.280964713174;6004.309504406983;6120.296165940907;7606.467547271694;8557;8560.571971401436;8624.008239052526;8649.740507784745;8661.437006594582;8664.39349245553;8669.089745576719;8555.144485551456;8622.267107295887;8629.007664118644;8640.265577425926;8641.65433382664;5967.283925928873;6047.516198704093;8246.670133194664;8378.078411374743;8382.916170838274;33619.82330618441;34430.48354274688;37114.628853711656;37401.81299093514;37465.06337341561;3594.5327107476123;3634.018814919983;3642.4354225095153;3644;3649.8905032849057;30442.54336184959;30557.38885222283;30571;30592;30633.46832658358;3060.8010479318773;3105.8602362893726;3118.033409643018;3146.6381366142728;3149.086764838194;282197.5890120536;290650.5467472649;291595;292038;292402.53798731085;39134.02164945899;48624.02751945012;48737.5126248733;48879.02241955141;48910;39740.801295993915;40613.59386406157;40749.59250407458;49122.50877491251;49124;13667.658308542168;13753.862461375458;13754;13766.862331376558;13768.24274664883;11209.271397359145;11217;11221;11228.66314010581;11257.718557035976;12314.876851231553;12332.691682707824;12352.25886446816;12358.44387002587;12484.687882803002;5193.1171700810955;5235.942144837782;5239.266502689627;5241.371035475768;5250.238715386324;1027.7482016905906;1030.2376241581326;1035.2649618770606;1059.5285098131258;1076.160594736107;23346.64980025301;24509.264722058368;24547;24549.877250613634;24569.754302457106;1115.5593540551438;1116.7543140509074;1153.7865494883474;1155.6590805712335;1177.5584155941522;12298.754024919452;12413.379331033413;12479.064070194772;12554.246745195318;12570.748585028432;273067.63466182543;274530;274686;275109;275707;52805;52818.679533011215;52865;52865.94268114616;52904;1504.0449314685254;1548.7367147584937;1555.688862227559;1559.485369827954;1561.625209949604;23909.641355379335;24054;24081.879590601933;24091.397715057265;24105.276841694777;37910.431343529315;37936.39604237593;37972.81013595025;38007.619923800405;38063.42904856374;271967;273046;273263;273425;273579;33702.98891033273;33858.83070584631;34777.65222347846;34820.82589587036;34840;42868;44666.10667786691;45100;45129.774351128035;45352;28946;29705.554416683335;30048.549271761378;31182.68817311798;31253.843730781202;24576.385590360384;30619;30668.07995760131;30944;31135.532967005965;29783.21300721877;35966.820165899;36386.90839274826;37167.442488362154;37248.44127338146;30272.789088436217;30880.845595771876;31217.687823122385;31296.843515782275;31498.68501315049;22861.161182972406;23721.52556948886;24217.757822422256;24411.75588244166;24667.62998555059 14:54:03 INFO - PID 1636 | |2;jquery.html;390.9081365879016;429.12472495196;438.1346839991018;441.81885426974947;460.132649954835;16667.583310417245;20845.791542084593;21982.34052978409;22056.779432205694;22295.554088918252;19075.523111922208;22123.89380530971;22632;22835.429114272152;22997.540049199008;4618.445786505624;5967.164596956419;5982.754547602183;6148.692565371736;6211.260846962858;6002.819915402523;6097.939020609781;6119.724612392453;6122.96938515309;6123.234595675541;5908.88182236355;5920.111983202532;5965.075413310922;6059.39406059395;6063.575549711522;5985.221921150266;6057.3336932937345;6064.514838812885;6066.363031881633;6066.484348830355;5134.614903882187;5325.8934821303355;5391.487808658171;5401.810936617199;5402.540784033362;26658.600120998202;26852;27048.64756762154;27604;27618.309542261402;2168.2194410012385;2225.5660146271484;2233.1514024670682;2236.1726161320253;2237.787410196045;17180.656386872317;17234;17674.91162544192;17680.381186658404;17907.641847162984;2066.5660211355635;2068.2864411777914;2129.7018417421573;2131.6695912133646;2139.850210485267;131420;138060.30969845186;152402.95194096057;152964.17589560128;153515;11350.54597816078;11681.532738690357;11928.46321915516;12451.564195253122;12594.866462018279;14675.77986330206;16241.593960150854;16513.587160321087;16672.583185420463;16676.58308542272;8312.836202931594;8913.55432228386;8927.375083744075;9187.26501879848;9188.127127922837;7814.140444551095;8506.36202284831;8547;8559.74320770378;8741.956290218508;7790.610469476504;7895.289423951872;7896.486728362638;7918.168592297841;7923.811428285803;2179.7057397251483;2187.8951129679726;2192.596738087625;2193.7915897989665;2354.83516153871;947.5025611553989;947.8909925358535;952.2857856607544;975.3903810118676;988.9011098890054;21008.474788130417;21645.134194632352;21703.78296217049;21959.67060494094;25454.363640909127;899.8785164002907;1000.2448151645607;1000.5797565022708;1013.9695809125737;1035.6789395287485;10684.679459616069;11078.002979731702;11137.387443690675;11201.495932683049;11203.831942520868;552321;552552;562241;565661;572963;129195;131199;131748;132268;134646;1144.4106285263097;1193.4689063366718;1210.291979192165;1222.969425764363;1239.0521251242806;21969.560608788055;22201.777982220618;22941.770582293964;22942;22953.885230573742;45883.47640879784;60555.394446054976;61193.47016324449;61389.079163811686;62375.68812156092;82116;83625.16374836174;83757.58121209354;85623.29071901106;86595.74255346764;7476.439267054884;8334.749957501284;9067.591958362022;9101.317401194805;9434.716958491255;13850.584482465541;13977;14104.435822567393;14523.201223932363;14634.341454634354;11744.29534227949;12011.339376334035;12011.459484323052;12040.939795300967;12124.878751212727;11393.373364465035;11394.031507321639;11537.769244614892;11647.941760291144;11821.70445738829;12204.206726562745;12453.813192801934;12528.37358132108;12658.98728101768;12667.619971400873;8896.2882969361;8912.86630700527;9071.183593476619;9186.494742789211;9374.765630859283;11794.469248883992;11879.287242765462;12116.333601651993;12181.269123852597;12257.570985015482 14:54:03 INFO - PID 1636 | |3;mootools.html;1358.3887250737168;1466.5554428887544;1475;1475.904066235695;1479.3564799312294;11207.6637700869;11800.58697945572;11826.29042257463;11832.349220792852;11850.3482308473;11044.073320570056;11598.956093951543;11756.177067605271;11757.412129393517;11758.470868810902;2508.222451040179;2544.567423538003;2553.846769193845;2555.7316481769426;2560.257525317665;2079.5425006498544;2380.2026321182425;2520.6723125993685;2521.8739063046773;2524.8737563121863;2125.0437303213616;2152.7201463809683;2152.924647637333;2153.450870028141;2154.741431028271;2126.9893650531803;2364.8226383021256;2525.217182673377;2530.9114181003574;2531.1141100614823;2488.8008959283393;2507.135038411745;2519.5212909547126;2521.067205134094;2524.762866195569;11490.13823963206;11747.177697561174;11751.706207344885;11754.23597466162;11799.292042477478;5755.510781583571;6807.727690892359;6815.454763618948;6824.658767061627;6832.6925288362145;3901.726879118463;4233.407322974786;4305.117450922553;4306.7631280279575;4321.135772845443;1215.8237055626973;1245.1284101129156;1288.2592509307185;1290.5418576405334;1297.1309222820732;16502.75245871313;16661.4168504103;16672.74990875138;16677.332906683718;16681.416150434678;5297.894042119136;5366.221897824872;5521.365043020024;5606.495415412551;5614.887702245932;11854.585089521997;11868.584599538975;11868.584599539148;11878.703032424259;11913.166078374605;6548.8362790930605;6554.80335589933;6560.245571759213;6565.606063636197;6579.078928949951;5978.133170690226;6102.145699602059;6138.846528836815;6219.564630475914;6226;4180.853670121531;4292.527821939584;4309.806058727365;4337.631301339421;4346.348047792793;1231.1259006105586;1256.258807303677;1263.4630282130058;1263.4819723913151;1272.783626783449;785.8349746553288;810.5825499867573;811.5577010529275;814.8411059843393;844.8256922877206;6007.3992600739575;6062.9090563641585;6235.812925612239;6290.24517057956;6315.936840631627;511.4885114885115;583.2971269620098;593.5162842283526;598.2402349016811;613.457090474924;4236.915261694749;4333.609975102193;4336.111097225062;4459.464864216315;4495.955040449554;14469;14756.40974361035;15489.845101549066;15501;15504.992175508556;14841.480548180762;15102;15102.924485377504;15125.621859453602;15178.31697573612;8466.830663386698;8672.132786721277;8684;8686.348523860735;8695.956520217358;6146;6695.12963314766;7255;7295.504421593667;7309.671064802203;9778.902210978084;12937.900278476434;13872.167669939836;13883.570375184101;13888.722225555635;13480.5281815136;13791.931040344734;13938.372773225026;14159.292035398395;14337.56987290383;9188.49463279526;9248.630054797733;9355.298352623444;9365.672201473188;9482.525873706149;10444.63443779464;10726.463676816284;10731.839022414826;10748.62379816734;10749.838752418877;8941.821163576562;9040.773980650536;9215.539223038688;9223.58493867791;9363.157315841607;8407.201315874981;8902.910970890209;8924.910750892668;8987;9034.774130646523;8173.918260817316;8262.380321475794;8282.958585207276;8370.497770133812;8387.874181887399;5494.615376923577;5975.312839023394;6014.759409623741;6069.696515174312;6107.236595425572;5298.629095963245;5791.420857914175;6159.568830182024;6172.722227499684;6223.875522489434 14:54:03 INFO - PID 1636 | |4;prototype.html;392.39179272128194;393.36864332745944;393.6083596821163;396.0968990701201;403.90710136668554;5146.279520867081;5889.851478961599;5891.671205768748;5922.911156332648;5947.096928982727;4896.55930966213;5518.944810551893;5606.243157173781;5728.453317604244;5795.072788353864;4134.710570260083;4321.935170972438;4348.347747837834;4392.275274579691;4394.978025109878;4157.3140431828715;4358.8474403395885;4401.537838526957;4403.383526306319;4412.801423935931;3511.7717348372275;3521.1197200699826;3742.9064273393246;4336.97831510842;4389.9025243689075;4328.6753493487795;4341.804618792162;4349.3475978603465;4353.368761529577;4360.324149756777;3151.328702062095;3827.82774775133;3852.4766278087895;3870.9806450967844;3888.9027774305587;4873.439554451248;5050.823221187241;5365.7585408656705;5555.805501817129;5690.687012214326;5214.217867319894;5214.97392513035;5236.402897116378;5238.711870847102;5280.973595132038;5209.348831396075;6074.383468563879;6121.938780612181;6126.448619624255;6132.344267047872;3625.558690603989;4181.770002649883;4304.870853874389;4392.692511524195;4393.428854248928;5857.85355366115;6174.166487524217;6243.2508099027955;6371.929123034985;6427.421532062137;4462.642988560972;4601.562851529099;4612.538746125428;4614.400127983341;4617.284320930261;4352.6735494837385;4466.173757854807;4674.789634466457;4693.55411235932;4713.750856023156;4646.6747327686735;4711.929321060187;5206.97396513015;5304.336957880265;5333.093374126408;6209.410106039919;6212.9068063979075;6218.440340369389;6226.719797609118;6234;1531.341523145036;1594.4339759385482;1599.072537927999;1626.4957863062252;1627.7558366245157;1093.2074246171462;1121.6522877907876;1130.3331034689572;1137.6928229378022;1138.6299452677913;5695.7152142392715;5698.0598201296325;5720.227769251181;5735.9388513125205;5750.2237197978575;5275.472452754694;5984.170131116002;6324.241091069009;6335.524835637346;6357.078223657544;4381.036172042146;5309.867253318698;5745.195672605839;5773.336066352339;5795.536357091422;2746.5605503119405;2762.309422644339;3037.665856755755;3294.225856923621;3308.6856748608843;5392.325959255093;6333.334999825044;6471.482281417475;6476.579022363531;6565.376289252514;6450.065699739703;6525.184351956005;6537.019447082976;6547.312532184147;6586.571872828251;5569.331680198402;6316.463100636497;6498.415142637185;6523.06462092051;6535.986922027093;5510.641808282448;5987.5808693391045;6284.654344011124;6290.905636415366;6297.433231009231;5555.333359996826;5980.790672326448;6026.397360263939;6198.442140207223;6239.719212635351;5183.922241166461;5414.620976531605;6101.7186390858415;6571.769988050395;6609.768658096944;3617.963820361868;4120.918935937332;4159.875203743893;4164.895877603084;4169.687273454442;6161.4146656067605;6422.967885160731;6456.741730330734;6484.383983521558;6553.377429144223;5069.898602028013;5622.353429355677;5791.565632577489;6179.011358182849;6255.718492667932;6040.516758659209;6185.2886918003205;6186.175078351987;6284.3087260402235;6285.685715714288;6117.632942023315;6117.724702388492;6124;6129.141920131096;6133.938660613337;5048.949510504848;6212.3286986596195;6224.502039836711;6225.968870155621;6321.462675672619;5993.340732519507;6014.188084608521;6026.276846778414;6055.939440605537;6070.2412198475195 14:54:03 INFO - PID 1636 | |5;yui.html;702.8067281497584;741.9629018549072;851.289173540094;857.3484152044444;869.2046777198864;12786.296753678556;17313.220905059272;17753.911230443846;17876;18600.813991860112;14144.292785360716;16833.32666693331;16855;17276.22256998435;17709.114544272798;968.4576637083238;977.7653363192853;983.6163896080499;985.6845809341014;986.4771671014338;666.6866572710818;1002.6991902429279;1003.2776400991274;1004.6031817432109;1005.4520286443906;734.9926500734978;737.9188289288201;738.5716284554945;738.9002484664555;912.8676341930416;1026.1380440430037;1029.433811403725;1031.1080915008502;1031.1441503552035;1031.41209510579;758.3629751009123;759.4304271796153;760.4410758092797;762.1235579084042;766.3218052023999;16032.919835400748;16369.83630163707;16381.624664423593;16632.584185395343;16696.165191740365;15840.366385344572;15855.36578536857;16224.594385140348;16273.51179464618;16891.746623800653;13374.732505349935;13424.798628020588;13594.456221751117;13698.589042328746;13834.654133646638;3331.916702082443;3358.932821343584;3362.529245905575;3365.6297807241185;3366.663333666638;108959.45520272428;109124.90875091306;109183;109192.36211456834;109362;11941.223820451643;12274.509019639294;12315.26108433479;12341.876581234073;12343.876561234452;17313.3940312091;18703.25186992505;19317.130729117223;19543;25147.24558263255;7082.575045497287;7221.313975172456;7289.671964761598;7300.6349682515665;7302.379297759644;3811.7712937223855;3954.189391174802;3960.0693836948294;3962.2471730371135;3970.2059588082498;3683.4843121962945;4238.87283381499;4263.914721705611;4267.573242675708;4275.38006988991;840.7687885831446;862.7541150772;863.6588547523693;864.5029108262775;865.5196366016795;538.6148903533992;644.4361183964031;663.10149747092;670.9194896612438;690.8756423843656;11010;11717.414129293502;11889.583864564871;11897.226680265929;11951.701207469709;575.516566084491;647.863948570796;653.9640319782458;656.8357910522369;674.3122015544118;5067.3412456381175;5278.498542638443;5418.187271909245;5457.345118585795;5545.833624991256;82228;96780.58048548842;108983.45508272407;109977.45011274892;112819;60065;86612;87598.79422306894;87737;92256;74517;76512.85230721543;79162.6041869787;80052.39895202064;80595.59702201451;10501.422421766876;11922.642320730392;12433.254004759743;12503;12556.560520381743;39436.2112757749;39436.60563394329;39646.60353396545;39793.633018716864;39842.80078599588;69968.95046574407;70342.64828675824;71679;73062;73182;13813.930930345285;14172;14173;14180.716385672435;14214.857851421353;17348;17385.56536086608;17465.650686986442;17762.822371776634;17940;13282.734345313233;15740.68518629644;15760.842391575938;15897.205139742735;16450.095244761655;15609.219539022777;16100.275487602852;16215.756763648318;16303.673926521165;16573.337066517204;15381.769273460683;15567.299471524035;15644.608884777972;16656.41702540405;16711.91644041772;11713.297202167898;11750.823737643772;12250.339488734979;12272.570460033856;12412.503499859904;11704.882951170379;12576.245425274512;12935.870641293466;13790.310484475936;13828.861711382757 14:54:03 INFO - PID 1636 | __end_tp_report 14:54:03 INFO - PID 1636 | __start_cc_report 14:54:03 INFO - PID 1636 | _x_x_mozilla_cycle_collect,1941 14:54:03 INFO - PID 1636 | __end_cc_report 14:54:03 INFO - PID 1636 | __startTimestamp1493330043377__endTimestamp 14:54:03 INFO - PID 1636 | 14:54:03 INFO - PID 1636 | ------- Summary: start ------- 14:54:03 INFO - PID 1636 | Number of tests: 6 14:54:03 INFO - PID 1636 | 14:54:03 INFO - PID 1636 | [#0] dojo.html Cycles:165 Average:6016.03 Median:6238.22 stddev:681.71 (10.9%) stddev-sans-first:654.70 14:54:03 INFO - PID 1636 | Values: 3504.1 3514.6 3532.0 3540.9 3587.2 5995.2 6106.9 6169.6 6177.1 6183.8 6109.5 6129.9 6167.2 6185.8 6187.4 5160.9 5336.8 5338.1 5351.2 5388.9 5461.5 5466.6 5489.0 5516.9 5520.2 5269.6 5421.5 5441.7 5464.9 5478.3 5316.2 5338.2 5407.0 5462.9 5472.0 5392.1 5398.3 5411.7 5425.8 5443.4 6170.4 6177.5 6184.7 6189.3 6233.4 6275.4 6340.6 6367.2 6550.5 6571.4 6584.1 6655.3 6659.0 6674.4 6682.6 6151.9 6180.8 6238.2 6239.4 6250.6 6449.1 6778.3 6780.5 6786.5 6797.7 5241.8 6324.0 6334.1 6393.4 6405.9 6614.9 6615.2 6618.0 6625.8 6635.5 6073.9 6121.2 6476.7 6490.1 6508.9 5239.8 5280.6 6310.8 6343.5 6429.0 5206.1 5233.6 5234.4 5239.7 5282.5 4628.9 4676.8 4685.9 4699.1 4726.8 6060.6 6087.4 6118.8 6124.8 6215.4 6345.9 6411.6 6419.8 6432.2 6432.6 6094.4 6094.4 6096.7 6107.2 6115.8 5655.7 5666.7 5675.7 5682.8 5685.0 6560.0 6561.0 6573.5 6730.6 6838.9 6569.0 6619.2 6659.1 6690.3 6707.4 5703.7 6504.3 6728.7 6815.4 6817.7 6266.2 6347.0 6525.3 6550.2 6555.0 6419.3 6532.6 6547.7 6548.8 6606.1 6231.8 6368.0 6373.3 6386.7 6396.0 6383.6 6384.8 6386.6 6387.9 6390.9 6165.5 6253.4 6258.8 6284.3 6293.5 5348.5 6390.9 6408.5 6414.0 6423.1 6183.0 6269.3 6273.6 6275.9 6281.4 14:54:03 INFO - PID 1636 | 14:54:03 INFO - PID 1636 | [#1] ext.html Cycles:180 Average:42874.56 Median:31275.34 stddev:73056.47 (233.6%) stddev-sans-first:73193.11 14:54:03 INFO - PID 1636 | Values: 798.0 1113.0 1116.3 1116.8 1243.8 33663.0 34703.3 37436.4 37592.0 37595.0 37332.1 37576.6 37666.9 37719.6 37738.2 7822.6 7977.8 7984.8 7985.1 7989.3 6004.3 6120.3 7606.5 8557.0 8560.6 8624.0 8649.7 8661.4 8664.4 8669.1 8555.1 8622.3 8629.0 8640.3 8641.7 5967.3 6047.5 8246.7 8378.1 8382.9 33619.8 34430.5 37114.6 37401.8 37465.1 3594.5 3634.0 3642.4 3644.0 3649.9 30442.5 30557.4 30571.0 30592.0 30633.5 3060.8 3105.9 3118.0 3146.6 3149.1 282197.6 290650.5 291595.0 292038.0 292402.5 39134.0 48624.0 48737.5 48879.0 48910.0 39740.8 40613.6 40749.6 49122.5 49124.0 13667.7 13753.9 13754.0 13766.9 13768.2 11209.3 11217.0 11221.0 11228.7 11257.7 12314.9 12332.7 12352.3 12358.4 12484.7 5193.1 5235.9 5239.3 5241.4 5250.2 1027.7 1030.2 1035.3 1059.5 1076.2 23346.6 24509.3 24547.0 24549.9 24569.8 1115.6 1116.8 1153.8 1155.7 1177.6 12298.8 12413.4 12479.1 12554.2 12570.7 273067.6 274530.0 274686.0 275109.0 275707.0 52805.0 52818.7 52865.0 52865.9 52904.0 1504.0 1548.7 1555.7 1559.5 1561.6 23909.6 24054.0 24081.9 24091.4 24105.3 37910.4 37936.4 37972.8 38007.6 38063.4 271967.0 273046.0 273263.0 273425.0 273579.0 33703.0 33858.8 34777.7 34820.8 34840.0 42868.0 44666.1 45100.0 45129.8 45352.0 28946.0 29705.6 30048.5 31182.7 31253.8 24576.4 30619.0 30668.1 30944.0 31135.5 29783.2 35966.8 36386.9 37167.4 37248.4 30272.8 30880.8 31217.7 31296.8 31498.7 22861.2 23721.5 24217.8 24411.8 24667.6 14:54:03 INFO - PID 1636 | 14:54:03 INFO - PID 1636 | [#2] jquery.html Cycles:180 Average:36041.89 Median:12434.89 stddev:94878.02 (763.0%) stddev-sans-first:95106.41 14:54:03 INFO - PID 1636 | Values: 390.9 429.1 438.1 441.8 460.1 16667.6 20845.8 21982.3 22056.8 22295.6 19075.5 22123.9 22632.0 22835.4 22997.5 4618.4 5967.2 5982.8 6148.7 6211.3 6002.8 6097.9 6119.7 6123.0 6123.2 5908.9 5920.1 5965.1 6059.4 6063.6 5985.2 6057.3 6064.5 6066.4 6066.5 5134.6 5325.9 5391.5 5401.8 5402.5 26658.6 26852.0 27048.6 27604.0 27618.3 2168.2 2225.6 2233.2 2236.2 2237.8 17180.7 17234.0 17674.9 17680.4 17907.6 2066.6 2068.3 2129.7 2131.7 2139.9 131420.0 138060.3 152403.0 152964.2 153515.0 11350.5 11681.5 11928.5 12451.6 12594.9 14675.8 16241.6 16513.6 16672.6 16676.6 8312.8 8913.6 8927.4 9187.3 9188.1 7814.1 8506.4 8547.0 8559.7 8742.0 7790.6 7895.3 7896.5 7918.2 7923.8 2179.7 2187.9 2192.6 2193.8 2354.8 947.5 947.9 952.3 975.4 988.9 21008.5 21645.1 21703.8 21959.7 25454.4 899.9 1000.2 1000.6 1014.0 1035.7 10684.7 11078.0 11137.4 11201.5 11203.8 552321.0 552552.0 562241.0 565661.0 572963.0 129195.0 131199.0 131748.0 132268.0 134646.0 1144.4 1193.5 1210.3 1223.0 1239.1 21969.6 22201.8 22941.8 22942.0 22953.9 45883.5 60555.4 61193.5 61389.1 62375.7 82116.0 83625.2 83757.6 85623.3 86595.7 7476.4 8334.7 9067.6 9101.3 9434.7 13850.6 13977.0 14104.4 14523.2 14634.3 11744.3 12011.3 12011.5 12040.9 12124.9 11393.4 11394.0 11537.8 11647.9 11821.7 12204.2 12453.8 12528.4 12659.0 12667.6 8896.3 8912.9 9071.2 9186.5 9374.8 11794.5 11879.3 12116.3 12181.3 12257.6 14:54:03 INFO - PID 1636 | 14:54:03 INFO - PID 1636 | [#3] mootools.html Cycles:180 Average:7098.18 Median:4207.13 stddev:4549.89 (108.1%) stddev-sans-first:4542.21 14:54:03 INFO - PID 1636 | Values: 1358.4 1466.6 1475.0 1475.9 1479.4 11207.7 11800.6 11826.3 11832.3 11850.3 11044.1 11599.0 11756.2 11757.4 11758.5 2508.2 2544.6 2553.8 2555.7 2560.3 2079.5 2380.2 2520.7 2521.9 2524.9 2125.0 2152.7 2152.9 2153.5 2154.7 2127.0 2364.8 2525.2 2530.9 2531.1 2488.8 2507.1 2519.5 2521.1 2524.8 11490.1 11747.2 11751.7 11754.2 11799.3 5755.5 6807.7 6815.5 6824.7 6832.7 3901.7 4233.4 4305.1 4306.8 4321.1 1215.8 1245.1 1288.3 1290.5 1297.1 16502.8 16661.4 16672.7 16677.3 16681.4 5297.9 5366.2 5521.4 5606.5 5614.9 11854.6 11868.6 11868.6 11878.7 11913.2 6548.8 6554.8 6560.2 6565.6 6579.1 5978.1 6102.1 6138.8 6219.6 6226.0 4180.9 4292.5 4309.8 4337.6 4346.3 1231.1 1256.3 1263.5 1263.5 1272.8 785.8 810.6 811.6 814.8 844.8 6007.4 6062.9 6235.8 6290.2 6315.9 511.5 583.3 593.5 598.2 613.5 4236.9 4333.6 4336.1 4459.5 4496.0 14469.0 14756.4 15489.8 15501.0 15505.0 14841.5 15102.0 15102.9 15125.6 15178.3 8466.8 8672.1 8684.0 8686.3 8696.0 6146.0 6695.1 7255.0 7295.5 7309.7 9778.9 12937.9 13872.2 13883.6 13888.7 13480.5 13791.9 13938.4 14159.3 14337.6 9188.5 9248.6 9355.3 9365.7 9482.5 10444.6 10726.5 10731.8 10748.6 10749.8 8941.8 9040.8 9215.5 9223.6 9363.2 8407.2 8902.9 8924.9 8987.0 9034.8 8173.9 8262.4 8283.0 8370.5 8387.9 5494.6 5975.3 6014.8 6069.7 6107.2 5298.6 5791.4 6159.6 6172.7 6223.9 14:54:03 INFO - PID 1636 | 14:54:03 INFO - PID 1636 | [#4] prototype.html Cycles:180 Average:5006.62 Median:5537.14 stddev:1524.52 (27.5%) stddev-sans-first:1488.94 14:54:03 INFO - PID 1636 | Values: 392.4 393.4 393.6 396.1 403.9 5146.3 5889.9 5891.7 5922.9 5947.1 4896.6 5518.9 5606.2 5728.5 5795.1 4134.7 4321.9 4348.3 4392.3 4395.0 4157.3 4358.8 4401.5 4403.4 4412.8 3511.8 3521.1 3742.9 4337.0 4389.9 4328.7 4341.8 4349.3 4353.4 4360.3 3151.3 3827.8 3852.5 3871.0 3888.9 4873.4 5050.8 5365.8 5555.8 5690.7 5214.2 5215.0 5236.4 5238.7 5281.0 5209.3 6074.4 6121.9 6126.4 6132.3 3625.6 4181.8 4304.9 4392.7 4393.4 5857.9 6174.2 6243.3 6371.9 6427.4 4462.6 4601.6 4612.5 4614.4 4617.3 4352.7 4466.2 4674.8 4693.6 4713.8 4646.7 4711.9 5207.0 5304.3 5333.1 6209.4 6212.9 6218.4 6226.7 6234.0 1531.3 1594.4 1599.1 1626.5 1627.8 1093.2 1121.7 1130.3 1137.7 1138.6 5695.7 5698.1 5720.2 5735.9 5750.2 5275.5 5984.2 6324.2 6335.5 6357.1 4381.0 5309.9 5745.2 5773.3 5795.5 2746.6 2762.3 3037.7 3294.2 3308.7 5392.3 6333.3 6471.5 6476.6 6565.4 6450.1 6525.2 6537.0 6547.3 6586.6 5569.3 6316.5 6498.4 6523.1 6536.0 5510.6 5987.6 6284.7 6290.9 6297.4 5555.3 5980.8 6026.4 6198.4 6239.7 5183.9 5414.6 6101.7 6571.8 6609.8 3618.0 4120.9 4159.9 4164.9 4169.7 6161.4 6423.0 6456.7 6484.4 6553.4 5069.9 5622.4 5791.6 6179.0 6255.7 6040.5 6185.3 6186.2 6284.3 6285.7 6117.6 6117.7 6124.0 6129.1 6133.9 5048.9 6212.3 6224.5 6226.0 6321.5 5993.3 6014.2 6026.3 6055.9 6070.2 14:54:03 INFO - PID 1636 | 14:54:03 INFO - PID 1636 | [#5] yui.html Cycles:180 Average:20971.52 Median:17908.00 stddev:29092.81 (162.5%) stddev-sans-first:29134.62 14:54:03 INFO - PID 1636 | Values: 702.8 742.0 851.3 857.3 869.2 12786.3 17313.2 17753.9 17876.0 18600.8 14144.3 16833.3 16855.0 17276.2 17709.1 968.5 977.8 983.6 985.7 986.5 666.7 1002.7 1003.3 1004.6 1005.5 735.0 737.9 738.6 738.9 912.9 1026.1 1029.4 1031.1 1031.1 1031.4 758.4 759.4 760.4 762.1 766.3 16032.9 16369.8 16381.6 16632.6 16696.2 15840.4 15855.4 16224.6 16273.5 16891.7 13374.7 13424.8 13594.5 13698.6 13834.7 3331.9 3358.9 3362.5 3365.6 3366.7 108959.5 109124.9 109183.0 109192.4 109362.0 11941.2 12274.5 12315.3 12341.9 12343.9 17313.4 18703.3 19317.1 19543.0 25147.2 7082.6 7221.3 7289.7 7300.6 7302.4 3811.8 3954.2 3960.1 3962.2 3970.2 3683.5 4238.9 4263.9 4267.6 4275.4 840.8 862.8 863.7 864.5 865.5 538.6 644.4 663.1 670.9 690.9 11010.0 11717.4 11889.6 11897.2 11951.7 575.5 647.9 654.0 656.8 674.3 5067.3 5278.5 5418.2 5457.3 5545.8 82228.0 96780.6 108983.5 109977.5 112819.0 60065.0 86612.0 87598.8 87737.0 92256.0 74517.0 76512.9 79162.6 80052.4 80595.6 10501.4 11922.6 12433.3 12503.0 12556.6 39436.2 39436.6 39646.6 39793.6 39842.8 69969.0 70342.6 71679.0 73062.0 73182.0 13813.9 14172.0 14173.0 14180.7 14214.9 17348.0 17385.6 17465.7 17762.8 17940.0 13282.7 15740.7 15760.8 15897.2 16450.1 15609.2 16100.3 16215.8 16303.7 16573.3 15381.8 15567.3 15644.6 16656.4 16711.9 11713.3 11750.8 12250.3 12272.6 12412.5 11704.9 12576.2 12935.9 13790.3 13828.9 14:54:03 INFO - PID 1636 | -------- Summary: end -------- 14:54:03 INFO - PID 1636 | 14:54:04 INFO - TEST-INFO | 1636: exit 0 14:54:04 INFO - TEST-OK | dromaeo_css | took 1119126ms 14:54:04 INFO - TEST-START | kraken 14:54:04 INFO - operating with platform_type : mac_ 14:54:04 INFO - Initialising browser for kraken test... 14:54:04 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/tmpE__7vt/profile http://localhost:49228/getInfo.html) 14:54:06 INFO - PID 1646 | __metrics Screen width/height:1600/1200 14:54:06 INFO - PID 1646 | colorDepth:24 14:54:06 INFO - PID 1646 | Browser inner width/height: 1024/689 14:54:06 INFO - PID 1646 | __metrics 14:54:06 INFO - PID 1646 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:54:06 INFO - PID 1646 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:54:07 INFO - TEST-INFO | 1646: exit 0 14:54:07 INFO - Browser initialized. 14:54:07 INFO - Running cycle 1/1 for kraken test... 14:54:07 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/tmpE__7vt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:54:19 INFO - PID 1647 | RSS: Main: 241041408 14:54:19 INFO - PID 1647 | 14:54:22 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49228/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49228/tests/kraken/driver.html?testName=audio-beat-detection) 14:54:23 INFO - PID 1647 | RSS: Main: 310624256 14:54:23 INFO - PID 1647 | 14:54:25 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49228/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49228/tests/kraken/driver.html?testName=audio-dft) 14:54:26 INFO - PID 1647 | RSS: Main: 291946496 14:54:26 INFO - PID 1647 | 14:54:29 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49228/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49228/tests/kraken/driver.html?testName=audio-fft) 14:54:30 INFO - PID 1647 | RSS: Main: 383250432 14:54:30 INFO - PID 1647 | 14:54:32 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49228/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49228/tests/kraken/driver.html?testName=audio-oscillator) 14:54:32 INFO - PID 1647 | RSS: Main: 286916608 14:54:32 INFO - PID 1647 | 14:54:34 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49228/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49228/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:54:35 INFO - PID 1647 | RSS: Main: 289103872 14:54:35 INFO - PID 1647 | 14:54:38 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49228/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49228/tests/kraken/driver.html?testName=imaging-darkroom) 14:54:38 INFO - PID 1647 | RSS: Main: 351952896 14:54:38 INFO - PID 1647 | 14:54:41 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49228/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49228/tests/kraken/driver.html?testName=imaging-desaturate) 14:54:42 INFO - PID 1647 | RSS: Main: 374296576 14:54:42 INFO - PID 1647 | 14:54:45 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49228/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49228/tests/kraken/driver.html?testName=json-parse-financial) 14:54:45 INFO - PID 1647 | RSS: Main: 387436544 14:54:45 INFO - PID 1647 | 14:54:47 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49228/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49228/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:54:47 INFO - PID 1647 | RSS: Main: 333205504 14:54:47 INFO - PID 1647 | 14:54:49 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49228/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49228/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:54:50 INFO - PID 1647 | RSS: Main: 332881920 14:54:50 INFO - PID 1647 | 14:54:52 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49228/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49228/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:54:53 INFO - PID 1647 | RSS: Main: 335663104 14:54:53 INFO - PID 1647 | 14:54:55 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49228/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49228/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:54:56 INFO - PID 1647 | RSS: Main: 350826496 14:54:56 INFO - PID 1647 | 14:54:59 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49228/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49228/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:55:00 INFO - PID 1647 | RSS: Main: 344076288 14:55:00 INFO - PID 1647 | 14:55:02 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49228/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49228/tests/kraken/driver.html?testName=ai-astar) 14:55:02 INFO - PID 1647 | RSS: Main: 386834432 14:55:02 INFO - PID 1647 | 14:55:02 INFO - PID 1647 | __start_tp_report 14:55:02 INFO - PID 1647 | _x_x_mozilla_page_load 14:55:02 INFO - PID 1647 | _x_x_mozilla_page_load_details 14:55:02 INFO - PID 1647 | |i|pagename|runs| 14:55:02 INFO - PID 1647 | |0;ai-astar;111;111;110;109;110;112;110;110;110;110 14:55:02 INFO - PID 1647 | |1;audio-beat-detection;142;110;105;145;104;105;107;105;135;108 14:55:02 INFO - PID 1647 | |2;audio-dft;186;184;182;184;180;182;184;183;181;179 14:55:02 INFO - PID 1647 | |3;audio-fft;83;57;57;86;59;62;58;58;82;58 14:55:02 INFO - PID 1647 | |4;audio-oscillator;91;71;85;70;68;70;87;69;68;90 14:55:02 INFO - PID 1647 | |5;imaging-gaussian-blur;88;87;87;87;87;87;87;87;87;87 14:55:02 INFO - PID 1647 | |6;imaging-darkroom;94;93;94;95;96;98;96;94;93;94 14:55:02 INFO - PID 1647 | |7;imaging-desaturate;86;83;84;85;86;83;85;85;84;83 14:55:02 INFO - PID 1647 | |8;json-parse-financial;49;48;48;47;47;49;49;46;49;49 14:55:02 INFO - PID 1647 | |9;json-stringify-tinderbox;54;53;59;59;65;58;56;57;56;55 14:55:02 INFO - PID 1647 | |10;stanford-crypto-aes;83;83;82;82;82;82;83;82;83;82 14:55:02 INFO - PID 1647 | |11;stanford-crypto-ccm;140;134;133;136;136;135;136;133;181;198 14:55:02 INFO - PID 1647 | |12;stanford-crypto-pbkdf2;185;232;185;187;186;204;185;183;186;183 14:55:02 INFO - PID 1647 | |13;stanford-crypto-sha256-iterative;67;66;67;66;66;67;68;68;91;98 14:55:02 INFO - PID 1647 | __end_tp_report 14:55:02 INFO - PID 1647 | __start_cc_report 14:55:02 INFO - PID 1647 | _x_x_mozilla_cycle_collect,2185 14:55:02 INFO - PID 1647 | __end_cc_report 14:55:02 INFO - PID 1647 | __startTimestamp1493330102455__endTimestamp 14:55:02 INFO - PID 1647 | 14:55:02 INFO - PID 1647 | ------- Summary: start ------- 14:55:02 INFO - PID 1647 | Number of tests: 14 14:55:02 INFO - PID 1647 | 14:55:02 INFO - PID 1647 | [#0] ai-astar Cycles:10 Average:110.30 Median:110.00 stddev:0.82 (0.7%) stddev-sans-first:0.83 14:55:02 INFO - PID 1647 | Values: 111.0 111.0 110.0 109.0 110.0 112.0 110.0 110.0 110.0 110.0 14:55:02 INFO - PID 1647 | 14:55:02 INFO - PID 1647 | [#1] audio-beat-detection Cycles:10 Average:116.60 Median:109.00 stddev:16.87 (15.5%) stddev-sans-first:15.19 14:55:02 INFO - PID 1647 | Values: 142.0 110.0 105.0 145.0 104.0 105.0 107.0 105.0 135.0 108.0 14:55:02 INFO - PID 1647 | 14:55:02 INFO - PID 1647 | [#2] audio-dft Cycles:10 Average:182.50 Median:183.50 stddev:2.12 (1.2%) stddev-sans-first:1.83 14:55:02 INFO - PID 1647 | Values: 186.0 184.0 182.0 184.0 180.0 182.0 184.0 183.0 181.0 179.0 14:55:02 INFO - PID 1647 | 14:55:02 INFO - PID 1647 | [#3] audio-fft Cycles:10 Average:66.00 Median:60.50 stddev:12.31 (20.3%) stddev-sans-first:11.42 14:55:02 INFO - PID 1647 | Values: 83.0 57.0 57.0 86.0 59.0 62.0 58.0 58.0 82.0 58.0 14:55:02 INFO - PID 1647 | 14:55:02 INFO - PID 1647 | [#4] audio-oscillator Cycles:10 Average:76.90 Median:78.00 stddev:9.94 (12.7%) stddev-sans-first:9.14 14:55:02 INFO - PID 1647 | Values: 91.0 71.0 85.0 70.0 68.0 70.0 87.0 69.0 68.0 90.0 14:55:02 INFO - PID 1647 | 14:55:02 INFO - PID 1647 | [#5] imaging-gaussian-blur Cycles:10 Average:87.10 Median:87.00 stddev:0.32 (0.4%) stddev-sans-first:0.00 14:55:02 INFO - PID 1647 | Values: 88.0 87.0 87.0 87.0 87.0 87.0 87.0 87.0 87.0 87.0 14:55:02 INFO - PID 1647 | 14:55:02 INFO - PID 1647 | [#6] imaging-darkroom Cycles:10 Average:94.70 Median:94.50 stddev:1.57 (1.7%) stddev-sans-first:1.64 14:55:02 INFO - PID 1647 | Values: 94.0 93.0 94.0 95.0 96.0 98.0 96.0 94.0 93.0 94.0 14:55:02 INFO - PID 1647 | 14:55:02 INFO - PID 1647 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:85.00 stddev:1.17 (1.4%) stddev-sans-first:1.09 14:55:02 INFO - PID 1647 | Values: 86.0 83.0 84.0 85.0 86.0 83.0 85.0 85.0 84.0 83.0 14:55:02 INFO - PID 1647 | 14:55:02 INFO - PID 1647 | [#8] json-parse-financial Cycles:10 Average:48.10 Median:49.00 stddev:1.10 (2.2%) stddev-sans-first:1.12 14:55:02 INFO - PID 1647 | Values: 49.0 48.0 48.0 47.0 47.0 49.0 49.0 46.0 49.0 49.0 14:55:02 INFO - PID 1647 | 14:55:02 INFO - PID 1647 | [#9] json-stringify-tinderbox Cycles:10 Average:57.20 Median:57.50 stddev:3.39 (5.9%) stddev-sans-first:3.40 14:55:02 INFO - PID 1647 | Values: 54.0 53.0 59.0 59.0 65.0 58.0 56.0 57.0 56.0 55.0 14:55:02 INFO - PID 1647 | 14:55:02 INFO - PID 1647 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:82.50 stddev:0.52 (0.6%) stddev-sans-first:0.50 14:55:02 INFO - PID 1647 | Values: 83.0 83.0 82.0 82.0 82.0 82.0 83.0 82.0 83.0 82.0 14:55:02 INFO - PID 1647 | 14:55:02 INFO - PID 1647 | [#11] stanford-crypto-ccm Cycles:10 Average:146.20 Median:136.00 stddev:23.26 (17.1%) stddev-sans-first:24.56 14:55:02 INFO - PID 1647 | Values: 140.0 134.0 133.0 136.0 136.0 135.0 136.0 133.0 181.0 198.0 14:55:02 INFO - PID 1647 | 14:55:02 INFO - PID 1647 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:191.60 Median:186.00 stddev:15.45 (8.3%) stddev-sans-first:16.20 14:55:02 INFO - PID 1647 | Values: 185.0 232.0 185.0 187.0 186.0 204.0 185.0 183.0 186.0 183.0 14:55:02 INFO - PID 1647 | 14:55:02 INFO - PID 1647 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.40 Median:67.50 stddev:11.79 (17.5%) stddev-sans-first:12.34 14:55:02 INFO - PID 1647 | Values: 67.0 66.0 67.0 66.0 66.0 67.0 68.0 68.0 91.0 98.0 14:55:02 INFO - PID 1647 | -------- Summary: end -------- 14:55:02 INFO - PID 1647 | 14:55:03 INFO - TEST-INFO | 1647: exit 0 14:55:03 INFO - TEST-OK | kraken | took 59463ms 14:55:03 INFO - SUITE-END | took 1178s 14:55:03 INFO - Completed test suite (00:19:38) 14:55:03 INFO - javascript benchmark 14:55:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7698.045003337415, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3504.071421073416, 3514.5958214805296, 3532.046347486177, 3540.8583656653736, 3587.1749497615547, 5995.220621319233, 6106.877862442749, 6169.5989760665525, 6177.135201071848, 6183.78356757513, 6109.495762817165, 6129.938700612993, 6167.167432396625, 6185.814425567229, 6187.412195841388, 5160.8709782255555, 5336.839894803162, 5338.119210330291, 5351.197320401932, 5388.892222155555, 5461.453854614527, 5466.562674986011, 5488.9725551372185, 5516.862078448051, 5520.227168196456, 5269.578433725293, 5421.457854214586, 5441.673499589998, 5464.9453505465035, 5478.315210598676, 5316.20256961455, 5338.172583249602, 5407.026735187665, 5462.945370546284, 5472.0, 5392.137258038695, 5398.2982212312545, 5411.702356370398, 5425.810096646638, 5443.42844001382, 6170.382961703794, 6177.474914632262, 6184.721687524072, 6189.2572891252885, 6233.438990490832, 6275.372462753734, 6340.619562826245, 6367.172267605228, 6550.475961923034, 6571.44142747867, 6584.144061272004, 6655.301193374675, 6659.0, 6674.399304062657, 6682.599044057323, 6151.876962460726, 6180.81457556265, 6238.220222472191, 6239.407256310643, 6250.562460627803, 6449.064885591657, 6778.254392016875, 6780.491463140284, 6786.524943254023, 6797.66011699423, 5241.764120614582, 6323.988161894074, 6334.144890439824, 6393.392627700361, 6405.903911441332, 6614.900776488356, 6615.206175259, 6617.966910165418, 6625.801225963132, 6635.469162466991, 6073.878522429615, 6121.234845644294, 6476.740930362733, 6490.0589414534625, 6508.869822603521, 5239.816606418757, 5280.603954703336, 6310.810675679737, 6343.492520598341, 6429.0, 5206.088934436459, 5233.581313494911, 5234.398044224963, 5239.73801309933, 5282.498162674539, 4628.907421851544, 4676.766161691902, 4685.906281874343, 4699.130660827758, 4726.787294571753, 6060.575759696867, 6087.391260873877, 6118.771466971993, 6124.777645458507, 6215.409536094064, 6345.904811427832, 6411.551191416556, 6419.839504012437, 6432.2281326241155, 6432.581882177644, 6094.421030002142, 6094.421030002142, 6096.725647345791, 6107.175531303306, 6115.816525504242, 5655.688937108416, 5666.744996475169, 5675.687837168995, 5682.829515114553, 5685.0, 6559.983202603604, 6561.015847622894, 6573.539852210395, 6730.629815360202, 6838.897416538656, 6569.047488114101, 6619.172603424572, 6659.101021362054, 6690.264070952288, 6707.42986846104, 5703.657780533182, 6504.252011018793, 6728.697208625722, 6815.352541508549, 6817.7272909083085, 6266.185395898504, 6347.0479428086155, 6525.282218956006, 6550.246721627074, 6554.967225163844, 6419.325970773189, 6532.608043517404, 6547.672616369257, 6548.770793022221, 6606.141201643755, 6231.813045608639, 6367.981123020295, 6373.267074286517, 6386.68066596659, 6396.008618664115, 6383.648899310582, 6384.840378990377, 6386.616802991835, 6387.936120638734, 6390.90413643805, 6165.475934545434, 6253.374662533893, 6258.843528911813, 6284.340144284784, 6293.465055470337, 5348.5186333230195, 6390.936090639034, 6408.455281301141, 6414.03789431589, 6423.132877061536, 6183.0, 6269.279032911274, 6273.592216505913, 6275.937240627535, 6281.371862813682], "value": 5973.277965641796, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [797.9521228726276, 1113.0427832064422, 1116.2576886370564, 1116.8492253545771, 1243.8009918413045, 33663.0, 34703.305933881304, 37436.43845342315, 37592.0, 37595.0, 37332.06669833256, 37576.62423375772, 37666.86999390016, 37719.622803771956, 37738.24523509528, 7822.647980840876, 7977.800554986114, 7984.760457186265, 7985.081715602722, 7989.280964713174, 6004.309504406983, 6120.296165940907, 7606.467547271694, 8557.0, 8560.571971401436, 8624.008239052526, 8649.740507784745, 8661.437006594582, 8664.39349245553, 8669.089745576719, 8555.144485551456, 8622.267107295887, 8629.007664118644, 8640.265577425926, 8641.65433382664, 5967.283925928873, 6047.516198704093, 8246.670133194664, 8378.078411374743, 8382.916170838274, 33619.82330618441, 34430.48354274688, 37114.628853711656, 37401.81299093514, 37465.06337341561, 3594.5327107476123, 3634.018814919983, 3642.4354225095153, 3644.0, 3649.8905032849057, 30442.54336184959, 30557.38885222283, 30571.0, 30592.0, 30633.46832658358, 3060.8010479318773, 3105.8602362893726, 3118.033409643018, 3146.6381366142728, 3149.086764838194, 282197.5890120536, 290650.5467472649, 291595.0, 292038.0, 292402.53798731085, 39134.02164945899, 48624.02751945012, 48737.5126248733, 48879.02241955141, 48910.0, 39740.801295993915, 40613.59386406157, 40749.59250407458, 49122.50877491251, 49124.0, 13667.658308542168, 13753.862461375458, 13754.0, 13766.862331376558, 13768.24274664883, 11209.271397359145, 11217.0, 11221.0, 11228.66314010581, 11257.718557035976, 12314.876851231553, 12332.691682707824, 12352.25886446816, 12358.44387002587, 12484.687882803002, 5193.1171700810955, 5235.942144837782, 5239.266502689627, 5241.371035475768, 5250.238715386324, 1027.7482016905906, 1030.2376241581326, 1035.2649618770606, 1059.5285098131258, 1076.160594736107, 23346.64980025301, 24509.264722058368, 24547.0, 24549.877250613634, 24569.754302457106, 1115.5593540551438, 1116.7543140509074, 1153.7865494883474, 1155.6590805712335, 1177.5584155941522, 12298.754024919452, 12413.379331033413, 12479.064070194772, 12554.246745195318, 12570.748585028432, 273067.63466182543, 274530.0, 274686.0, 275109.0, 275707.0, 52805.0, 52818.679533011215, 52865.0, 52865.94268114616, 52904.0, 1504.0449314685254, 1548.7367147584937, 1555.688862227559, 1559.485369827954, 1561.625209949604, 23909.641355379335, 24054.0, 24081.879590601933, 24091.397715057265, 24105.276841694777, 37910.431343529315, 37936.39604237593, 37972.81013595025, 38007.619923800405, 38063.42904856374, 271967.0, 273046.0, 273263.0, 273425.0, 273579.0, 33702.98891033273, 33858.83070584631, 34777.65222347846, 34820.82589587036, 34840.0, 42868.0, 44666.10667786691, 45100.0, 45129.774351128035, 45352.0, 28946.0, 29705.554416683335, 30048.549271761378, 31182.68817311798, 31253.843730781202, 24576.385590360384, 30619.0, 30668.07995760131, 30944.0, 31135.532967005965, 29783.21300721877, 35966.820165899, 36386.90839274826, 37167.442488362154, 37248.44127338146, 30272.789088436217, 30880.845595771876, 31217.687823122385, 31296.843515782275, 31498.68501315049, 22861.161182972406, 23721.52556948886, 24217.757822422256, 24411.75588244166, 24667.62998555059], "value": 17126.191307848218, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.9081365879016, 429.12472495196, 438.1346839991018, 441.81885426974947, 460.132649954835, 16667.583310417245, 20845.791542084593, 21982.34052978409, 22056.779432205694, 22295.554088918252, 19075.523111922208, 22123.89380530971, 22632.0, 22835.429114272152, 22997.540049199008, 4618.445786505624, 5967.164596956419, 5982.754547602183, 6148.692565371736, 6211.260846962858, 6002.819915402523, 6097.939020609781, 6119.724612392453, 6122.96938515309, 6123.234595675541, 5908.88182236355, 5920.111983202532, 5965.075413310922, 6059.39406059395, 6063.575549711522, 5985.221921150266, 6057.3336932937345, 6064.514838812885, 6066.363031881633, 6066.484348830355, 5134.614903882187, 5325.8934821303355, 5391.487808658171, 5401.810936617199, 5402.540784033362, 26658.600120998202, 26852.0, 27048.64756762154, 27604.0, 27618.309542261402, 2168.2194410012385, 2225.5660146271484, 2233.1514024670682, 2236.1726161320253, 2237.787410196045, 17180.656386872317, 17234.0, 17674.91162544192, 17680.381186658404, 17907.641847162984, 2066.5660211355635, 2068.2864411777914, 2129.7018417421573, 2131.6695912133646, 2139.850210485267, 131420.0, 138060.30969845186, 152402.95194096057, 152964.17589560128, 153515.0, 11350.54597816078, 11681.532738690357, 11928.46321915516, 12451.564195253122, 12594.866462018279, 14675.77986330206, 16241.593960150854, 16513.587160321087, 16672.583185420463, 16676.58308542272, 8312.836202931594, 8913.55432228386, 8927.375083744075, 9187.26501879848, 9188.127127922837, 7814.140444551095, 8506.36202284831, 8547.0, 8559.74320770378, 8741.956290218508, 7790.610469476504, 7895.289423951872, 7896.486728362638, 7918.168592297841, 7923.811428285803, 2179.7057397251483, 2187.8951129679726, 2192.596738087625, 2193.7915897989665, 2354.83516153871, 947.5025611553989, 947.8909925358535, 952.2857856607544, 975.3903810118676, 988.9011098890054, 21008.474788130417, 21645.134194632352, 21703.78296217049, 21959.67060494094, 25454.363640909127, 899.8785164002907, 1000.2448151645607, 1000.5797565022708, 1013.9695809125737, 1035.6789395287485, 10684.679459616069, 11078.002979731702, 11137.387443690675, 11201.495932683049, 11203.831942520868, 552321.0, 552552.0, 562241.0, 565661.0, 572963.0, 129195.0, 131199.0, 131748.0, 132268.0, 134646.0, 1144.4106285263097, 1193.4689063366718, 1210.291979192165, 1222.969425764363, 1239.0521251242806, 21969.560608788055, 22201.777982220618, 22941.770582293964, 22942.0, 22953.885230573742, 45883.47640879784, 60555.394446054976, 61193.47016324449, 61389.079163811686, 62375.68812156092, 82116.0, 83625.16374836174, 83757.58121209354, 85623.29071901106, 86595.74255346764, 7476.439267054884, 8334.749957501284, 9067.591958362022, 9101.317401194805, 9434.716958491255, 13850.584482465541, 13977.0, 14104.435822567393, 14523.201223932363, 14634.341454634354, 11744.29534227949, 12011.339376334035, 12011.459484323052, 12040.939795300967, 12124.878751212727, 11393.373364465035, 11394.031507321639, 11537.769244614892, 11647.941760291144, 11821.70445738829, 12204.206726562745, 12453.813192801934, 12528.37358132108, 12658.98728101768, 12667.619971400873, 8896.2882969361, 8912.86630700527, 9071.183593476619, 9186.494742789211, 9374.765630859283, 11794.469248883992, 11879.287242765462, 12116.333601651993, 12181.269123852597, 12257.570985015482], "value": 10513.788400469226, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1358.3887250737168, 1466.5554428887544, 1475.0, 1475.904066235695, 1479.3564799312294, 11207.6637700869, 11800.58697945572, 11826.29042257463, 11832.349220792852, 11850.3482308473, 11044.073320570056, 11598.956093951543, 11756.177067605271, 11757.412129393517, 11758.470868810902, 2508.222451040179, 2544.567423538003, 2553.846769193845, 2555.7316481769426, 2560.257525317665, 2079.5425006498544, 2380.2026321182425, 2520.6723125993685, 2521.8739063046773, 2524.8737563121863, 2125.0437303213616, 2152.7201463809683, 2152.924647637333, 2153.450870028141, 2154.741431028271, 2126.9893650531803, 2364.8226383021256, 2525.217182673377, 2530.9114181003574, 2531.1141100614823, 2488.8008959283393, 2507.135038411745, 2519.5212909547126, 2521.067205134094, 2524.762866195569, 11490.13823963206, 11747.177697561174, 11751.706207344885, 11754.23597466162, 11799.292042477478, 5755.510781583571, 6807.727690892359, 6815.454763618948, 6824.658767061627, 6832.6925288362145, 3901.726879118463, 4233.407322974786, 4305.117450922553, 4306.7631280279575, 4321.135772845443, 1215.8237055626973, 1245.1284101129156, 1288.2592509307185, 1290.5418576405334, 1297.1309222820732, 16502.75245871313, 16661.4168504103, 16672.74990875138, 16677.332906683718, 16681.416150434678, 5297.894042119136, 5366.221897824872, 5521.365043020024, 5606.495415412551, 5614.887702245932, 11854.585089521997, 11868.584599538975, 11868.584599539148, 11878.703032424259, 11913.166078374605, 6548.8362790930605, 6554.80335589933, 6560.245571759213, 6565.606063636197, 6579.078928949951, 5978.133170690226, 6102.145699602059, 6138.846528836815, 6219.564630475914, 6226.0, 4180.853670121531, 4292.527821939584, 4309.806058727365, 4337.631301339421, 4346.348047792793, 1231.1259006105586, 1256.258807303677, 1263.4630282130058, 1263.4819723913151, 1272.783626783449, 785.8349746553288, 810.5825499867573, 811.5577010529275, 814.8411059843393, 844.8256922877206, 6007.3992600739575, 6062.9090563641585, 6235.812925612239, 6290.24517057956, 6315.936840631627, 511.4885114885115, 583.2971269620098, 593.5162842283526, 598.2402349016811, 613.457090474924, 4236.915261694749, 4333.609975102193, 4336.111097225062, 4459.464864216315, 4495.955040449554, 14469.0, 14756.40974361035, 15489.845101549066, 15501.0, 15504.992175508556, 14841.480548180762, 15102.0, 15102.924485377504, 15125.621859453602, 15178.31697573612, 8466.830663386698, 8672.132786721277, 8684.0, 8686.348523860735, 8695.956520217358, 6146.0, 6695.12963314766, 7255.0, 7295.504421593667, 7309.671064802203, 9778.902210978084, 12937.900278476434, 13872.167669939836, 13883.570375184101, 13888.722225555635, 13480.5281815136, 13791.931040344734, 13938.372773225026, 14159.292035398395, 14337.56987290383, 9188.49463279526, 9248.630054797733, 9355.298352623444, 9365.672201473188, 9482.525873706149, 10444.63443779464, 10726.463676816284, 10731.839022414826, 10748.62379816734, 10749.838752418877, 8941.821163576562, 9040.773980650536, 9215.539223038688, 9223.58493867791, 9363.157315841607, 8407.201315874981, 8902.910970890209, 8924.910750892668, 8987.0, 9034.774130646523, 8173.918260817316, 8262.380321475794, 8282.958585207276, 8370.497770133812, 8387.874181887399, 5494.615376923577, 5975.312839023394, 6014.759409623741, 6069.696515174312, 6107.236595425572, 5298.629095963245, 5791.420857914175, 6159.568830182024, 6172.722227499684, 6223.875522489434], "value": 5293.021371338654, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.39179272128194, 393.36864332745944, 393.6083596821163, 396.0968990701201, 403.90710136668554, 5146.279520867081, 5889.851478961599, 5891.671205768748, 5922.911156332648, 5947.096928982727, 4896.55930966213, 5518.944810551893, 5606.243157173781, 5728.453317604244, 5795.072788353864, 4134.710570260083, 4321.935170972438, 4348.347747837834, 4392.275274579691, 4394.978025109878, 4157.3140431828715, 4358.8474403395885, 4401.537838526957, 4403.383526306319, 4412.801423935931, 3511.7717348372275, 3521.1197200699826, 3742.9064273393246, 4336.97831510842, 4389.9025243689075, 4328.6753493487795, 4341.804618792162, 4349.3475978603465, 4353.368761529577, 4360.324149756777, 3151.328702062095, 3827.82774775133, 3852.4766278087895, 3870.9806450967844, 3888.9027774305587, 4873.439554451248, 5050.823221187241, 5365.7585408656705, 5555.805501817129, 5690.687012214326, 5214.217867319894, 5214.97392513035, 5236.402897116378, 5238.711870847102, 5280.973595132038, 5209.348831396075, 6074.383468563879, 6121.938780612181, 6126.448619624255, 6132.344267047872, 3625.558690603989, 4181.770002649883, 4304.870853874389, 4392.692511524195, 4393.428854248928, 5857.85355366115, 6174.166487524217, 6243.2508099027955, 6371.929123034985, 6427.421532062137, 4462.642988560972, 4601.562851529099, 4612.538746125428, 4614.400127983341, 4617.284320930261, 4352.6735494837385, 4466.173757854807, 4674.789634466457, 4693.55411235932, 4713.750856023156, 4646.6747327686735, 4711.929321060187, 5206.97396513015, 5304.336957880265, 5333.093374126408, 6209.410106039919, 6212.9068063979075, 6218.440340369389, 6226.719797609118, 6234.0, 1531.341523145036, 1594.4339759385482, 1599.072537927999, 1626.4957863062252, 1627.7558366245157, 1093.2074246171462, 1121.6522877907876, 1130.3331034689572, 1137.6928229378022, 1138.6299452677913, 5695.7152142392715, 5698.0598201296325, 5720.227769251181, 5735.9388513125205, 5750.2237197978575, 5275.472452754694, 5984.170131116002, 6324.241091069009, 6335.524835637346, 6357.078223657544, 4381.036172042146, 5309.867253318698, 5745.195672605839, 5773.336066352339, 5795.536357091422, 2746.5605503119405, 2762.309422644339, 3037.665856755755, 3294.225856923621, 3308.6856748608843, 5392.325959255093, 6333.334999825044, 6471.482281417475, 6476.579022363531, 6565.376289252514, 6450.065699739703, 6525.184351956005, 6537.019447082976, 6547.312532184147, 6586.571872828251, 5569.331680198402, 6316.463100636497, 6498.415142637185, 6523.06462092051, 6535.986922027093, 5510.641808282448, 5987.5808693391045, 6284.654344011124, 6290.905636415366, 6297.433231009231, 5555.333359996826, 5980.790672326448, 6026.397360263939, 6198.442140207223, 6239.719212635351, 5183.922241166461, 5414.620976531605, 6101.7186390858415, 6571.769988050395, 6609.768658096944, 3617.963820361868, 4120.918935937332, 4159.875203743893, 4164.895877603084, 4169.687273454442, 6161.4146656067605, 6422.967885160731, 6456.741730330734, 6484.383983521558, 6553.377429144223, 5069.898602028013, 5622.353429355677, 5791.565632577489, 6179.011358182849, 6255.718492667932, 6040.516758659209, 6185.2886918003205, 6186.175078351987, 6284.3087260402235, 6285.685715714288, 6117.632942023315, 6117.724702388492, 6124.0, 6129.141920131096, 6133.938660613337, 5048.949510504848, 6212.3286986596195, 6224.502039836711, 6225.968870155621, 6321.462675672619, 5993.340732519507, 6014.188084608521, 6026.276846778414, 6055.939440605537, 6070.2412198475195], "value": 4551.230411525953, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [702.8067281497584, 741.9629018549072, 851.289173540094, 857.3484152044444, 869.2046777198864, 12786.296753678556, 17313.220905059272, 17753.911230443846, 17876.0, 18600.813991860112, 14144.292785360716, 16833.32666693331, 16855.0, 17276.22256998435, 17709.114544272798, 968.4576637083238, 977.7653363192853, 983.6163896080499, 985.6845809341014, 986.4771671014338, 666.6866572710818, 1002.6991902429279, 1003.2776400991274, 1004.6031817432109, 1005.4520286443906, 734.9926500734978, 737.9188289288201, 738.5716284554945, 738.9002484664555, 912.8676341930416, 1026.1380440430037, 1029.433811403725, 1031.1080915008502, 1031.1441503552035, 1031.41209510579, 758.3629751009123, 759.4304271796153, 760.4410758092797, 762.1235579084042, 766.3218052023999, 16032.919835400748, 16369.83630163707, 16381.624664423593, 16632.584185395343, 16696.165191740365, 15840.366385344572, 15855.36578536857, 16224.594385140348, 16273.51179464618, 16891.746623800653, 13374.732505349935, 13424.798628020588, 13594.456221751117, 13698.589042328746, 13834.654133646638, 3331.916702082443, 3358.932821343584, 3362.529245905575, 3365.6297807241185, 3366.663333666638, 108959.45520272428, 109124.90875091306, 109183.0, 109192.36211456834, 109362.0, 11941.223820451643, 12274.509019639294, 12315.26108433479, 12341.876581234073, 12343.876561234452, 17313.3940312091, 18703.25186992505, 19317.130729117223, 19543.0, 25147.24558263255, 7082.575045497287, 7221.313975172456, 7289.671964761598, 7300.6349682515665, 7302.379297759644, 3811.7712937223855, 3954.189391174802, 3960.0693836948294, 3962.2471730371135, 3970.2059588082498, 3683.4843121962945, 4238.87283381499, 4263.914721705611, 4267.573242675708, 4275.38006988991, 840.7687885831446, 862.7541150772, 863.6588547523693, 864.5029108262775, 865.5196366016795, 538.6148903533992, 644.4361183964031, 663.10149747092, 670.9194896612438, 690.8756423843656, 11010.0, 11717.414129293502, 11889.583864564871, 11897.226680265929, 11951.701207469709, 575.516566084491, 647.863948570796, 653.9640319782458, 656.8357910522369, 674.3122015544118, 5067.3412456381175, 5278.498542638443, 5418.187271909245, 5457.345118585795, 5545.833624991256, 82228.0, 96780.58048548842, 108983.45508272407, 109977.45011274892, 112819.0, 60065.0, 86612.0, 87598.79422306894, 87737.0, 92256.0, 74517.0, 76512.85230721543, 79162.6041869787, 80052.39895202064, 80595.59702201451, 10501.422421766876, 11922.642320730392, 12433.254004759743, 12503.0, 12556.560520381743, 39436.2112757749, 39436.60563394329, 39646.60353396545, 39793.633018716864, 39842.80078599588, 69968.95046574407, 70342.64828675824, 71679.0, 73062.0, 73182.0, 13813.930930345285, 14172.0, 14173.0, 14180.716385672435, 14214.857851421353, 17348.0, 17385.56536086608, 17465.650686986442, 17762.822371776634, 17940.0, 13282.734345313233, 15740.68518629644, 15760.842391575938, 15897.205139742735, 16450.095244761655, 15609.219539022777, 16100.275487602852, 16215.756763648318, 16303.673926521165, 16573.337066517204, 15381.769273460683, 15567.299471524035, 15644.608884777972, 16656.41702540405, 16711.91644041772, 11713.297202167898, 11750.823737643772, 12250.339488734979, 12272.570460033856, 12412.503499859904, 11704.882951170379, 12576.245425274512, 12935.870641293466, 13790.310484475936, 13828.861711382757], "value": 8031.285045286865, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1416.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 110.0, 109.0, 110.0, 112.0, 110.0, 110.0, 110.0, 110.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 110.0, 105.0, 145.0, 104.0, 105.0, 107.0, 105.0, 135.0, 108.0], "value": 116.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 184.0, 182.0, 184.0, 180.0, 182.0, 184.0, 183.0, 181.0, 179.0], "value": 182.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 57.0, 57.0, 86.0, 59.0, 62.0, 58.0, 58.0, 82.0, 58.0], "value": 66.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 71.0, 85.0, 70.0, 68.0, 70.0, 87.0, 69.0, 68.0, 90.0], "value": 76.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 87.0, 87.0, 87.0, 87.0, 87.0, 87.0, 87.0, 87.0], "value": 87.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 95.0, 96.0, 98.0, 96.0, 94.0, 93.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 84.0, 85.0, 86.0, 83.0, 85.0, 85.0, 84.0, 83.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 48.0, 48.0, 47.0, 47.0, 49.0, 49.0, 46.0, 49.0, 49.0], "value": 48.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 59.0, 59.0, 65.0, 58.0, 56.0, 57.0, 56.0, 55.0], "value": 57.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 82.0, 82.0, 82.0, 82.0, 83.0, 82.0, 83.0, 82.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 134.0, 133.0, 136.0, 136.0, 135.0, 136.0, 133.0, 181.0, 198.0], "value": 146.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 232.0, 185.0, 187.0, 186.0, 204.0, 185.0, 183.0, 186.0, 183.0], "value": 191.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 66.0, 66.0, 67.0, 68.0, 68.0, 91.0, 98.0], "value": 72.4, "unit": "score"}]}]} 14:55:03 INFO - Return code: 0 14:55:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:55:03 ERROR - # TBPL SUCCESS # 14:55:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:55:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:55:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:55:03 INFO - 2017-04-27 14:55:03.734 screenresolution[1651:9663] starting screenresolution argv=screenresolution get 14:55:03 INFO - 2017-04-27 14:55:03.737 screenresolution[1651:9663] Display 0: 1600x1200x32@60 14:55:03 INFO - 2017-04-27 14:55:03.743 screenresolution[1652:9666] starting screenresolution argv=screenresolution list 14:55:03 INFO - Available Modes on Display 0 14:55:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:55:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:55:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:55:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:55:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:55:03 INFO - Intel Iris: 14:55:03 INFO - Chipset Model: Intel Iris 14:55:03 INFO - Type: GPU 14:55:03 INFO - Bus: Built-In 14:55:03 INFO - VRAM (Dynamic, Max): 1536 MB 14:55:03 INFO - Vendor: Intel (0x8086) 14:55:03 INFO - Device ID: 0x0a2e 14:55:03 INFO - Revision ID: 0x0009 14:55:03 INFO - Displays: 14:55:03 INFO - Display: 14:55:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:55:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:55:03 INFO - Display Serial Number: 1600x1200 60 14:55:03 INFO - Main Display: Yes 14:55:03 INFO - Mirror: Off 14:55:03 INFO - Online: Yes 14:55:03 INFO - Rotation: Supported 14:55:03 INFO - Return code: 0 14:55:03 INFO - Running post-action listener: _resource_record_post_action 14:55:03 INFO - [mozharness: 2017-04-27 21:55:03.995115Z] Finished run-tests step (success) 14:55:03 INFO - Running post-run listener: _resource_record_post_run 14:55:04 INFO - Total resource usage - Wall time: 1199s; CPU: 53.0%; Read bytes: 37155840; Write bytes: 511442944; Read time: 240; Write time: 1568 14:55:04 INFO - TinderboxPrint: CPU usage
53.2% 14:55:04 INFO - TinderboxPrint: I/O read bytes / time
37,155,840 / 240 14:55:04 INFO - TinderboxPrint: I/O write bytes / time
511,442,944 / 1,568 14:55:04 INFO - TinderboxPrint: CPU idle
2,244.2 (46.8%) 14:55:04 INFO - TinderboxPrint: CPU system
951.8 (19.8%) 14:55:04 INFO - TinderboxPrint: CPU user
1,601.6 (33.4%) 14:55:04 INFO - TinderboxPrint: Swap in / out
245,657,600 / 0 14:55:04 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 209885696; Write bytes: 206735360; Read time: 16236; Write time: 431 14:55:04 INFO - run-tests - Wall time: 1180s; CPU: 53.0%; Read bytes: 34362368; Write bytes: 297474048; Read time: 217; Write time: 1107 14:55:04 INFO - Running post-run listener: _upload_blobber_files 14:55:04 INFO - Blob upload gear active. 14:55:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:55:04 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 14:55:04 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:55:04 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:55:04 INFO - (blobuploader) - INFO - Open directory for files ... 14:55:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:55:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:55:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:55:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:55:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:55:06 INFO - (blobuploader) - INFO - Done attempting. 14:55:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:55:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:55:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:55:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:55:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:55:07 INFO - (blobuploader) - INFO - Done attempting. 14:55:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:55:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:55:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:55:08 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:55:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:55:08 INFO - (blobuploader) - INFO - Done attempting. 14:55:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:55:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:55:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:55:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:55:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:55:10 INFO - (blobuploader) - INFO - Done attempting. 14:55:10 INFO - (blobuploader) - INFO - Iteration through files over. 14:55:10 INFO - Return code: 0 14:55:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:55:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:55:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5165115c356b47b437428c1a9caf15218fc5ba53ff90e07deb8a3e29ad2ffba755727256c21085caba18115327e3e3c574874fb88e89e0f7c661e4172a54756c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f26d3a2477f9ff8e7dbafd57783ad12662ba63b491100d48a101cc1f132ea9a2dd6a712040e396029659ade27f7b9db5aa1b8c559d73dbe4f82a03414c758f72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7b4718d227d2c6f49f9e59ecacb711434909b781bd7dae5d378d0acc72a5422fcc34d2968bb0adf8b8264d482f51a157bd22855e2f8b7371cf10f5fe4b369493", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c07c6374464518828689ee56f711577526b95c773c5d60a5c222bc562fa11c1b8652167ebfeebe4403b6ffbfdbe97e45ee644b347df5380e7ec70a34d5bde542"} 14:55:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:55:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:55:10 INFO - Contents: 14:55:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5165115c356b47b437428c1a9caf15218fc5ba53ff90e07deb8a3e29ad2ffba755727256c21085caba18115327e3e3c574874fb88e89e0f7c661e4172a54756c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f26d3a2477f9ff8e7dbafd57783ad12662ba63b491100d48a101cc1f132ea9a2dd6a712040e396029659ade27f7b9db5aa1b8c559d73dbe4f82a03414c758f72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7b4718d227d2c6f49f9e59ecacb711434909b781bd7dae5d378d0acc72a5422fcc34d2968bb0adf8b8264d482f51a157bd22855e2f8b7371cf10f5fe4b369493", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c07c6374464518828689ee56f711577526b95c773c5d60a5c222bc562fa11c1b8652167ebfeebe4403b6ffbfdbe97e45ee644b347df5380e7ec70a34d5bde542"} 14:55:10 INFO - Running post-run listener: copy_logs_to_upload_dir 14:55:10 INFO - Copying logs to upload dir... 14:55:10 INFO - mkdir: /builds/slave/test/build/upload/logs 14:55:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.608472 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-04-27 14:55:10.508725) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-27 14:55:10.512558) ========= 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.4DDkWCO3Qi/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.DXafM68OwS/Listeners TMPDIR=/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/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/Firefox/sha512/5165115c356b47b437428c1a9caf15218fc5ba53ff90e07deb8a3e29ad2ffba755727256c21085caba18115327e3e3c574874fb88e89e0f7c661e4172a54756c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f26d3a2477f9ff8e7dbafd57783ad12662ba63b491100d48a101cc1f132ea9a2dd6a712040e396029659ade27f7b9db5aa1b8c559d73dbe4f82a03414c758f72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7b4718d227d2c6f49f9e59ecacb711434909b781bd7dae5d378d0acc72a5422fcc34d2968bb0adf8b8264d482f51a157bd22855e2f8b7371cf10f5fe4b369493", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c07c6374464518828689ee56f711577526b95c773c5d60a5c222bc562fa11c1b8652167ebfeebe4403b6ffbfdbe97e45ee644b347df5380e7ec70a34d5bde542"} build_url:https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011457 build_url: 'https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5165115c356b47b437428c1a9caf15218fc5ba53ff90e07deb8a3e29ad2ffba755727256c21085caba18115327e3e3c574874fb88e89e0f7c661e4172a54756c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f26d3a2477f9ff8e7dbafd57783ad12662ba63b491100d48a101cc1f132ea9a2dd6a712040e396029659ade27f7b9db5aa1b8c559d73dbe4f82a03414c758f72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7b4718d227d2c6f49f9e59ecacb711434909b781bd7dae5d378d0acc72a5422fcc34d2968bb0adf8b8264d482f51a157bd22855e2f8b7371cf10f5fe4b369493", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c07c6374464518828689ee56f711577526b95c773c5d60a5c222bc562fa11c1b8652167ebfeebe4403b6ffbfdbe97e45ee644b347df5380e7ec70a34d5bde542"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-27 14:55:10.549086) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 14:55:10.549453) ========= 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.4DDkWCO3Qi/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.DXafM68OwS/Listeners TMPDIR=/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/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.005144 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 14:55:10.598356) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-27 14:55:10.598677) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-27 14:55:10.598995) ========= ========= Total master_lag: 0.18 =========