builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0070 starttime: 1479151421.3 results: success (0) buildid: 20161114081643 builduid: da4be81bc0254b29b4f65eae2dfacea3 revision: 4ed88686e49e3b941dd9b01f2f5c038f53187a05 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 11:23:41.296397) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 11:23:41.296900) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 11:23:41.297181) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 11:23:41.322046) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:23:41.322370) ========= 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.8mBDbauXmO/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.gY2LNsn3EL/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-14 11:23:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.70M=0.001s 2016-11-14 11:23:41 (9.70 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.081058 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:23:41.426297) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:23:41.426621) ========= 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.8mBDbauXmO/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.gY2LNsn3EL/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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.034495 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:23:41.481323) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 11:23:41.481682) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 4ed88686e49e3b941dd9b01f2f5c038f53187a05 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 4ed88686e49e3b941dd9b01f2f5c038f53187a05 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8mBDbauXmO/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.gY2LNsn3EL/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-14 11:23:41,564 truncating revision to first 12 chars 2016-11-14 11:23:41,564 Setting DEBUG logging. 2016-11-14 11:23:41,564 attempt 1/10 2016-11-14 11:23:41,564 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/4ed88686e49e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-14 11:23:43,281 unpacking tar archive at: mozilla-beta-4ed88686e49e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.974625 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 11:23:43.478458) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 11:23:43.478788) ========= script_repo_revision: 4ed88686e49e3b941dd9b01f2f5c038f53187a05 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 11:23:43.479168) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 11:23:43.479427) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 11:23:43.497708) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-11-14 11:23:43.498067) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8mBDbauXmO/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.gY2LNsn3EL/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 11:23:43 INFO - MultiFileLogger online at 20161114 11:23:43 in /builds/slave/test 11:23:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 11:23:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:23:43 INFO - {'append_to_log': False, 11:23:43 INFO - 'base_work_dir': '/builds/slave/test', 11:23:43 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:23:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:23:43 INFO - 'branch': 'Mozilla-Beta', 11:23:43 INFO - 'buildbot_json_path': 'buildprops.json', 11:23:43 INFO - 'config_files': ('talos/mac_config.py',), 11:23:43 INFO - 'default_actions': ('clobber', 11:23:43 INFO - 'read-buildbot-config', 11:23:43 INFO - 'download-and-extract', 11:23:43 INFO - 'populate-webroot', 11:23:43 INFO - 'create-virtualenv', 11:23:43 INFO - 'install', 11:23:43 INFO - 'run-tests'), 11:23:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:23:43 INFO - 'download_minidump_stackwalk': True, 11:23:43 INFO - 'download_symbols': 'ondemand', 11:23:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:23:43 INFO - 'tooltool.py': '/tools/tooltool.py', 11:23:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:23:43 INFO - '/tools/misc-python/virtualenv.py')}, 11:23:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:23:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:23:43 INFO - 'installer_path': 'installer.exe', 11:23:43 INFO - 'log_level': 'info', 11:23:43 INFO - 'log_name': 'talos', 11:23:43 INFO - 'log_to_console': True, 11:23:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:23:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:23:43 INFO - 'opt_config_files': (), 11:23:43 INFO - 'pip_index': False, 11:23:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:23:43 INFO - 'cmd': ('bash', 11:23:43 INFO - '-c', 11:23:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:23:43 INFO - 'enabled': True, 11:23:43 INFO - 'halt_on_failure': False, 11:23:43 INFO - 'name': 'check_screen_resolution'},), 11:23:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:23:43 INFO - 'cmd': ('bash', 11:23:43 INFO - '-c', 11:23:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:23:43 INFO - 'enabled': True, 11:23:43 INFO - 'halt_on_failure': False, 11:23:43 INFO - 'name': 'check_screen_resolution'},), 11:23:43 INFO - 'run_cmd_checks_enabled': True, 11:23:43 INFO - 'sps_profile': False, 11:23:43 INFO - 'sps_profile_interval': 0, 11:23:43 INFO - 'suite': 'dromaeojs', 11:23:43 INFO - 'system_bits': '32', 11:23:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:23:43 INFO - 'title': 't-yosemite-r7-0070', 11:23:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:23:43 INFO - 'use_talos_json': True, 11:23:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:23:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:23:43 INFO - 'work_dir': 'build'} 11:23:43 INFO - [mozharness: 2016-11-14 19:23:43.702534Z] Running clobber step. 11:23:43 INFO - Running pre-action listener: _resource_record_pre_action 11:23:43 INFO - Running main action method: clobber 11:23:43 INFO - rmtree: /builds/slave/test/build 11:23:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:23:46 INFO - Running post-action listener: _resource_record_post_action 11:23:46 INFO - [mozharness: 2016-11-14 19:23:46.094842Z] Finished clobber step (success) 11:23:46 INFO - [mozharness: 2016-11-14 19:23:46.094966Z] Running read-buildbot-config step. 11:23:46 INFO - Running pre-action listener: _resource_record_pre_action 11:23:46 INFO - Running main action method: read_buildbot_config 11:23:46 INFO - Using buildbot properties: 11:23:46 INFO - { 11:23:46 INFO - "project": "", 11:23:46 INFO - "product": "firefox", 11:23:46 INFO - "script_repo_revision": "production", 11:23:46 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 11:23:46 INFO - "repository": "", 11:23:46 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 11:23:46 INFO - "buildid": "20161114081643", 11:23:46 INFO - "pgo_build": "False", 11:23:46 INFO - "basedir": "/builds/slave/test", 11:23:46 INFO - "buildnumber": 0, 11:23:46 INFO - "slavename": "t-yosemite-r7-0070", 11:23:46 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 11:23:46 INFO - "platform": "yosemite_r7", 11:23:46 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 11:23:46 INFO - "branch": "mozilla-beta", 11:23:46 INFO - "repo_path": "releases/mozilla-beta", 11:23:46 INFO - "revision": "4ed88686e49e3b941dd9b01f2f5c038f53187a05", 11:23:46 INFO - "stage_platform": "macosx64", 11:23:46 INFO - "builduid": "da4be81bc0254b29b4f65eae2dfacea3", 11:23:46 INFO - "slavebuilddir": "test" 11:23:46 INFO - } 11:23:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 11:23:46 INFO - Running post-action listener: _resource_record_post_action 11:23:46 INFO - [mozharness: 2016-11-14 19:23:46.098241Z] Finished read-buildbot-config step (success) 11:23:46 INFO - [mozharness: 2016-11-14 19:23:46.098340Z] Running download-and-extract step. 11:23:46 INFO - Running pre-action listener: _resource_record_pre_action 11:23:46 INFO - Running main action method: download_and_extract 11:23:46 INFO - mkdir: /builds/slave/test/build/tests 11:23:46 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')]} 11:23:46 INFO - trying https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 11:23:46 INFO - Downloading https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 11:23:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json'}, attempt #1 11:23:47 INFO - Downloaded 1165 bytes. 11:23:47 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 11:23:47 INFO - Using the following test package requirements: 11:23:47 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 11:23:47 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 11:23:47 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 11:23:47 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 11:23:47 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 11:23:47 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 11:23:47 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 11:23:47 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 11:23:47 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 11:23:47 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 11:23:47 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 11:23:47 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 11:23:47 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 11:23:47 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 11:23:47 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 11:23:47 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 11:23:47 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 11:23:47 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 11:23:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 11:23:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 11:23:47 INFO - Fetch https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 11:23:47 INFO - Expected file size: 16231351 11:23:54 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip', u'firefox-51.0.en-US.mac.talos.tests.zip'] for test suite category: talos 11:23:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 11:23:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 11:23:54 INFO - Fetch https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 11:23:55 INFO - Expected file size: 16231351 11:24:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 11:24:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 11:24:02 INFO - Fetch https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 11:24:03 INFO - Expected file size: 14414089 11:24: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')]} 11:24:03 INFO - trying https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.dmg 11:24:03 INFO - Downloading https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 11:24:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg'}, attempt #1 11:24:06 INFO - Downloaded 86008559 bytes. 11:24:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.dmg 11:24:06 INFO - mkdir: /builds/slave/test/properties 11:24:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:24:06 INFO - Writing to file /builds/slave/test/properties/build_url 11:24:06 INFO - Contents: 11:24:06 INFO - build_url:https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.dmg 11:24:06 INFO - Running post-action listener: _resource_record_post_action 11:24:06 INFO - Running post-action listener: set_extra_try_arguments 11:24:06 INFO - [mozharness: 2016-11-14 19:24:06.951623Z] Finished download-and-extract step (success) 11:24:06 INFO - [mozharness: 2016-11-14 19:24:06.951739Z] Running populate-webroot step. 11:24:06 INFO - Running pre-action listener: _resource_record_pre_action 11:24:06 INFO - Running main action method: populate_webroot 11:24:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:24:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:24:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:24:06 INFO - '--tppagecycles', 11:24:06 INFO - '7'], 11:24:06 INFO - 'tests': ['tsvgm']}}, 11:24:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:24:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:24:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:24:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:24:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:24:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:24:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:06 INFO - 'talos_options': ['--disable-e10s'], 11:24:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:24:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:24:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:06 INFO - 'talos_options': ['--disable-e10s'], 11:24:06 INFO - 'tests': ['damp', 'tps']}, 11:24:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:06 INFO - 'tests': ['damp', 'tps']}, 11:24:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:24:06 INFO - 'tests': ['dromaeo_dom']}, 11:24:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:24:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:24:06 INFO - 'tests': ['basic_compositor_video']}, 11:24:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:24:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:24:06 INFO - 'tests': ['a11yr', 11:24:06 INFO - 'ts_paint', 11:24:06 INFO - 'tpaint', 11:24:06 INFO - 'sessionrestore', 11:24:06 INFO - 'sessionrestore_no_auto_restore', 11:24:06 INFO - 'tabpaint']}, 11:24:06 INFO - 'other-e10s': {'tests': ['a11yr', 11:24:06 INFO - 'ts_paint', 11:24:06 INFO - 'tpaint', 11:24:06 INFO - 'sessionrestore', 11:24:06 INFO - 'sessionrestore_no_auto_restore', 11:24:06 INFO - 'tabpaint']}, 11:24:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:24:06 INFO - 'ts_paint', 11:24:06 INFO - 'tpaint', 11:24:06 INFO - 'sessionrestore', 11:24:06 INFO - 'sessionrestore_no_auto_restore', 11:24:06 INFO - 'tabpaint']}, 11:24:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:24:06 INFO - 'ts_paint', 11:24:06 INFO - 'tpaint', 11:24:06 INFO - 'sessionrestore', 11:24:06 INFO - 'sessionrestore_no_auto_restore', 11:24:06 INFO - 'tabpaint']}, 11:24:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:24:06 INFO - 'tests': ['a11yr', 11:24:06 INFO - 'ts_paint', 11:24:06 INFO - 'tpaint', 11:24:06 INFO - 'sessionrestore', 11:24:06 INFO - 'sessionrestore_no_auto_restore', 11:24:06 INFO - 'tabpaint']}, 11:24:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:24:06 INFO - 'tests': ['a11yr', 11:24:06 INFO - 'ts_paint', 11:24:06 INFO - 'tpaint', 11:24:06 INFO - 'sessionrestore', 11:24:06 INFO - 'sessionrestore_no_auto_restore', 11:24:06 INFO - 'tabpaint']}, 11:24:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:24:06 INFO - 'tests': ['tsvgx', 11:24:06 INFO - 'tsvgr_opacity', 11:24:06 INFO - 'tart', 11:24:06 INFO - 'tscrollx', 11:24:06 INFO - 'cart']}, 11:24:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:24:06 INFO - 'tsvgr_opacity', 11:24:06 INFO - 'tart', 11:24:06 INFO - 'tscrollx', 11:24:06 INFO - 'cart']}, 11:24:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:06 INFO - 'talos_options': ['--disable-e10s'], 11:24:06 INFO - 'tests': ['tp5o']}, 11:24:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:06 INFO - 'tests': ['tp5o']}, 11:24:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:06 INFO - 'talos_options': ['--disable-e10s', 11:24:06 INFO - '--xperf_path', 11:24:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:24:06 INFO - 'tests': ['tp5n']}, 11:24:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:06 INFO - 'talos_options': ['--xperf_path', 11:24:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:24:06 INFO - 'tests': ['tp5n']}}, 11:24:06 INFO - 'talos.zip': {'path': '', 11:24:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:24:06 INFO - Running post-action listener: _resource_record_post_action 11:24:06 INFO - [mozharness: 2016-11-14 19:24:06.970301Z] Finished populate-webroot step (success) 11:24:06 INFO - [mozharness: 2016-11-14 19:24:06.970418Z] Running create-virtualenv step. 11:24:06 INFO - Running pre-action listener: _resource_record_pre_action 11:24:06 INFO - Running main action method: create_virtualenv 11:24:06 INFO - Creating virtualenv /builds/slave/test/build/venv 11:24:06 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 11:24:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:24:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:24:07 INFO - Using real prefix '/tools/python27' 11:24:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:24:07 INFO - Installing distribute.............................................................................................................................................................................................done. 11:24:10 INFO - Installing pip.................done. 11:24:10 INFO - Return code: 0 11:24:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:24:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:10 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 0x10463a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045b0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2c8d3cbe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10444ed30>, '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 0x1042b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104446b20>, '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.8mBDbauXmO/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.gY2LNsn3EL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 11:24:10 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 11:24:10 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 11:24:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8mBDbauXmO/Render', 11:24:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:24:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:24:10 INFO - 'HOME': '/Users/cltbld', 11:24:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:24:10 INFO - 'LOGNAME': 'cltbld', 11:24:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:10 INFO - 'MOZ_NO_REMOTE': '1', 11:24:10 INFO - 'NO_EM_RESTART': '1', 11:24:10 INFO - 'PAGER': '/bin/cat', 11:24:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:24:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:10 INFO - 'PWD': '/builds/slave/test', 11:24:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:24:10 INFO - 'SHELL': '/bin/bash', 11:24:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gY2LNsn3EL/Listeners', 11:24:10 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 11:24:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:24:10 INFO - 'USER': 'cltbld', 11:24:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:24:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:24:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:10 INFO - 'XPC_FLAGS': '0x0', 11:24:10 INFO - 'XPC_SERVICE_NAME': '0', 11:24:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:24:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:10 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 11:24:10 INFO - Cleaning up... 11:24:11 INFO - Return code: 0 11:24:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:24:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10463a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045b0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2c8d3cbe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10444ed30>, '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 0x1042b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104446b20>, '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.8mBDbauXmO/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.gY2LNsn3EL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 11:24:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:24:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:24:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8mBDbauXmO/Render', 11:24:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:24:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:24:11 INFO - 'HOME': '/Users/cltbld', 11:24:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:24:11 INFO - 'LOGNAME': 'cltbld', 11:24:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:11 INFO - 'MOZ_NO_REMOTE': '1', 11:24:11 INFO - 'NO_EM_RESTART': '1', 11:24:11 INFO - 'PAGER': '/bin/cat', 11:24:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:24:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:11 INFO - 'PWD': '/builds/slave/test', 11:24:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:24:11 INFO - 'SHELL': '/bin/bash', 11:24:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gY2LNsn3EL/Listeners', 11:24:11 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 11:24:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:24:11 INFO - 'USER': 'cltbld', 11:24:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:24:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:24:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:11 INFO - 'XPC_FLAGS': '0x0', 11:24:11 INFO - 'XPC_SERVICE_NAME': '0', 11:24:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:24:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:11 INFO - Downloading/unpacking psutil>=3.1.1 11:24:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:24:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:24:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:24:14 INFO - Installing collected packages: psutil 11:24:14 INFO - Running setup.py install for psutil 11:24:14 INFO - building 'psutil._psutil_osx' extension 11:24:14 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 11:24:14 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 11:24:14 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 11:24:15 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 11:24:15 INFO - building 'psutil._psutil_posix' extension 11:24:15 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 11:24:15 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:24:15 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:24:15 INFO - ^ 11:24:15 INFO - 1 warning generated. 11:24:15 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 11:24:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:24:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:24:15 INFO - Successfully installed psutil 11:24:15 INFO - Cleaning up... 11:24:15 INFO - Return code: 0 11:24:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10463a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045b0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2c8d3cbe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10444ed30>, '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 0x1042b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104446b20>, '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.8mBDbauXmO/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.gY2LNsn3EL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 11:24:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:24:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:24:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8mBDbauXmO/Render', 11:24:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:24:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:24:15 INFO - 'HOME': '/Users/cltbld', 11:24:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:24:15 INFO - 'LOGNAME': 'cltbld', 11:24:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:15 INFO - 'MOZ_NO_REMOTE': '1', 11:24:15 INFO - 'NO_EM_RESTART': '1', 11:24:15 INFO - 'PAGER': '/bin/cat', 11:24:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:24:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:15 INFO - 'PWD': '/builds/slave/test', 11:24:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:24:15 INFO - 'SHELL': '/bin/bash', 11:24:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gY2LNsn3EL/Listeners', 11:24:15 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 11:24:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:24:15 INFO - 'USER': 'cltbld', 11:24:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:24:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:24:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:15 INFO - 'XPC_FLAGS': '0x0', 11:24:15 INFO - 'XPC_SERVICE_NAME': '0', 11:24:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:24:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:24:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:24:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:24:18 INFO - Installing collected packages: mozsystemmonitor 11:24:18 INFO - Running setup.py install for mozsystemmonitor 11:24:18 INFO - Successfully installed mozsystemmonitor 11:24:18 INFO - Cleaning up... 11:24:18 INFO - Return code: 0 11:24:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:24:18 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')]} 11:24:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:18 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')]} 11:24:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:18 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 0x10463a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045b0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2c8d3cbe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10444ed30>, '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 0x1042b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104446b20>, '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.8mBDbauXmO/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.gY2LNsn3EL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 11:24:18 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 11:24:18 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 11:24:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8mBDbauXmO/Render', 11:24:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:24:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:24:18 INFO - 'HOME': '/Users/cltbld', 11:24:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:24:18 INFO - 'LOGNAME': 'cltbld', 11:24:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:18 INFO - 'MOZ_NO_REMOTE': '1', 11:24:18 INFO - 'NO_EM_RESTART': '1', 11:24:18 INFO - 'PAGER': '/bin/cat', 11:24:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:24:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:18 INFO - 'PWD': '/builds/slave/test', 11:24:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:24:18 INFO - 'SHELL': '/bin/bash', 11:24:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gY2LNsn3EL/Listeners', 11:24:18 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 11:24:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:24:18 INFO - 'USER': 'cltbld', 11:24:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:24:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:24:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:18 INFO - 'XPC_FLAGS': '0x0', 11:24:18 INFO - 'XPC_SERVICE_NAME': '0', 11:24:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:24:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:18 INFO - Downloading/unpacking jsonschema==2.5.1 11:24:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:24:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:24:21 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 11:24:21 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 11:24:21 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 11:24:21 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 11:24:21 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 11:24:21 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 11:24:21 INFO - Downloading functools32-3.2.3-2.tar.gz 11:24:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:24:21 INFO - warning: no files found matching '*.txt' 11:24:21 INFO - no previously-included directories found matching 'build' 11:24:21 INFO - no previously-included directories found matching 'dist' 11:24:21 INFO - no previously-included directories found matching '.git*' 11:24:21 INFO - Installing collected packages: jsonschema, functools32 11:24:21 INFO - Running setup.py install for functools32 11:24:22 INFO - warning: no files found matching '*.txt' 11:24:22 INFO - no previously-included directories found matching 'build' 11:24:22 INFO - no previously-included directories found matching 'dist' 11:24:22 INFO - no previously-included directories found matching '.git*' 11:24:22 INFO - Successfully installed jsonschema functools32 11:24:22 INFO - Cleaning up... 11:24:22 INFO - Return code: 0 11:24:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:24:22 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')]} 11:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:22 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')]} 11:24:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:22 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 0x10463a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045b0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2c8d3cbe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10444ed30>, '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 0x1042b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104446b20>, '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.8mBDbauXmO/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.gY2LNsn3EL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 11:24:22 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 11:24:22 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 11:24:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8mBDbauXmO/Render', 11:24:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:24:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:24:22 INFO - 'HOME': '/Users/cltbld', 11:24:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:24:22 INFO - 'LOGNAME': 'cltbld', 11:24:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:22 INFO - 'MOZ_NO_REMOTE': '1', 11:24:22 INFO - 'NO_EM_RESTART': '1', 11:24:22 INFO - 'PAGER': '/bin/cat', 11:24:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:24:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:22 INFO - 'PWD': '/builds/slave/test', 11:24:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:24:22 INFO - 'SHELL': '/bin/bash', 11:24:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gY2LNsn3EL/Listeners', 11:24:22 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 11:24:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:24:22 INFO - 'USER': 'cltbld', 11:24:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:24:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:24:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:22 INFO - 'XPC_FLAGS': '0x0', 11:24:22 INFO - 'XPC_SERVICE_NAME': '0', 11:24:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:24:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:24:22 INFO - Cleaning up... 11:24:22 INFO - Return code: 0 11:24:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:24:22 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')]} 11:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:22 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')]} 11:24:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:22 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 0x10463a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045b0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2c8d3cbe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10444ed30>, '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 0x1042b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104446b20>, '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.8mBDbauXmO/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.gY2LNsn3EL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 11:24:22 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 11:24:22 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 11:24:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8mBDbauXmO/Render', 11:24:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:24:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:24:22 INFO - 'HOME': '/Users/cltbld', 11:24:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:24:22 INFO - 'LOGNAME': 'cltbld', 11:24:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:22 INFO - 'MOZ_NO_REMOTE': '1', 11:24:22 INFO - 'NO_EM_RESTART': '1', 11:24:22 INFO - 'PAGER': '/bin/cat', 11:24:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:24:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:22 INFO - 'PWD': '/builds/slave/test', 11:24:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:24:22 INFO - 'SHELL': '/bin/bash', 11:24:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gY2LNsn3EL/Listeners', 11:24:22 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 11:24:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:24:22 INFO - 'USER': 'cltbld', 11:24:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:24:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:24:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:22 INFO - 'XPC_FLAGS': '0x0', 11:24:22 INFO - 'XPC_SERVICE_NAME': '0', 11:24:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:24:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:22 INFO - Downloading/unpacking blobuploader==1.2.4 11:24:22 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 11:24:22 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 11:24:22 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 11:24:22 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 11:24:22 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 11:24:22 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 11:24:25 INFO - Downloading blobuploader-1.2.4.tar.gz 11:24:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:24:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:24:25 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 11:24:25 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 11:24:25 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 11:24:25 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 11:24:25 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 11:24:25 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 11:24:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:24:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:24:25 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 11:24:25 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 11:24:25 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 11:24:25 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 11:24:25 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 11:24:25 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 11:24:26 INFO - Downloading docopt-0.6.1.tar.gz 11:24:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:24:26 INFO - Installing collected packages: blobuploader, requests, docopt 11:24:26 INFO - Running setup.py install for blobuploader 11:24:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:24:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:24:26 INFO - Running setup.py install for requests 11:24:27 INFO - Running setup.py install for docopt 11:24:27 INFO - Successfully installed blobuploader requests docopt 11:24:27 INFO - Cleaning up... 11:24:27 INFO - Return code: 0 11:24:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:24: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')]} 11:24:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24: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')]} 11:24:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:27 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 0x10463a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045b0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2c8d3cbe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10444ed30>, '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 0x1042b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104446b20>, '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.8mBDbauXmO/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.gY2LNsn3EL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 11:24:27 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 11:24:27 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 11:24:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8mBDbauXmO/Render', 11:24:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:24:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:24:27 INFO - 'HOME': '/Users/cltbld', 11:24:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:24:27 INFO - 'LOGNAME': 'cltbld', 11:24:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:27 INFO - 'MOZ_NO_REMOTE': '1', 11:24:27 INFO - 'NO_EM_RESTART': '1', 11:24:27 INFO - 'PAGER': '/bin/cat', 11:24:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:24:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:27 INFO - 'PWD': '/builds/slave/test', 11:24:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:24:27 INFO - 'SHELL': '/bin/bash', 11:24:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gY2LNsn3EL/Listeners', 11:24:27 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 11:24:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:24:27 INFO - 'USER': 'cltbld', 11:24:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:24:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:24:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:27 INFO - 'XPC_FLAGS': '0x0', 11:24:27 INFO - 'XPC_SERVICE_NAME': '0', 11:24:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:24:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:24:27 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-LMD2gT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:24:27 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-0AQ0hm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:24:27 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-7adXs8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:24:27 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-D3MeY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:24:28 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-K6XyKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:24:28 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-ouZsgk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:24:28 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-JsyQ1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:24:28 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-k1UvaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:24:28 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-BBvBMM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:24:28 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-KCPKMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:24:28 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-mUPF_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:24:28 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-jCGvib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:24:28 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-7h7gC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:24:28 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-KUkcLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:29 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-a0OQZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:24:29 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-fwyfpQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:24:29 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-QQerjs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:24:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:24:29 INFO - Running setup.py install for manifestparser 11:24:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:24:29 INFO - Running setup.py install for mozcrash 11:24:29 INFO - Running setup.py install for mozdebug 11:24:29 INFO - Running setup.py install for mozdevice 11:24:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:24:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:24:29 INFO - Running setup.py install for mozfile 11:24:30 INFO - Running setup.py install for mozhttpd 11:24:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:24:30 INFO - Running setup.py install for mozinfo 11:24:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:24:30 INFO - Running setup.py install for mozInstall 11:24:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:24:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:24:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:24:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:24:30 INFO - Running setup.py install for mozleak 11:24:30 INFO - Running setup.py install for mozlog 11:24:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:24:30 INFO - Running setup.py install for moznetwork 11:24:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:24:31 INFO - Running setup.py install for mozprocess 11:24:31 INFO - Running setup.py install for mozprofile 11:24:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:24:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:24:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:24:31 INFO - Running setup.py install for mozrunner 11:24:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:24:31 INFO - Running setup.py install for mozscreenshot 11:24:31 INFO - Running setup.py install for moztest 11:24:31 INFO - Running setup.py install for mozversion 11:24:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:24:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:24:31 INFO - Cleaning up... 11:24:31 INFO - Return code: 0 11:24:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:24:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:31 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 0x10463a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045b0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2c8d3cbe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10444ed30>, '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 0x1042b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104446b20>, '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.8mBDbauXmO/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.gY2LNsn3EL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 11:24:31 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 11:24:31 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 11:24:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8mBDbauXmO/Render', 11:24:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:24:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:24:31 INFO - 'HOME': '/Users/cltbld', 11:24:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:24:31 INFO - 'LOGNAME': 'cltbld', 11:24:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:31 INFO - 'MOZ_NO_REMOTE': '1', 11:24:31 INFO - 'NO_EM_RESTART': '1', 11:24:31 INFO - 'PAGER': '/bin/cat', 11:24:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:24:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:31 INFO - 'PWD': '/builds/slave/test', 11:24:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:24:31 INFO - 'SHELL': '/bin/bash', 11:24:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gY2LNsn3EL/Listeners', 11:24:31 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 11:24:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:24:31 INFO - 'USER': 'cltbld', 11:24:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:24:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:24:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:31 INFO - 'XPC_FLAGS': '0x0', 11:24:31 INFO - 'XPC_SERVICE_NAME': '0', 11:24:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:24:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:24:32 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-hdDAGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:24:32 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)) 11:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:24:32 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-udPv5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:24:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:24:32 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-HFxOSf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:24:32 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)) 11:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:24:32 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-9RA2eb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:24:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:24:32 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-BIPK52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:24:32 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)) 11:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:24:32 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-28P79a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:24:32 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)) 11:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:24:32 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-8PoCBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:24:33 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)) 11:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:24:33 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-O5E7rM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:24:33 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)) 11:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:24:33 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-WfdDGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:24:33 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)) 11:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:24:33 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-8zpWon-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:24:33 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)) 11:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:24:33 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-I8Vg8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:24:33 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)) 11:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:24:33 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-caVkl4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:24:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:24:33 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-VKkVhJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:24:33 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)) 11:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:24:33 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-Q_e6fT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:24:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:33 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-xjIf63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:33 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)) 11:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:24:33 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-OnlB6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:24:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:24:33 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-6jEldS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:24:34 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)) 11:24:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:24:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:24:34 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)) 11:24:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:24:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:24:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:36 INFO - Downloading blessings-1.6.tar.gz 11:24:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:24:36 INFO - Installing collected packages: blessings 11:24:36 INFO - Running setup.py install for blessings 11:24:36 INFO - Successfully installed blessings 11:24:36 INFO - Cleaning up... 11:24:36 INFO - Return code: 0 11:24:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:24:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:24:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:24:37 INFO - Reading from file tmpfile_stdout 11:24:37 INFO - Current package versions: 11:24:37 INFO - blessings == 1.6 11:24:37 INFO - blobuploader == 1.2.4 11:24:37 INFO - docopt == 0.6.1 11:24:37 INFO - functools32 == 3.2.3-2 11:24:37 INFO - jsonschema == 2.5.1 11:24:37 INFO - manifestparser == 1.1 11:24:37 INFO - mozInstall == 1.12 11:24:37 INFO - mozcrash == 0.17 11:24:37 INFO - mozdebug == 0.1 11:24:37 INFO - mozdevice == 0.48 11:24:37 INFO - mozfile == 1.2 11:24:37 INFO - mozhttpd == 0.7 11:24:37 INFO - mozinfo == 0.9 11:24:37 INFO - mozleak == 0.1 11:24:37 INFO - mozlog == 3.4 11:24:37 INFO - moznetwork == 0.27 11:24:37 INFO - mozprocess == 0.23 11:24:37 INFO - mozprofile == 0.28 11:24:37 INFO - mozrunner == 6.12 11:24:37 INFO - mozscreenshot == 0.1 11:24:37 INFO - mozsystemmonitor == 0.3 11:24:37 INFO - moztest == 0.7 11:24:37 INFO - mozversion == 1.4 11:24:37 INFO - psutil == 3.1.1 11:24:37 INFO - requests == 1.2.3 11:24:37 INFO - wsgiref == 0.1.2 11:24:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:24:37 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')]} 11:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:37 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')]} 11:24:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:37 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 0x10463a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045b0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2c8d3cbe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10444ed30>, '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 0x1042b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104446b20>, '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.8mBDbauXmO/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.gY2LNsn3EL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 11:24:37 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 11:24:37 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 11:24:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8mBDbauXmO/Render', 11:24:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:24:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:24:37 INFO - 'HOME': '/Users/cltbld', 11:24:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:24:37 INFO - 'LOGNAME': 'cltbld', 11:24:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:37 INFO - 'MOZ_NO_REMOTE': '1', 11:24:37 INFO - 'NO_EM_RESTART': '1', 11:24:37 INFO - 'PAGER': '/bin/cat', 11:24:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:24:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:37 INFO - 'PWD': '/builds/slave/test', 11:24:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:24:37 INFO - 'SHELL': '/bin/bash', 11:24:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gY2LNsn3EL/Listeners', 11:24:37 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 11:24:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:24:37 INFO - 'USER': 'cltbld', 11:24:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:24:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:24:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:37 INFO - 'XPC_FLAGS': '0x0', 11:24:37 INFO - 'XPC_SERVICE_NAME': '0', 11:24:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:24:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:37 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)) 11:24:37 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)) 11:24:37 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)) 11:24:37 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)) 11:24:37 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)) 11:24:37 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)) 11:24:37 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)) 11:24:37 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)) 11:24:37 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)) 11:24:37 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)) 11:24:37 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)) 11:24:37 INFO - Cleaning up... 11:24:37 INFO - Return code: 0 11:24:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:24:37 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')]} 11:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:37 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')]} 11:24:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:37 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 0x10463a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045b0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2c8d3cbe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10444ed30>, '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 0x1042b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104446b20>, '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.8mBDbauXmO/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.gY2LNsn3EL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 11:24:37 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 11:24:37 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 11:24:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8mBDbauXmO/Render', 11:24:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:24:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:24:37 INFO - 'HOME': '/Users/cltbld', 11:24:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:24:37 INFO - 'LOGNAME': 'cltbld', 11:24:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:37 INFO - 'MOZ_NO_REMOTE': '1', 11:24:37 INFO - 'NO_EM_RESTART': '1', 11:24:37 INFO - 'PAGER': '/bin/cat', 11:24:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:24:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:37 INFO - 'PWD': '/builds/slave/test', 11:24:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:24:37 INFO - 'SHELL': '/bin/bash', 11:24:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gY2LNsn3EL/Listeners', 11:24:37 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 11:24:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:24:37 INFO - 'USER': 'cltbld', 11:24:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:24:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:24:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:37 INFO - 'XPC_FLAGS': '0x0', 11:24:37 INFO - 'XPC_SERVICE_NAME': '0', 11:24:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:24:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:24:37 INFO - Cleaning up... 11:24:37 INFO - Return code: 0 11:24:37 INFO - Running post-action listener: _resource_record_post_action 11:24:37 INFO - Running post-action listener: _start_resource_monitoring 11:24:37 INFO - Starting resource monitoring. 11:24:37 INFO - [mozharness: 2016-11-14 19:24:37.775997Z] Finished create-virtualenv step (success) 11:24:37 INFO - [mozharness: 2016-11-14 19:24:37.776985Z] Running install step. 11:24:37 INFO - Running pre-action listener: _resource_record_pre_action 11:24:37 INFO - Running main action method: install 11:24:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:24:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:24:38 INFO - Reading from file tmpfile_stdout 11:24:38 INFO - Detecting whether we're running mozinstall >=1.0... 11:24:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:24:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:24:38 INFO - Reading from file tmpfile_stdout 11:24:38 INFO - Output received: 11:24:38 INFO - Usage: mozinstall [options] installer 11:24:38 INFO - Options: 11:24:38 INFO - -h, --help show this help message and exit 11:24:38 INFO - -d DEST, --destination=DEST 11:24:38 INFO - Directory to install application into. [default: 11:24:38 INFO - "/builds/slave/test"] 11:24:38 INFO - --app=APP Application being installed. [default: firefox] 11:24:38 INFO - mkdir: /builds/slave/test/build/application 11:24:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:24:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.mac.dmg --destination /builds/slave/test/build/application 11:25:00 INFO - Reading from file tmpfile_stdout 11:25:00 INFO - Output received: 11:25:00 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 11:25:00 INFO - Running post-action listener: _resource_record_post_action 11:25:00 INFO - [mozharness: 2016-11-14 19:25:00.109857Z] Finished install step (success) 11:25:00 INFO - [mozharness: 2016-11-14 19:25:00.110003Z] Running run-tests step. 11:25:00 INFO - Running pre-action listener: _resource_record_pre_action 11:25:00 INFO - Running main action method: run_tests 11:25:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:25:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:25:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:25:00 INFO - 2016-11-14 11:25:00.124 screenresolution[1642:7568] starting screenresolution argv=screenresolution get 11:25:00 INFO - 2016-11-14 11:25:00.127 screenresolution[1642:7568] Display 0: 1600x1200x32@60 11:25:00 INFO - 2016-11-14 11:25:00.132 screenresolution[1643:7570] starting screenresolution argv=screenresolution list 11:25:00 INFO - Available Modes on Display 0 11:25:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:25:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:25:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:25:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:25:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:25:00 INFO - Intel Iris: 11:25:00 INFO - Chipset Model: Intel Iris 11:25:00 INFO - Type: GPU 11:25:00 INFO - Bus: Built-In 11:25:00 INFO - VRAM (Dynamic, Max): 1536 MB 11:25:00 INFO - Vendor: Intel (0x8086) 11:25:00 INFO - Device ID: 0x0a2e 11:25:00 INFO - Revision ID: 0x0009 11:25:00 INFO - Displays: 11:25:00 INFO - Display: 11:25:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:25:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:25:00 INFO - Display Serial Number: 1600x1200 60 11:25:00 INFO - Main Display: Yes 11:25:00 INFO - Mirror: Off 11:25:00 INFO - Online: Yes 11:25:00 INFO - Rotation: Supported 11:25:00 INFO - Return code: 0 11:25:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:25:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:25:00 INFO - Python 2.7.3 11:25:00 INFO - Return code: 0 11:25:00 INFO - grabbing minidump binary from tooltool 11:25:00 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')]} 11:25:00 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 0x10444ed30>, '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 0x1042b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104446b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:25:00 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 11:25:00 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 11:25:00 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 11:25:00 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:25:00 INFO - Return code: 0 11:25:00 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:25:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:25:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:25:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:25:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:25:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0070', '--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 11:25:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0070 --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 11:25:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8mBDbauXmO/Render', 11:25:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:25:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:25:00 INFO - 'HOME': '/Users/cltbld', 11:25:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:25:00 INFO - 'LOGNAME': 'cltbld', 11:25:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:25:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:25:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:00 INFO - 'MOZ_NO_REMOTE': '1', 11:25:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:25:00 INFO - 'NO_EM_RESTART': '1', 11:25:00 INFO - 'PAGER': '/bin/cat', 11:25:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:25:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:00 INFO - 'PWD': '/builds/slave/test', 11:25:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:25:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:25:00 INFO - 'SHELL': '/bin/bash', 11:25:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gY2LNsn3EL/Listeners', 11:25:00 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 11:25:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:25:00 INFO - 'USER': 'cltbld', 11:25:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:25:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:25:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:00 INFO - 'XPC_FLAGS': '0x0', 11:25:00 INFO - 'XPC_SERVICE_NAME': '0', 11:25:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:25:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0070', '--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 11:25:00 INFO - mozversion application_buildid: 20161114081643 11:25:00 INFO - mozversion application_changeset: 4ed88686e49e3b941dd9b01f2f5c038f53187a05 11:25:00 INFO - mozversion application_display_name: Firefox 11:25:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:25:00 INFO - mozversion application_name: Firefox 11:25:00 INFO - mozversion application_remotingname: firefox 11:25:00 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:25:00 INFO - mozversion application_vendor: Mozilla 11:25:00 INFO - mozversion application_version: 51.0 11:25:00 INFO - mozversion platform_buildid: 20161114081643 11:25:00 INFO - mozversion platform_changeset: 4ed88686e49e3b941dd9b01f2f5c038f53187a05 11:25:00 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:25:00 INFO - mozversion platform_version: 51.0 11:25:00 INFO - using testdate: 1479151500 11:25:00 INFO - actual date: 1479151500 11:25:00 INFO - starting webserver on 'localhost:49272' 11:25:00 INFO - SUITE-START | Running 2 tests 11:25:00 INFO - TEST-START | dromaeo_css 11:25:00 INFO - operating with platform_type : mac_ 11:25:00 INFO - Initialising browser for dromaeo_css test... 11:25:00 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/tmpYXS20U/profile http://localhost:49272/getInfo.html) 11:25:03 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 11:25:03 INFO - PROCESS | 1653 | colorDepth:24 11:25:03 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 11:25:03 INFO - PROCESS | 1653 | __metrics 11:25:03 INFO - PROCESS | 1653 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:25:03 INFO - PROCESS | 1653 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:25:03 INFO - TEST-INFO | 1653: exit 0 11:25:03 INFO - Browser initialized. 11:25:03 INFO - Running cycle 1/1 for dromaeo_css test... 11:25:03 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/tmpYXS20U/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:25:15 INFO - PROCESS | 1656 | RSS: Main: 164392960 11:25:15 INFO - PROCESS | 1656 | 11:26:07 INFO - PROCESS | 1656 | 1479151567023 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:28:17 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 11:28:19 INFO - PROCESS | 1656 | RSS: Main: 289550336 11:28:19 INFO - PROCESS | 1656 | 11:31:21 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 11:31:22 INFO - PROCESS | 1656 | RSS: Main: 301113344 11:31:22 INFO - PROCESS | 1656 | 11:34:24 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 11:34:25 INFO - PROCESS | 1656 | RSS: Main: 292798464 11:34:25 INFO - PROCESS | 1656 | 11:37:27 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 11:37:28 INFO - PROCESS | 1656 | RSS: Main: 268140544 11:37:28 INFO - PROCESS | 1656 | 11:40:31 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 11:40:31 INFO - PROCESS | 1656 | RSS: Main: 268488704 11:40:31 INFO - PROCESS | 1656 | 11:43:34 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 11:43:34 INFO - PROCESS | 1656 | RSS: Main: 429146112 11:43:34 INFO - PROCESS | 1656 | 11:43:34 INFO - PROCESS | 1656 | __start_tp_report 11:43:34 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 11:43:34 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 11:43:34 INFO - PROCESS | 1656 | |i|pagename|runs| 11:43:34 INFO - PROCESS | 1656 | |0;dojo.html;2653.389720364316;2936.7650587952958;3215.061549601738;3562.501249825024;3567;5949.940500594998;6034.6379217246995;6040.818775436733;6063.151158837755;6100.23747031621;5955.106733989904;6051.394860513947;6060.000099983508;6061.575689701723;6066.636001839882;5431.21247419124;5446.673199608016;5474.507294343508;5498.780048798043;5518.2826232589705;5371.973140134294;5383.219433182187;5540.113581826909;5542.224088627595;5544.972275138619;5453.345598528183;5456.645318054314;5469.589780766439;5475.616706830523;5510.972445137769;5459.945400546003;5499.752511137009;5542.695151766651;5557.138643510222;5559.416261292587;5308.336457942757;5382.354117505885;5461.371942226655;5471.616986810925;5511.696856672881;5899.2920849497905;5902.992982386009;5913.763449462016;5978.163057172;6035.517158627299;6314.463270622003;6337.841553961188;6343.968280158616;6359.332270111618;6372.649504277263;6365.49076073913;6371.203599550056;6408.551401401904;6416.582922110095;6421.64680942548;5980.700964951779;6009.939900601025;6040.818775436744;6044.818655440344;6058.939410605925;5461.2627295315415;6472.708728107246;6498.480121590262;6510.18622672166;6534.346565343428;6379.457746091542;6388.265349484869;6389.584676995981;6395.680215989182;6396.744130234739;6293.118963345135;6295.811125666238;6303.086052522359;6336.271328797156;6372.7132279047555;5304.363476382859;6334.683265836689;6342.4926005919415;6347.079673447324;6359.9364006360265;6300.8424789379715;6318.210223722035;6322.841928951813;6327.4938004959495;6331.778387756499;4965.379327584052;5100.48995100487;5131.435542090367;5157.638965272395;5178.430372659004;4603.539646035437;4635.443746750411;4646;4657.743824089707;4662.090892275974;6001.5798894077;6017.398260173947;6017.939820601738;6017.969910150421;6030.849228769228;6255;6324.588901721373;6332.841678958063;6357.87372098827;6421.775237866746;6158.353372895871;6189.721462534107;6194.5354098442795;6209.9068513972325;6212.689365531705;4909.533594308535;5516.062269414209;5691.430856914276;5701.458361455655;5709.628874123168;6436.452901503425;6521;6523.804285871526;6532.804015879531;6545.345465453416;6266.122742816101;6335.334789847;6349.111124442674;6357.90463143044;6405.487560995016;6640.767573134917;6650.767223147167;6653.600783952978;6663.333666633298;6674.532782705358;6360.109584658244;6372.681365931778;6380;6382;6387.872242555216;6294.842628934313;6305.085762564311;6317.5893566918;6327.588706734047;6376.298607153117;6324.620522768649;6355.650439225702;6360.809175724736;6362.045693146065;6372.681365931778;6314.273858506331;6343.714532846126;6360.77737279193;6369.554131210771;6372.330905254881;6123.724432400463;6137.079438084323;6154.415330543591;6180.505559555315;6326.588771729823;6237.812865614039;6303.054541818764;6368.395002474757;6385.584936979268;6387.393197646216;5323.893522129459;6095.811316793182;6231.906521402092;6270.278917924315;6298.653574053471 11:43:34 INFO - PROCESS | 1656 | |1;ext.html;520.2014907117575;530.2523441946855;532.5659587436237;536.3617295418453;542.1244689825933;32345.838270808643;43985.34021989673;45261;45406.54593454064;47454.288185677244;46450.30324545126;47065.52934470654;47084.76457617716;47092;47152.52847471524;9972.850407243897;10154.339967902062;10163.034511721375;10167;10167.288289819715;9405.81188376232;9665.661701840438;12196.756064878697;12428.316442595653;12489.750204995895;12230.755384892296;12310;12313.569025084123;12321.199122057038;12331.876681233207;12213.938930305336;12273.202241854251;12292.385380730928;12292.631221063382;12328.691782705415;12211.877881221162;12277.38613069343;12280.201786883825;12281.263124212575;12292.139550231488;42245.57754422447;42522.57477425217;42662;42682.78658606687;42709.35935960932;3496.685298323138;3557.146284891633;3584.2473080653094;3616.4936908832783;4435.135148646015;31927.84036079828;32153.1961700957;32196.551155197838;32512.83743581267;32873.013809585515;3290.6873846984736;3312.138843900579;3336.432806422914;3353.496975453677;3392.5080863274934;424231;425368;426076;427476.86261568806;427726;33820.985370438924;64054.35945640577;64534;64561.35438645553;64686;35049.948501545;36435;36546.08634784099;36548.45177322342;36593.634063659556;15767.053976761432;15965.680686386208;16004;16008.359665613478;16019.359225630844;12071.396430178456;12390.6282811514;13359.866401336056;13509.932450337685;13523.59429217125;7875.133735289113;8188.058373287029;8195.508269503849;8225.588720563948;8271.462354946909;3337.7830441021742;3365.6802603752603;3376.324735052999;3377.121948293461;3409.335179639996;979.808937257228;1008.9192864570816;1028.4600584693096;1044.9811433852085;1109.2230953602996;31178.1831619635;31283.687163128532;31290.217744556114;31737.523937140963;31883.043508694776;1097.4238524774557;1109.628274528042;1112.7203715726978;1117.9720506987228;1170.9941450292695;16661;16698.075952151234;16775.664486710197;16799.496015119566;16981.660366792596;690869.5456522686;708100;711798;716187;717440;64561.35438645647;65003.349966500675;65193;65305;65508.67245663741;1270.9300988445539;1310.4627102887962;1383.6264208663806;1424.6367176369959;1454.5999850041323;25901.352466188495;30676.84661576678;31748.68251317457;32204;32830.671693283715;55572;56354;56446.717766410904;56625.433745663664;56643.71678141583;486406;486905;487307;490114;492095;27816.86091569529;28654.570181446878;28702.712972870006;28752.712472875002;29402.411951760416;49169.50830491649;49248.9409419387;49258.50741492539;49383;49817.25274120964;40828;43262.56737432711;43391.9152021202;43806.56193438152;44305.55694443014;37903.62096379001;42960.35559466548;43655;43740.56259437365;44211.115777683626;39957.2008559833;40691.389629155;40886.59113408828;40903.77288681344;40936.385954211306;34411.13972150616;36555.45166822553;37144.628553714116;37242;37290.8135459321;23700.170494032627;25417.364565886;26648.8667556661;26726;26913.596296055966 11:43:34 INFO - PROCESS | 1656 | |2;jquery.html;374.3056629951442;377.78088708549035;388.544899351927;389.2448649619739;411.8332075509418;19783.802161978376;21869.781302186973;21886.343409697696;22196.88901555492;23238.954247058922;17694.557636059104;20665.966701664933;20802.583948321026;21276.36170914875;21731.456713582167;5510.311211098613;5924.6149000314845;6191.938080619181;6266.686665666722;6308.053791931201;6129.233845769279;6228.5017198624;6272.090546870701;6278.6860656966965;6953.756618518353;6963.338482844122;6978.302169783032;6979.47653925955;6984.755533556327;7010.75462358815;6239.875202495948;6300;6308.842278943017;6359.109724638532;6974.51178417511;5912;6155.230596175478;6160;6164.753409863645;6169;12872.935635321763;13201.933990330082;13283.601491955256;13306.733865322736;13325.13386629866;2217.634090375086;2337.6610391493136;2381.2380038387723;2381.4760752634393;2414.5291668124723;8842.93884733836;9978.90021099787;10022.448765317904;10150.340227885164;10748.301360411626;1659.3030927010684;1872.6722823505831;1995.1520603743495;1999.71004204391;2002.979970200294;86513.56743216306;117830.23254651188;130121;137571;140185.99999999898;11656.766864662659;11704.648860534198;11806.291622502677;11817.586384476503;11981.760364792655;15250.161241131622;15260.084394936339;15264.542063738105;15265.236738163047;15267;9061.95469022664;9123.726288211365;9147;9158.450492970444;9221.308401869886;9074.45553266806;9112.908870911338;9146.2682985361;9211.723648290563;9268.860967085498;4549.135664223787;4673.439187297546;4674.275487299406;4726.716397016121;4735.928961065587;1925.7881633020356;1969.6257711034857;1978.9505262368268;1982.415187519685;1989.263972330247;828.9751307460785;893.2139717049085;898.1871953557192;1000;1043.212374657129;22106.33680989573;22536.774632253466;22555.887220563793;22632.773672263396;22667.20664776725;981.3228872078244;985.261054209343;986.1420564109271;1009.1876039787894;1031.7575369788094;11270.492827822603;11665.183437159318;11907.285562866256;11911.927926486658;11923.105767067505;551231;561360;648807;668257;669812;117964.41017795028;123548;142636;146593;147877;949.539473355422;958.8274110660149;967.8693376394097;969.0793745941384;973.6446197137993;19107.331243406414;20068.39794806158;20110;20426.489337766674;20512.641046279274;46944.29583556181;48519.272210917574;61679.69160154171;62985;63593;74857;80554.59722701584;86304.56847715721;89436;90104.54947725219;7360.263973602811;7573.621318933921;7669.539827610138;8231.34149268069;8571.442856214326;9329.346945713734;13464.057515973787;13528.729425411633;13926.30368481592;14396.352164152848;11500.597479088192;11716.121290903046;12023.579174728842;12066;12073.27560346382;9502.47736374506;9552.42685438876;11755;11807.114466415225;12139.757204855678;11836.171467997157;11859.881401185878;11960.880391195977;12105.636830895088;12300.753984920073;7634.885476717965;7739.845203095794;7766.805829854299;7767.456278060482;7983.081945576333;10360.948195258976;11804.291742495478;11892.76214475723;12065.638030858738;12171.634850954486 11:43:34 INFO - PROCESS | 1656 | |3;mootools.html;1428.2501686614532;1451.1365737386254;1595.6569337592416;1797.4517772079519;1932.5844943337179;8340.623797073484;8878.955605221972;9099.727008189748;9507;9517.524123793817;9250.259979201664;9345.859812102824;9352.906470935288;9362.110599493037;9370.344075914672;2442.267319804056;2473.7773600375963;2479.0455674565333;2479.7148327942245;2480.875956202192;2407.4703565215714;2465.9753402466013;2467.642191882176;2468.148488771371;2469.8518088914634;2407.831451798375;2442.3039433761382;2460.3972026853444;2461.089396923132;2465.543874383236;2405.915792947256;2435.257246539805;2438.292895060439;2444.364465239033;2446.5473887330722;2406.7352591214953;2418.069043418279;2426.277343086411;2427.077710470028;2429.1740808125146;9262.39794413361;9473.715788526355;9476.289278304155;9483;9507.906590742085;5460.726963651841;5689.544836413077;5698.487136157724;5737.082066869322;5747.482726554588;3769.4157405602177;3808.980955095207;3829.4064420014943;3880.2821478026653;3904.297226499229;1114.3202646385698;1114.799336119498;1118.4351902289293;1137.1357768096307;1140.3841925360377;12469;12506.937465312707;12594;12595.370231488389;12623.810642840273;4545.8408955687055;4619.9769001155455;4795.20879054959;4804.615630749601;4806;9629.518524073768;9640.75898102553;9645.71062868115;9694.127528522467;9700.660476883275;5495.807646732425;5499.1476321170285;5500.669959802424;5500.944990550123;5505.807296744595;4496.258117410591;4647.674662773641;4800.759962001886;4829.96155826499;5163.870903227449;3176.5552822604855;3857.517810273716;3965.5637879833193;3966.424868394067;3975.2248311578965;1183.5325046606542;1187.2994932989404;1192.2846292224597;1200.0699457920007;1205.8070708686569;945.4847108325979;954.6897258391051;968.7917097823861;973.5570315506427;1007.3982368034859;6008.158857759917;6041.2750469943885;6050.273967123973;6063.484603808637;6172.69136543171;444.6331776284578;447.98656040318843;454.6908102490272;460.1165761737472;460.6821293307674;4044.9797751011056;4085.22380747657;4106.7946602670345;4112.444819949268;4169.291220492463;11216.270942388881;11489.655310340702;11562.537498500134;11577.131715121399;11584.189106762446;11420.029297509638;11420.543178272776;11420.972112509913;11492.885071149181;11534.307941523535;7503.437242206856;8599.527026013504;8625.999999999874;8649.567521623894;8675.045744968049;6113.969430152821;6201.875962480815;6209.689515524296;6302.401271879165;6321.367863213642;9063.728088157366;10584.629537966135;10674.412907290174;10816.621418250323;10935.726606834574;10668.573257069631;10793.892061079288;11074.667759967213;11091.778164436504;11135.387553684624;7647.732329368446;7898.091719452336;7993;8064.798380040546;8066.87899681517;7561.168271490242;8843.292536597186;8921.06328835489;8929.330300227639;8944.239739621944;7856;7963.562004089599;7990.121086680344;8119.431639785158;8158.224968627971;7709.922900770921;7789.805254868447;7798.766037018899;7825.686972521035;7844.568548729874;7323.487355885037;7386.556806591621;7460.813479663052;7462.179160292472;7465.776026719207;4362.672799540111;5112.514311140436;5157.355330583677;5331.653442526223;5430.40265570779;4543.182227199136;5266.97366513165;5310.150375939831;5390.353157621111;5530.6128570999645 11:43:34 INFO - PROCESS | 1656 | |4;prototype.html;277.83468836042556;309.57433528897764;310.77313561100397;314.70889427279775;317.5918944156759;5507.54050176703;5514.5864060195545;5544.334679838415;5545.833624991256;5566.1334412777405;5406.270153529273;5424.226680521136;5433.538149257308;5448.891022179554;5449.073657478229;3441.4493681011045;3747.5690295615946;3944.7179666608254;4083.3466645336753;4093.44738460307;3774.735768496206;3904.026838936418;4050.5949405059405;4077.245709543729;4129.421880936671;3506.0183148718274;4063.451434056394;4069.308217603;4070.9185816283657;4107.274944523292;3367.511710801932;3862.7938810786977;3879.3318872884647;4102.815373308194;4147.382520816884;3572.7856328620105;3599.9840089549675;3611.9277614447565;3613.8915832525067;3617.457381392786;4952;5277.973610131925;5299.2845965794895;5310.99091172676;5317.867053323659;3894.6494815466745;4067.5118985721606;4155.667546596265;4629.722216667011;4678.508756580578;4428.579284967923;5438.646487978269;5724.656520608735;5729.942700572982;5747.18963526492;3834.7123965702685;3863.1070775320172;3876.9418458723144;3887.7278590498677;3901.6878649707955;4525.434320709911;4910.625024993008;5633.943610582149;5931.466168044896;5981.730822113015;3114.9377012460077;3272.280098378353;3804.334241507725;3818.9427158592644;3925.6074392561086;3691.4126925422324;3850.4609354690365;3974.5627980922077;4004.9199016019516;4028.617281358266;4092.6316631502714;4345.848804841624;4651.534846515321;4675.625949923998;4683.461401938753;5557.055300598908;5559.305086864142;5649.4633009864;5716.771329146787;5728.281515545403;1203.3441774233063;1348.4021434600031;1352.8850047745855;1355.9559139462558;1358.3887250737207;785.3795501553823;814.8998851550359;822.9506229626242;832.4505826154709;833.2167762303536;3903.843846246118;4263.445752052214;4540.636749060067;4565.315202719618;4591.265397536378;4666.673332866667;4864.440589332272;4918.360613120271;4926.4088309403105;4991.5258050485145;3597.5862775780597;3926.5877082906454;4474.485434175112;4481.414868105568;4558.521355257716;1822.6239189412174;2295.391721193885;2508.523380557688;2606.960895586568;2614.8692565372035;4526.977365113219;4586.518415566385;4588.678792484494;4687.9683472213865;4928;4115.54728979812;4698.835540756126;5015.3730783652045;5031.899362012739;5034.421041580265;4448.219862585884;4774.355462012653;5091.1090559152;5109.182530795055;5119.539241468286;4267.722598031118;4485.753283569305;4665.090307390026;4932.383452068491;4935.827246046371;4476.4556228101255;4811.3264143019305;4836.274558816206;4845.127876982177;4866.318715379779;3914.745541539791;4147.440095587057;4599.149157405891;5743.396943321059;6065.6663883486835;3050.8322042287;3348.983255083709;3820.6943444523818;3924.9607503925736;3937.5865534118507;4500;5446.128619420873;5676.914846277226;5981.132735753378;6000.429959153874;5220.973895130652;5333.919991200058;5501.669899806025;5778.8266352009505;5811.506021988178;4872.6832755870755;5667.866426714591;5714.371419143974;5722.198892155018;5743.1385292206505;5113.948860511496;5620.85947851307;5655.529562313745;5662.377138514677;5663.150527420919;4911.3369695090705;5548.55611551083;5621.775128994795;5687.971560142173;5739.339975902824;4962.702237865739;5106.591472682251;5325.520703136736;5550.88982203569;5624.9750089966765 11:43:34 INFO - PROCESS | 1656 | |5;yui.html;693.0089971340983;735.749845052682;794.9801254968625;819.6024927909963;836.7657056024316;16072.91963540182;17325.306987720476;17351;17358.611311095112;17405.738913916284;14415;14448.133112013287;14460.710785784278;14462.493812716557;14475.782863257033;714.1858281559026;736.4991805572208;737.9741709040185;881.9382643214977;885.2740752582885;903.1104362203257;906.0893801729286;918.7106061590611;920.1304766995192;920.8664743612172;885.5660726244158;978.8727465429484;979.1970584121024;981.092489447262;983.6950545330934;973.4305431322684;973.5813600151931;974.5663179884954;974.7758015656439;974.9756256093583;719.0795781399817;720.3660778514874;720.5712601002396;721.4913485992363;721.779857143571;16036;16328.020318780911;16488.17559122039;16516.587085322844;16519.752203716835;14833.110013399231;15576.598106170386;15657;15876.12681302528;15904.681906361924;12233.510659573607;12299.877001229963;12305.75388492234;12337;12406.62780116598;3925.6270654288082;4002.4996875390575;4010.0776821330965;4028.3554631258858;4151.481064866892;107735;110590.44704776505;111061.33407998887;119613.40193299064;126222.36888815589;11479.196456247982;11498.827517587242;11712.180147389601;11757.059435245159;12217.144799864102;23119.653205201597;23169.53660926772;23170.536589268122;23173.304800855665;23176.884115579312;7484.887726684104;8068.112507624157;8475.915240847637;8675.655273432629;8691.608877600524;3542.3446662367546;4644.4934074774;4666.066786642685;4763.523647635278;4845.781939812717;3698.2973235085246;3848.037990502374;3850.979490435037;3855.1904100139286;3857.672097871656;582.251806428737;689.8309914071085;693.4071368979551;694.1358009278481;704.1550139832221;536.8443151486103;610.3926593039865;630.9589876658002;698.4656737595743;699.1505321034865;9574.642228229812;10038.932561643158;10124.139448146843;10293.176545876311;10569.365838049742;559.0942672869895;606.884691908536;682.331315310998;705.7670968580356;714.9749758758419;4601.884952876205;4950.529699678525;4980.203167493256;4986.152354099811;4988.276699878497;106441;115178.27232591518;172465;177301;183672;92168.07831921594;92273.61589576161;120612.39693801475;137377;149986.25006875113;85831;118816.40591796985;120235.196472053;120275;124361;10057.094861462503;10487.26589138753;10551.736206594896;10579.15366770641;10650.147988160774;65572.67213664092;65647.34352656412;65655.34344656684;66421;67417.66291168513;97404;101573;102074;103889.48055259675;106437.46781266044;13422.597322080353;13866;13901.58295251144;14099.577012689635;14114.01201915897;12021.278723276282;12322.876771232173;12661.240325580495;12826;13235.602931912059;12368.628941131781;12657.87342126567;12859.807102893277;14392.928035359757;14650.706985860435;14340.56978290653;14614.488492902698;14617.780733288797;14685.412583496967;14894.77657835155;13636.454541818217;13946.16323020622;14224.431022758974;14502.85497145015;14851;11383.203175777617;11518.769624607628;11568.826467603161;12183.512659493521;12589.18170318963;10309.896901030894;12048.51805927753;12129.636110916686;12399.318037508023;12451.377431128227 11:43:34 INFO - PROCESS | 1656 | __end_tp_report 11:43:34 INFO - PROCESS | 1656 | __start_cc_report 11:43:34 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,1464 11:43:34 INFO - PROCESS | 1656 | __end_cc_report 11:43:34 INFO - PROCESS | 1656 | __startTimestamp1479152614859__endTimestamp 11:43:34 INFO - PROCESS | 1656 | 11:43:34 INFO - PROCESS | 1656 | ------- Summary: start ------- 11:43:34 INFO - PROCESS | 1656 | Number of tests: 6 11:43:34 INFO - PROCESS | 1656 | 11:43:34 INFO - PROCESS | 1656 | [#0] dojo.html Cycles:165 Average:5942.52 Median:6212.69 stddev:680.39 (11.0%) stddev-sans-first:631.66 11:43:34 INFO - PROCESS | 1656 | Values: 2653.4 2936.8 3215.1 3562.5 3567.0 5949.9 6034.6 6040.8 6063.2 6100.2 5955.1 6051.4 6060.0 6061.6 6066.6 5431.2 5446.7 5474.5 5498.8 5518.3 5372.0 5383.2 5540.1 5542.2 5545.0 5453.3 5456.6 5469.6 5475.6 5511.0 5459.9 5499.8 5542.7 5557.1 5559.4 5308.3 5382.4 5461.4 5471.6 5511.7 5899.3 5903.0 5913.8 5978.2 6035.5 6314.5 6337.8 6344.0 6359.3 6372.6 6365.5 6371.2 6408.6 6416.6 6421.6 5980.7 6009.9 6040.8 6044.8 6058.9 5461.3 6472.7 6498.5 6510.2 6534.3 6379.5 6388.3 6389.6 6395.7 6396.7 6293.1 6295.8 6303.1 6336.3 6372.7 5304.4 6334.7 6342.5 6347.1 6359.9 6300.8 6318.2 6322.8 6327.5 6331.8 4965.4 5100.5 5131.4 5157.6 5178.4 4603.5 4635.4 4646.0 4657.7 4662.1 6001.6 6017.4 6017.9 6018.0 6030.8 6255.0 6324.6 6332.8 6357.9 6421.8 6158.4 6189.7 6194.5 6209.9 6212.7 4909.5 5516.1 5691.4 5701.5 5709.6 6436.5 6521.0 6523.8 6532.8 6545.3 6266.1 6335.3 6349.1 6357.9 6405.5 6640.8 6650.8 6653.6 6663.3 6674.5 6360.1 6372.7 6380.0 6382.0 6387.9 6294.8 6305.1 6317.6 6327.6 6376.3 6324.6 6355.7 6360.8 6362.0 6372.7 6314.3 6343.7 6360.8 6369.6 6372.3 6123.7 6137.1 6154.4 6180.5 6326.6 6237.8 6303.1 6368.4 6385.6 6387.4 5323.9 6095.8 6231.9 6270.3 6298.7 11:43:34 INFO - PROCESS | 1656 | 11:43:34 INFO - PROCESS | 1656 | [#1] ext.html Cycles:180 Average:68329.10 Median:19303.55 stddev:148369.95 (768.6%) stddev-sans-first:148698.81 11:43:34 INFO - PROCESS | 1656 | Values: 520.2 530.3 532.6 536.4 542.1 32345.8 43985.3 45261.0 45406.5 47454.3 46450.3 47065.5 47084.8 47092.0 47152.5 9972.9 10154.3 10163.0 10167.0 10167.3 9405.8 9665.7 12196.8 12428.3 12489.8 12230.8 12310.0 12313.6 12321.2 12331.9 12213.9 12273.2 12292.4 12292.6 12328.7 12211.9 12277.4 12280.2 12281.3 12292.1 42245.6 42522.6 42662.0 42682.8 42709.4 3496.7 3557.1 3584.2 3616.5 4435.1 31927.8 32153.2 32196.6 32512.8 32873.0 3290.7 3312.1 3336.4 3353.5 3392.5 424231.0 425368.0 426076.0 427476.9 427726.0 33821.0 64054.4 64534.0 64561.4 64686.0 35049.9 36435.0 36546.1 36548.5 36593.6 15767.1 15965.7 16004.0 16008.4 16019.4 12071.4 12390.6 13359.9 13509.9 13523.6 7875.1 8188.1 8195.5 8225.6 8271.5 3337.8 3365.7 3376.3 3377.1 3409.3 979.8 1008.9 1028.5 1045.0 1109.2 31178.2 31283.7 31290.2 31737.5 31883.0 1097.4 1109.6 1112.7 1118.0 1171.0 16661.0 16698.1 16775.7 16799.5 16981.7 690869.5 708100.0 711798.0 716187.0 717440.0 64561.4 65003.3 65193.0 65305.0 65508.7 1270.9 1310.5 1383.6 1424.6 1454.6 25901.4 30676.8 31748.7 32204.0 32830.7 55572.0 56354.0 56446.7 56625.4 56643.7 486406.0 486905.0 487307.0 490114.0 492095.0 27816.9 28654.6 28702.7 28752.7 29402.4 49169.5 49248.9 49258.5 49383.0 49817.3 40828.0 43262.6 43391.9 43806.6 44305.6 37903.6 42960.4 43655.0 43740.6 44211.1 39957.2 40691.4 40886.6 40903.8 40936.4 34411.1 36555.5 37144.6 37242.0 37290.8 23700.2 25417.4 26648.9 26726.0 26913.6 11:43:34 INFO - PROCESS | 1656 | 11:43:34 INFO - PROCESS | 1656 | [#2] jquery.html Cycles:180 Average:36257.86 Median:2381.36 stddev:104091.61 (4371.1%) stddev-sans-first:104348.74 11:43:34 INFO - PROCESS | 1656 | Values: 374.3 377.8 388.5 389.2 411.8 19783.8 21869.8 21886.3 22196.9 23239.0 17694.6 20666.0 20802.6 21276.4 21731.5 5510.3 5924.6 6191.9 6266.7 6308.1 6129.2 6228.5 6272.1 6278.7 6953.8 6963.3 6978.3 6979.5 6984.8 7010.8 6239.9 6300.0 6308.8 6359.1 6974.5 5912.0 6155.2 6160.0 6164.8 6169.0 12872.9 13201.9 13283.6 13306.7 13325.1 2217.6 2337.7 2381.2 2381.5 2414.5 8842.9 9978.9 10022.4 10150.3 10748.3 1659.3 1872.7 1995.2 1999.7 2003.0 86513.6 117830.2 130121.0 137571.0 140186.0 11656.8 11704.6 11806.3 11817.6 11981.8 15250.2 15260.1 15264.5 15265.2 15267.0 9062.0 9123.7 9147.0 9158.5 9221.3 9074.5 9112.9 9146.3 9211.7 9268.9 4549.1 4673.4 4674.3 4726.7 4735.9 1925.8 1969.6 1979.0 1982.4 1989.3 829.0 893.2 898.2 1000.0 1043.2 22106.3 22536.8 22555.9 22632.8 22667.2 981.3 985.3 986.1 1009.2 1031.8 11270.5 11665.2 11907.3 11911.9 11923.1 551231.0 561360.0 648807.0 668257.0 669812.0 117964.4 123548.0 142636.0 146593.0 147877.0 949.5 958.8 967.9 969.1 973.6 19107.3 20068.4 20110.0 20426.5 20512.6 46944.3 48519.3 61679.7 62985.0 63593.0 74857.0 80554.6 86304.6 89436.0 90104.5 7360.3 7573.6 7669.5 8231.3 8571.4 9329.3 13464.1 13528.7 13926.3 14396.4 11500.6 11716.1 12023.6 12066.0 12073.3 9502.5 9552.4 11755.0 11807.1 12139.8 11836.2 11859.9 11960.9 12105.6 12300.8 7634.9 7739.8 7766.8 7767.5 7983.1 10360.9 11804.3 11892.8 12065.6 12171.6 11:43:34 INFO - PROCESS | 1656 | 11:43:34 INFO - PROCESS | 1656 | [#3] mootools.html Cycles:180 Average:5977.50 Median:4721.44 stddev:3439.55 (72.8%) stddev-sans-first:3432.21 11:43:34 INFO - PROCESS | 1656 | Values: 1428.3 1451.1 1595.7 1797.5 1932.6 8340.6 8879.0 9099.7 9507.0 9517.5 9250.3 9345.9 9352.9 9362.1 9370.3 2442.3 2473.8 2479.0 2479.7 2480.9 2407.5 2466.0 2467.6 2468.1 2469.9 2407.8 2442.3 2460.4 2461.1 2465.5 2405.9 2435.3 2438.3 2444.4 2446.5 2406.7 2418.1 2426.3 2427.1 2429.2 9262.4 9473.7 9476.3 9483.0 9507.9 5460.7 5689.5 5698.5 5737.1 5747.5 3769.4 3809.0 3829.4 3880.3 3904.3 1114.3 1114.8 1118.4 1137.1 1140.4 12469.0 12506.9 12594.0 12595.4 12623.8 4545.8 4620.0 4795.2 4804.6 4806.0 9629.5 9640.8 9645.7 9694.1 9700.7 5495.8 5499.1 5500.7 5500.9 5505.8 4496.3 4647.7 4800.8 4830.0 5163.9 3176.6 3857.5 3965.6 3966.4 3975.2 1183.5 1187.3 1192.3 1200.1 1205.8 945.5 954.7 968.8 973.6 1007.4 6008.2 6041.3 6050.3 6063.5 6172.7 444.6 448.0 454.7 460.1 460.7 4045.0 4085.2 4106.8 4112.4 4169.3 11216.3 11489.7 11562.5 11577.1 11584.2 11420.0 11420.5 11421.0 11492.9 11534.3 7503.4 8599.5 8626.0 8649.6 8675.0 6114.0 6201.9 6209.7 6302.4 6321.4 9063.7 10584.6 10674.4 10816.6 10935.7 10668.6 10793.9 11074.7 11091.8 11135.4 7647.7 7898.1 7993.0 8064.8 8066.9 7561.2 8843.3 8921.1 8929.3 8944.2 7856.0 7963.6 7990.1 8119.4 8158.2 7709.9 7789.8 7798.8 7825.7 7844.6 7323.5 7386.6 7460.8 7462.2 7465.8 4362.7 5112.5 5157.4 5331.7 5430.4 4543.2 5267.0 5310.2 5390.4 5530.6 11:43:34 INFO - PROCESS | 1656 | 11:43:34 INFO - PROCESS | 1656 | [#4] prototype.html Cycles:180 Average:4322.13 Median:4658.31 stddev:1343.16 (28.8%) stddev-sans-first:1312.18 11:43:34 INFO - PROCESS | 1656 | Values: 277.8 309.6 310.8 314.7 317.6 5507.5 5514.6 5544.3 5545.8 5566.1 5406.3 5424.2 5433.5 5448.9 5449.1 3441.4 3747.6 3944.7 4083.3 4093.4 3774.7 3904.0 4050.6 4077.2 4129.4 3506.0 4063.5 4069.3 4070.9 4107.3 3367.5 3862.8 3879.3 4102.8 4147.4 3572.8 3600.0 3611.9 3613.9 3617.5 4952.0 5278.0 5299.3 5311.0 5317.9 3894.6 4067.5 4155.7 4629.7 4678.5 4428.6 5438.6 5724.7 5729.9 5747.2 3834.7 3863.1 3876.9 3887.7 3901.7 4525.4 4910.6 5633.9 5931.5 5981.7 3114.9 3272.3 3804.3 3818.9 3925.6 3691.4 3850.5 3974.6 4004.9 4028.6 4092.6 4345.8 4651.5 4675.6 4683.5 5557.1 5559.3 5649.5 5716.8 5728.3 1203.3 1348.4 1352.9 1356.0 1358.4 785.4 814.9 823.0 832.5 833.2 3903.8 4263.4 4540.6 4565.3 4591.3 4666.7 4864.4 4918.4 4926.4 4991.5 3597.6 3926.6 4474.5 4481.4 4558.5 1822.6 2295.4 2508.5 2607.0 2614.9 4527.0 4586.5 4588.7 4688.0 4928.0 4115.5 4698.8 5015.4 5031.9 5034.4 4448.2 4774.4 5091.1 5109.2 5119.5 4267.7 4485.8 4665.1 4932.4 4935.8 4476.5 4811.3 4836.3 4845.1 4866.3 3914.7 4147.4 4599.1 5743.4 6065.7 3050.8 3349.0 3820.7 3925.0 3937.6 4500.0 5446.1 5676.9 5981.1 6000.4 5221.0 5333.9 5501.7 5778.8 5811.5 4872.7 5667.9 5714.4 5722.2 5743.1 5113.9 5620.9 5655.5 5662.4 5663.2 4911.3 5548.6 5621.8 5688.0 5739.3 4962.7 5106.6 5325.5 5550.9 5625.0 11:43:34 INFO - PROCESS | 1656 | 11:43:34 INFO - PROCESS | 1656 | [#5] yui.html Cycles:180 Average:25645.50 Median:17354.81 stddev:40782.42 (235.0%) stddev-sans-first:40853.79 11:43:34 INFO - PROCESS | 1656 | Values: 693.0 735.7 795.0 819.6 836.8 16072.9 17325.3 17351.0 17358.6 17405.7 14415.0 14448.1 14460.7 14462.5 14475.8 714.2 736.5 738.0 881.9 885.3 903.1 906.1 918.7 920.1 920.9 885.6 978.9 979.2 981.1 983.7 973.4 973.6 974.6 974.8 975.0 719.1 720.4 720.6 721.5 721.8 16036.0 16328.0 16488.2 16516.6 16519.8 14833.1 15576.6 15657.0 15876.1 15904.7 12233.5 12299.9 12305.8 12337.0 12406.6 3925.6 4002.5 4010.1 4028.4 4151.5 107735.0 110590.4 111061.3 119613.4 126222.4 11479.2 11498.8 11712.2 11757.1 12217.1 23119.7 23169.5 23170.5 23173.3 23176.9 7484.9 8068.1 8475.9 8675.7 8691.6 3542.3 4644.5 4666.1 4763.5 4845.8 3698.3 3848.0 3851.0 3855.2 3857.7 582.3 689.8 693.4 694.1 704.2 536.8 610.4 631.0 698.5 699.2 9574.6 10038.9 10124.1 10293.2 10569.4 559.1 606.9 682.3 705.8 715.0 4601.9 4950.5 4980.2 4986.2 4988.3 106441.0 115178.3 172465.0 177301.0 183672.0 92168.1 92273.6 120612.4 137377.0 149986.3 85831.0 118816.4 120235.2 120275.0 124361.0 10057.1 10487.3 10551.7 10579.2 10650.1 65572.7 65647.3 65655.3 66421.0 67417.7 97404.0 101573.0 102074.0 103889.5 106437.5 13422.6 13866.0 13901.6 14099.6 14114.0 12021.3 12322.9 12661.2 12826.0 13235.6 12368.6 12657.9 12859.8 14392.9 14650.7 14340.6 14614.5 14617.8 14685.4 14894.8 13636.5 13946.2 14224.4 14502.9 14851.0 11383.2 11518.8 11568.8 12183.5 12589.2 10309.9 12048.5 12129.6 12399.3 12451.4 11:43:34 INFO - PROCESS | 1656 | -------- Summary: end -------- 11:43:34 INFO - PROCESS | 1656 | 11:43:35 INFO - TEST-INFO | 1656: exit 0 11:43:35 INFO - TEST-OK | dromaeo_css | took 1114772ms 11:43:35 INFO - TEST-START | kraken 11:43:35 INFO - operating with platform_type : mac_ 11:43:35 INFO - Initialising browser for kraken test... 11:43:35 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/tmpIOCC6S/profile http://localhost:49272/getInfo.html) 11:43:37 INFO - PROCESS | 1667 | __metrics Screen width/height:1600/1200 11:43:37 INFO - PROCESS | 1667 | colorDepth:24 11:43:37 INFO - PROCESS | 1667 | Browser inner width/height: 1024/689 11:43:37 INFO - PROCESS | 1667 | __metrics 11:43:37 INFO - PROCESS | 1667 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:43:37 INFO - PROCESS | 1667 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:43:38 INFO - TEST-INFO | 1667: exit 0 11:43:38 INFO - Browser initialized. 11:43:38 INFO - Running cycle 1/1 for kraken test... 11:43:38 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/tmpIOCC6S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:43:50 INFO - PROCESS | 1669 | RSS: Main: 168206336 11:43:50 INFO - PROCESS | 1669 | 11:43:53 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 11:43:54 INFO - PROCESS | 1669 | RSS: Main: 218054656 11:43:54 INFO - PROCESS | 1669 | 11:43:56 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 11:43:57 INFO - PROCESS | 1669 | RSS: Main: 229212160 11:43:57 INFO - PROCESS | 1669 | 11:44:00 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 11:44:00 INFO - PROCESS | 1669 | RSS: Main: 325238784 11:44:00 INFO - PROCESS | 1669 | 11:44:02 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 11:44:03 INFO - PROCESS | 1669 | RSS: Main: 228720640 11:44:03 INFO - PROCESS | 1669 | 11:44:05 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:44:06 INFO - PROCESS | 1669 | RSS: Main: 229384192 11:44:06 INFO - PROCESS | 1669 | 11:44:08 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 11:44:09 INFO - PROCESS | 1669 | RSS: Main: 266940416 11:44:09 INFO - PROCESS | 1669 | 11:44:12 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 11:44:12 INFO - PROCESS | 1669 | RSS: Main: 267452416 11:44:12 INFO - PROCESS | 1669 | 11:44:15 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 11:44:16 INFO - PROCESS | 1669 | RSS: Main: 265670656 11:44:16 INFO - PROCESS | 1669 | 11:44:17 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:44:18 INFO - PROCESS | 1669 | RSS: Main: 239640576 11:44:18 INFO - PROCESS | 1669 | 11:44:20 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:44:20 INFO - PROCESS | 1669 | RSS: Main: 245080064 11:44:20 INFO - PROCESS | 1669 | 11:44:22 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:44:23 INFO - PROCESS | 1669 | RSS: Main: 250970112 11:44:23 INFO - PROCESS | 1669 | 11:44:26 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:44:27 INFO - PROCESS | 1669 | RSS: Main: 256081920 11:44:27 INFO - PROCESS | 1669 | 11:44:29 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:44:30 INFO - PROCESS | 1669 | RSS: Main: 257146880 11:44:30 INFO - PROCESS | 1669 | 11:44:32 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 11:44:32 INFO - PROCESS | 1669 | RSS: Main: 301006848 11:44:32 INFO - PROCESS | 1669 | 11:44:32 INFO - PROCESS | 1669 | __start_tp_report 11:44:32 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 11:44:32 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 11:44:32 INFO - PROCESS | 1669 | |i|pagename|runs| 11:44:32 INFO - PROCESS | 1669 | |0;ai-astar;116;114;113;114;114;113;117;114;114;113 11:44:32 INFO - PROCESS | 1669 | |1;audio-beat-detection;143;107;108;141;107;103;110;105;135;107 11:44:32 INFO - PROCESS | 1669 | |2;audio-dft;187;183;181;185;185;185;180;183;185;181 11:44:32 INFO - PROCESS | 1669 | |3;audio-fft;80;59;59;88;63;59;59;80;80;57 11:44:32 INFO - PROCESS | 1669 | |4;audio-oscillator;90;70;93;94;97;100;127;97;70;89 11:44:32 INFO - PROCESS | 1669 | |5;imaging-gaussian-blur;89;86;88;86;90;86;89;87;89;94 11:44:32 INFO - PROCESS | 1669 | |6;imaging-darkroom;94;93;93;94;94;94;94;94;94;92 11:44:32 INFO - PROCESS | 1669 | |7;imaging-desaturate;86;85;85;86;85;84;85;84;84;85 11:44:32 INFO - PROCESS | 1669 | |8;json-parse-financial;56;52;53;53;54;55;54;56;56;56 11:44:32 INFO - PROCESS | 1669 | |9;json-stringify-tinderbox;70;71;75;70;72;68;68;68;68;70 11:44:32 INFO - PROCESS | 1669 | |10;stanford-crypto-aes;83;83;83;82;80;81;84;86;83;109 11:44:32 INFO - PROCESS | 1669 | |11;stanford-crypto-ccm;146;144;141;133;132;143;148;139;143;135 11:44:32 INFO - PROCESS | 1669 | |12;stanford-crypto-pbkdf2;161;161;159;158;160;159;158;159;160;162 11:44:32 INFO - PROCESS | 1669 | |13;stanford-crypto-sha256-iterative;68;68;81;85;85;86;65;64;66;63 11:44:32 INFO - PROCESS | 1669 | __end_tp_report 11:44:32 INFO - PROCESS | 1669 | __start_cc_report 11:44:32 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,1858 11:44:32 INFO - PROCESS | 1669 | __end_cc_report 11:44:32 INFO - PROCESS | 1669 | __startTimestamp1479152672519__endTimestamp 11:44:32 INFO - PROCESS | 1669 | 11:44:32 INFO - PROCESS | 1669 | ------- Summary: start ------- 11:44:32 INFO - PROCESS | 1669 | Number of tests: 14 11:44:32 INFO - PROCESS | 1669 | 11:44:32 INFO - PROCESS | 1669 | [#0] ai-astar Cycles:10 Average:114.20 Median:114.00 stddev:1.32 (1.2%) stddev-sans-first:1.22 11:44:32 INFO - PROCESS | 1669 | Values: 116.0 114.0 113.0 114.0 114.0 113.0 117.0 114.0 114.0 113.0 11:44:32 INFO - PROCESS | 1669 | 11:44:32 INFO - PROCESS | 1669 | [#1] audio-beat-detection Cycles:10 Average:116.60 Median:109.00 stddev:16.14 (14.8%) stddev-sans-first:14.01 11:44:32 INFO - PROCESS | 1669 | Values: 143.0 107.0 108.0 141.0 107.0 103.0 110.0 105.0 135.0 107.0 11:44:32 INFO - PROCESS | 1669 | 11:44:32 INFO - PROCESS | 1669 | [#2] audio-dft Cycles:10 Average:183.50 Median:185.00 stddev:2.27 (1.2%) stddev-sans-first:2.03 11:44:32 INFO - PROCESS | 1669 | Values: 187.0 183.0 181.0 185.0 185.0 185.0 180.0 183.0 185.0 181.0 11:44:32 INFO - PROCESS | 1669 | 11:44:32 INFO - PROCESS | 1669 | [#3] audio-fft Cycles:10 Average:68.40 Median:71.50 stddev:12.02 (16.8%) stddev-sans-first:11.99 11:44:32 INFO - PROCESS | 1669 | Values: 80.0 59.0 59.0 88.0 63.0 59.0 59.0 80.0 80.0 57.0 11:44:32 INFO - PROCESS | 1669 | 11:44:32 INFO - PROCESS | 1669 | [#4] audio-oscillator Cycles:10 Average:92.70 Median:91.50 stddev:16.06 (17.5%) stddev-sans-first:17.00 11:44:32 INFO - PROCESS | 1669 | Values: 90.0 70.0 93.0 94.0 97.0 100.0 127.0 97.0 70.0 89.0 11:44:32 INFO - PROCESS | 1669 | 11:44:32 INFO - PROCESS | 1669 | [#5] imaging-gaussian-blur Cycles:10 Average:88.40 Median:89.00 stddev:2.46 (2.8%) stddev-sans-first:2.60 11:44:32 INFO - PROCESS | 1669 | Values: 89.0 86.0 88.0 86.0 90.0 86.0 89.0 87.0 89.0 94.0 11:44:32 INFO - PROCESS | 1669 | 11:44:32 INFO - PROCESS | 1669 | [#6] imaging-darkroom Cycles:10 Average:93.60 Median:94.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 11:44:32 INFO - PROCESS | 1669 | Values: 94.0 93.0 93.0 94.0 94.0 94.0 94.0 94.0 94.0 92.0 11:44:32 INFO - PROCESS | 1669 | 11:44:32 INFO - PROCESS | 1669 | [#7] imaging-desaturate Cycles:10 Average:84.90 Median:85.00 stddev:0.74 (0.9%) stddev-sans-first:0.67 11:44:32 INFO - PROCESS | 1669 | Values: 86.0 85.0 85.0 86.0 85.0 84.0 85.0 84.0 84.0 85.0 11:44:32 INFO - PROCESS | 1669 | 11:44:32 INFO - PROCESS | 1669 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:55.50 stddev:1.51 (2.7%) stddev-sans-first:1.50 11:44:32 INFO - PROCESS | 1669 | Values: 56.0 52.0 53.0 53.0 54.0 55.0 54.0 56.0 56.0 56.0 11:44:32 INFO - PROCESS | 1669 | 11:44:32 INFO - PROCESS | 1669 | [#9] json-stringify-tinderbox Cycles:10 Average:70.00 Median:70.00 stddev:2.26 (3.2%) stddev-sans-first:2.40 11:44:32 INFO - PROCESS | 1669 | Values: 70.0 71.0 75.0 70.0 72.0 68.0 68.0 68.0 68.0 70.0 11:44:32 INFO - PROCESS | 1669 | 11:44:32 INFO - PROCESS | 1669 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:83.00 stddev:8.45 (10.2%) stddev-sans-first:8.92 11:44:32 INFO - PROCESS | 1669 | Values: 83.0 83.0 83.0 82.0 80.0 81.0 84.0 86.0 83.0 109.0 11:44:32 INFO - PROCESS | 1669 | 11:44:32 INFO - PROCESS | 1669 | [#11] stanford-crypto-ccm Cycles:10 Average:140.40 Median:143.00 stddev:5.50 (3.8%) stddev-sans-first:5.45 11:44:32 INFO - PROCESS | 1669 | Values: 146.0 144.0 141.0 133.0 132.0 143.0 148.0 139.0 143.0 135.0 11:44:32 INFO - PROCESS | 1669 | 11:44:32 INFO - PROCESS | 1669 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.70 Median:160.00 stddev:1.34 (0.8%) stddev-sans-first:1.33 11:44:32 INFO - PROCESS | 1669 | Values: 161.0 161.0 159.0 158.0 160.0 159.0 158.0 159.0 160.0 162.0 11:44:32 INFO - PROCESS | 1669 | 11:44:32 INFO - PROCESS | 1669 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.10 Median:74.50 stddev:9.80 (13.2%) stddev-sans-first:10.22 11:44:32 INFO - PROCESS | 1669 | Values: 68.0 68.0 81.0 85.0 85.0 86.0 65.0 64.0 66.0 63.0 11:44:32 INFO - PROCESS | 1669 | -------- Summary: end -------- 11:44:32 INFO - PROCESS | 1669 | 11:44:33 INFO - TEST-INFO | 1669: exit 0 11:44:33 INFO - TEST-OK | kraken | took 57854ms 11:44:33 INFO - SUITE-END | took 1172s 11:44:33 INFO - Completed test suite (00:19:32) 11:44:33 INFO - javascript benchmark 11:44:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2653.389720364316, 2936.7650587952958, 3215.061549601738, 3562.501249825024, 3567.0, 5949.940500594998, 6034.6379217246995, 6040.818775436733, 6063.151158837755, 6100.23747031621, 5955.106733989904, 6051.394860513947, 6060.000099983508, 6061.575689701723, 6066.636001839882, 5431.21247419124, 5446.673199608016, 5474.507294343508, 5498.780048798043, 5518.2826232589705, 5371.973140134294, 5383.219433182187, 5540.113581826909, 5542.224088627595, 5544.972275138619, 5453.345598528183, 5456.645318054314, 5469.589780766439, 5475.616706830523, 5510.972445137769, 5459.945400546003, 5499.752511137009, 5542.695151766651, 5557.138643510222, 5559.416261292587, 5308.336457942757, 5382.354117505885, 5461.371942226655, 5471.616986810925, 5511.696856672881, 5899.2920849497905, 5902.992982386009, 5913.763449462016, 5978.163057172, 6035.517158627299, 6314.463270622003, 6337.841553961188, 6343.968280158616, 6359.332270111618, 6372.649504277263, 6365.49076073913, 6371.203599550056, 6408.551401401904, 6416.582922110095, 6421.64680942548, 5980.700964951779, 6009.939900601025, 6040.818775436744, 6044.818655440344, 6058.939410605925, 5461.2627295315415, 6472.708728107246, 6498.480121590262, 6510.18622672166, 6534.346565343428, 6379.457746091542, 6388.265349484869, 6389.584676995981, 6395.680215989182, 6396.744130234739, 6293.118963345135, 6295.811125666238, 6303.086052522359, 6336.271328797156, 6372.7132279047555, 5304.363476382859, 6334.683265836689, 6342.4926005919415, 6347.079673447324, 6359.9364006360265, 6300.8424789379715, 6318.210223722035, 6322.841928951813, 6327.4938004959495, 6331.778387756499, 4965.379327584052, 5100.48995100487, 5131.435542090367, 5157.638965272395, 5178.430372659004, 4603.539646035437, 4635.443746750411, 4646.0, 4657.743824089707, 4662.090892275974, 6001.5798894077, 6017.398260173947, 6017.939820601738, 6017.969910150421, 6030.849228769228, 6255.0, 6324.588901721373, 6332.841678958063, 6357.87372098827, 6421.775237866746, 6158.353372895871, 6189.721462534107, 6194.5354098442795, 6209.9068513972325, 6212.689365531705, 4909.533594308535, 5516.062269414209, 5691.430856914276, 5701.458361455655, 5709.628874123168, 6436.452901503425, 6521.0, 6523.804285871526, 6532.804015879531, 6545.345465453416, 6266.122742816101, 6335.334789847, 6349.111124442674, 6357.90463143044, 6405.487560995016, 6640.767573134917, 6650.767223147167, 6653.600783952978, 6663.333666633298, 6674.532782705358, 6360.109584658244, 6372.681365931778, 6380.0, 6382.0, 6387.872242555216, 6294.842628934313, 6305.085762564311, 6317.5893566918, 6327.588706734047, 6376.298607153117, 6324.620522768649, 6355.650439225702, 6360.809175724736, 6362.045693146065, 6372.681365931778, 6314.273858506331, 6343.714532846126, 6360.77737279193, 6369.554131210771, 6372.330905254881, 6123.724432400463, 6137.079438084323, 6154.415330543591, 6180.505559555315, 6326.588771729823, 6237.812865614039, 6303.054541818764, 6368.395002474757, 6385.584936979268, 6387.393197646216, 5323.893522129459, 6095.811316793182, 6231.906521402092, 6270.278917924315, 6298.653574053471], "value": 5895.844968794232, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [520.2014907117575, 530.2523441946855, 532.5659587436237, 536.3617295418453, 542.1244689825933, 32345.838270808643, 43985.34021989673, 45261.0, 45406.54593454064, 47454.288185677244, 46450.30324545126, 47065.52934470654, 47084.76457617716, 47092.0, 47152.52847471524, 9972.850407243897, 10154.339967902062, 10163.034511721375, 10167.0, 10167.288289819715, 9405.81188376232, 9665.661701840438, 12196.756064878697, 12428.316442595653, 12489.750204995895, 12230.755384892296, 12310.0, 12313.569025084123, 12321.199122057038, 12331.876681233207, 12213.938930305336, 12273.202241854251, 12292.385380730928, 12292.631221063382, 12328.691782705415, 12211.877881221162, 12277.38613069343, 12280.201786883825, 12281.263124212575, 12292.139550231488, 42245.57754422447, 42522.57477425217, 42662.0, 42682.78658606687, 42709.35935960932, 3496.685298323138, 3557.146284891633, 3584.2473080653094, 3616.4936908832783, 4435.135148646015, 31927.84036079828, 32153.1961700957, 32196.551155197838, 32512.83743581267, 32873.013809585515, 3290.6873846984736, 3312.138843900579, 3336.432806422914, 3353.496975453677, 3392.5080863274934, 424231.0, 425368.0, 426076.0, 427476.86261568806, 427726.0, 33820.985370438924, 64054.35945640577, 64534.0, 64561.35438645553, 64686.0, 35049.948501545, 36435.0, 36546.08634784099, 36548.45177322342, 36593.634063659556, 15767.053976761432, 15965.680686386208, 16004.0, 16008.359665613478, 16019.359225630844, 12071.396430178456, 12390.6282811514, 13359.866401336056, 13509.932450337685, 13523.59429217125, 7875.133735289113, 8188.058373287029, 8195.508269503849, 8225.588720563948, 8271.462354946909, 3337.7830441021742, 3365.6802603752603, 3376.324735052999, 3377.121948293461, 3409.335179639996, 979.808937257228, 1008.9192864570816, 1028.4600584693096, 1044.9811433852085, 1109.2230953602996, 31178.1831619635, 31283.687163128532, 31290.217744556114, 31737.523937140963, 31883.043508694776, 1097.4238524774557, 1109.628274528042, 1112.7203715726978, 1117.9720506987228, 1170.9941450292695, 16661.0, 16698.075952151234, 16775.664486710197, 16799.496015119566, 16981.660366792596, 690869.5456522686, 708100.0, 711798.0, 716187.0, 717440.0, 64561.35438645647, 65003.349966500675, 65193.0, 65305.0, 65508.67245663741, 1270.9300988445539, 1310.4627102887962, 1383.6264208663806, 1424.6367176369959, 1454.5999850041323, 25901.352466188495, 30676.84661576678, 31748.68251317457, 32204.0, 32830.671693283715, 55572.0, 56354.0, 56446.717766410904, 56625.433745663664, 56643.71678141583, 486406.0, 486905.0, 487307.0, 490114.0, 492095.0, 27816.86091569529, 28654.570181446878, 28702.712972870006, 28752.712472875002, 29402.411951760416, 49169.50830491649, 49248.9409419387, 49258.50741492539, 49383.0, 49817.25274120964, 40828.0, 43262.56737432711, 43391.9152021202, 43806.56193438152, 44305.55694443014, 37903.62096379001, 42960.35559466548, 43655.0, 43740.56259437365, 44211.115777683626, 39957.2008559833, 40691.389629155, 40886.59113408828, 40903.77288681344, 40936.385954211306, 34411.13972150616, 36555.45166822553, 37144.628553714116, 37242.0, 37290.8135459321, 23700.170494032627, 25417.364565886, 26648.8667556661, 26726.0, 26913.596296055966], "value": 19970.443307182435, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.3056629951442, 377.78088708549035, 388.544899351927, 389.2448649619739, 411.8332075509418, 19783.802161978376, 21869.781302186973, 21886.343409697696, 22196.88901555492, 23238.954247058922, 17694.557636059104, 20665.966701664933, 20802.583948321026, 21276.36170914875, 21731.456713582167, 5510.311211098613, 5924.6149000314845, 6191.938080619181, 6266.686665666722, 6308.053791931201, 6129.233845769279, 6228.5017198624, 6272.090546870701, 6278.6860656966965, 6953.756618518353, 6963.338482844122, 6978.302169783032, 6979.47653925955, 6984.755533556327, 7010.75462358815, 6239.875202495948, 6300.0, 6308.842278943017, 6359.109724638532, 6974.51178417511, 5912.0, 6155.230596175478, 6160.0, 6164.753409863645, 6169.0, 12872.935635321763, 13201.933990330082, 13283.601491955256, 13306.733865322736, 13325.13386629866, 2217.634090375086, 2337.6610391493136, 2381.2380038387723, 2381.4760752634393, 2414.5291668124723, 8842.93884733836, 9978.90021099787, 10022.448765317904, 10150.340227885164, 10748.301360411626, 1659.3030927010684, 1872.6722823505831, 1995.1520603743495, 1999.71004204391, 2002.979970200294, 86513.56743216306, 117830.23254651188, 130121.0, 137571.0, 140185.99999999898, 11656.766864662659, 11704.648860534198, 11806.291622502677, 11817.586384476503, 11981.760364792655, 15250.161241131622, 15260.084394936339, 15264.542063738105, 15265.236738163047, 15267.0, 9061.95469022664, 9123.726288211365, 9147.0, 9158.450492970444, 9221.308401869886, 9074.45553266806, 9112.908870911338, 9146.2682985361, 9211.723648290563, 9268.860967085498, 4549.135664223787, 4673.439187297546, 4674.275487299406, 4726.716397016121, 4735.928961065587, 1925.7881633020356, 1969.6257711034857, 1978.9505262368268, 1982.415187519685, 1989.263972330247, 828.9751307460785, 893.2139717049085, 898.1871953557192, 1000.0, 1043.212374657129, 22106.33680989573, 22536.774632253466, 22555.887220563793, 22632.773672263396, 22667.20664776725, 981.3228872078244, 985.261054209343, 986.1420564109271, 1009.1876039787894, 1031.7575369788094, 11270.492827822603, 11665.183437159318, 11907.285562866256, 11911.927926486658, 11923.105767067505, 551231.0, 561360.0, 648807.0, 668257.0, 669812.0, 117964.41017795028, 123548.0, 142636.0, 146593.0, 147877.0, 949.539473355422, 958.8274110660149, 967.8693376394097, 969.0793745941384, 973.6446197137993, 19107.331243406414, 20068.39794806158, 20110.0, 20426.489337766674, 20512.641046279274, 46944.29583556181, 48519.272210917574, 61679.69160154171, 62985.0, 63593.0, 74857.0, 80554.59722701584, 86304.56847715721, 89436.0, 90104.54947725219, 7360.263973602811, 7573.621318933921, 7669.539827610138, 8231.34149268069, 8571.442856214326, 9329.346945713734, 13464.057515973787, 13528.729425411633, 13926.30368481592, 14396.352164152848, 11500.597479088192, 11716.121290903046, 12023.579174728842, 12066.0, 12073.27560346382, 9502.47736374506, 9552.42685438876, 11755.0, 11807.114466415225, 12139.757204855678, 11836.171467997157, 11859.881401185878, 11960.880391195977, 12105.636830895088, 12300.753984920073, 7634.885476717965, 7739.845203095794, 7766.805829854299, 7767.456278060482, 7983.081945576333, 10360.948195258976, 11804.291742495478, 11892.76214475723, 12065.638030858738, 12171.634850954486], "value": 9812.776559980004, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1428.2501686614532, 1451.1365737386254, 1595.6569337592416, 1797.4517772079519, 1932.5844943337179, 8340.623797073484, 8878.955605221972, 9099.727008189748, 9507.0, 9517.524123793817, 9250.259979201664, 9345.859812102824, 9352.906470935288, 9362.110599493037, 9370.344075914672, 2442.267319804056, 2473.7773600375963, 2479.0455674565333, 2479.7148327942245, 2480.875956202192, 2407.4703565215714, 2465.9753402466013, 2467.642191882176, 2468.148488771371, 2469.8518088914634, 2407.831451798375, 2442.3039433761382, 2460.3972026853444, 2461.089396923132, 2465.543874383236, 2405.915792947256, 2435.257246539805, 2438.292895060439, 2444.364465239033, 2446.5473887330722, 2406.7352591214953, 2418.069043418279, 2426.277343086411, 2427.077710470028, 2429.1740808125146, 9262.39794413361, 9473.715788526355, 9476.289278304155, 9483.0, 9507.906590742085, 5460.726963651841, 5689.544836413077, 5698.487136157724, 5737.082066869322, 5747.482726554588, 3769.4157405602177, 3808.980955095207, 3829.4064420014943, 3880.2821478026653, 3904.297226499229, 1114.3202646385698, 1114.799336119498, 1118.4351902289293, 1137.1357768096307, 1140.3841925360377, 12469.0, 12506.937465312707, 12594.0, 12595.370231488389, 12623.810642840273, 4545.8408955687055, 4619.9769001155455, 4795.20879054959, 4804.615630749601, 4806.0, 9629.518524073768, 9640.75898102553, 9645.71062868115, 9694.127528522467, 9700.660476883275, 5495.807646732425, 5499.1476321170285, 5500.669959802424, 5500.944990550123, 5505.807296744595, 4496.258117410591, 4647.674662773641, 4800.759962001886, 4829.96155826499, 5163.870903227449, 3176.5552822604855, 3857.517810273716, 3965.5637879833193, 3966.424868394067, 3975.2248311578965, 1183.5325046606542, 1187.2994932989404, 1192.2846292224597, 1200.0699457920007, 1205.8070708686569, 945.4847108325979, 954.6897258391051, 968.7917097823861, 973.5570315506427, 1007.3982368034859, 6008.158857759917, 6041.2750469943885, 6050.273967123973, 6063.484603808637, 6172.69136543171, 444.6331776284578, 447.98656040318843, 454.6908102490272, 460.1165761737472, 460.6821293307674, 4044.9797751011056, 4085.22380747657, 4106.7946602670345, 4112.444819949268, 4169.291220492463, 11216.270942388881, 11489.655310340702, 11562.537498500134, 11577.131715121399, 11584.189106762446, 11420.029297509638, 11420.543178272776, 11420.972112509913, 11492.885071149181, 11534.307941523535, 7503.437242206856, 8599.527026013504, 8625.999999999874, 8649.567521623894, 8675.045744968049, 6113.969430152821, 6201.875962480815, 6209.689515524296, 6302.401271879165, 6321.367863213642, 9063.728088157366, 10584.629537966135, 10674.412907290174, 10816.621418250323, 10935.726606834574, 10668.573257069631, 10793.892061079288, 11074.667759967213, 11091.778164436504, 11135.387553684624, 7647.732329368446, 7898.091719452336, 7993.0, 8064.798380040546, 8066.87899681517, 7561.168271490242, 8843.292536597186, 8921.06328835489, 8929.330300227639, 8944.239739621944, 7856.0, 7963.562004089599, 7990.121086680344, 8119.431639785158, 8158.224968627971, 7709.922900770921, 7789.805254868447, 7798.766037018899, 7825.686972521035, 7844.568548729874, 7323.487355885037, 7386.556806591621, 7460.813479663052, 7462.179160292472, 7465.776026719207, 4362.672799540111, 5112.514311140436, 5157.355330583677, 5331.653442526223, 5430.40265570779, 4543.182227199136, 5266.97366513165, 5310.150375939831, 5390.353157621111, 5530.6128570999645], "value": 4684.443701669105, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [277.83468836042556, 309.57433528897764, 310.77313561100397, 314.70889427279775, 317.5918944156759, 5507.54050176703, 5514.5864060195545, 5544.334679838415, 5545.833624991256, 5566.1334412777405, 5406.270153529273, 5424.226680521136, 5433.538149257308, 5448.891022179554, 5449.073657478229, 3441.4493681011045, 3747.5690295615946, 3944.7179666608254, 4083.3466645336753, 4093.44738460307, 3774.735768496206, 3904.026838936418, 4050.5949405059405, 4077.245709543729, 4129.421880936671, 3506.0183148718274, 4063.451434056394, 4069.308217603, 4070.9185816283657, 4107.274944523292, 3367.511710801932, 3862.7938810786977, 3879.3318872884647, 4102.815373308194, 4147.382520816884, 3572.7856328620105, 3599.9840089549675, 3611.9277614447565, 3613.8915832525067, 3617.457381392786, 4952.0, 5277.973610131925, 5299.2845965794895, 5310.99091172676, 5317.867053323659, 3894.6494815466745, 4067.5118985721606, 4155.667546596265, 4629.722216667011, 4678.508756580578, 4428.579284967923, 5438.646487978269, 5724.656520608735, 5729.942700572982, 5747.18963526492, 3834.7123965702685, 3863.1070775320172, 3876.9418458723144, 3887.7278590498677, 3901.6878649707955, 4525.434320709911, 4910.625024993008, 5633.943610582149, 5931.466168044896, 5981.730822113015, 3114.9377012460077, 3272.280098378353, 3804.334241507725, 3818.9427158592644, 3925.6074392561086, 3691.4126925422324, 3850.4609354690365, 3974.5627980922077, 4004.9199016019516, 4028.617281358266, 4092.6316631502714, 4345.848804841624, 4651.534846515321, 4675.625949923998, 4683.461401938753, 5557.055300598908, 5559.305086864142, 5649.4633009864, 5716.771329146787, 5728.281515545403, 1203.3441774233063, 1348.4021434600031, 1352.8850047745855, 1355.9559139462558, 1358.3887250737207, 785.3795501553823, 814.8998851550359, 822.9506229626242, 832.4505826154709, 833.2167762303536, 3903.843846246118, 4263.445752052214, 4540.636749060067, 4565.315202719618, 4591.265397536378, 4666.673332866667, 4864.440589332272, 4918.360613120271, 4926.4088309403105, 4991.5258050485145, 3597.5862775780597, 3926.5877082906454, 4474.485434175112, 4481.414868105568, 4558.521355257716, 1822.6239189412174, 2295.391721193885, 2508.523380557688, 2606.960895586568, 2614.8692565372035, 4526.977365113219, 4586.518415566385, 4588.678792484494, 4687.9683472213865, 4928.0, 4115.54728979812, 4698.835540756126, 5015.3730783652045, 5031.899362012739, 5034.421041580265, 4448.219862585884, 4774.355462012653, 5091.1090559152, 5109.182530795055, 5119.539241468286, 4267.722598031118, 4485.753283569305, 4665.090307390026, 4932.383452068491, 4935.827246046371, 4476.4556228101255, 4811.3264143019305, 4836.274558816206, 4845.127876982177, 4866.318715379779, 3914.745541539791, 4147.440095587057, 4599.149157405891, 5743.396943321059, 6065.6663883486835, 3050.8322042287, 3348.983255083709, 3820.6943444523818, 3924.9607503925736, 3937.5865534118507, 4500.0, 5446.128619420873, 5676.914846277226, 5981.132735753378, 6000.429959153874, 5220.973895130652, 5333.919991200058, 5501.669899806025, 5778.8266352009505, 5811.506021988178, 4872.6832755870755, 5667.866426714591, 5714.371419143974, 5722.198892155018, 5743.1385292206505, 5113.948860511496, 5620.85947851307, 5655.529562313745, 5662.377138514677, 5663.150527420919, 4911.3369695090705, 5548.55611551083, 5621.775128994795, 5687.971560142173, 5739.339975902824, 4962.702237865739, 5106.591472682251, 5325.520703136736, 5550.88982203569, 5624.9750089966765], "value": 3901.403382817535, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [693.0089971340983, 735.749845052682, 794.9801254968625, 819.6024927909963, 836.7657056024316, 16072.91963540182, 17325.306987720476, 17351.0, 17358.611311095112, 17405.738913916284, 14415.0, 14448.133112013287, 14460.710785784278, 14462.493812716557, 14475.782863257033, 714.1858281559026, 736.4991805572208, 737.9741709040185, 881.9382643214977, 885.2740752582885, 903.1104362203257, 906.0893801729286, 918.7106061590611, 920.1304766995192, 920.8664743612172, 885.5660726244158, 978.8727465429484, 979.1970584121024, 981.092489447262, 983.6950545330934, 973.4305431322684, 973.5813600151931, 974.5663179884954, 974.7758015656439, 974.9756256093583, 719.0795781399817, 720.3660778514874, 720.5712601002396, 721.4913485992363, 721.779857143571, 16036.0, 16328.020318780911, 16488.17559122039, 16516.587085322844, 16519.752203716835, 14833.110013399231, 15576.598106170386, 15657.0, 15876.12681302528, 15904.681906361924, 12233.510659573607, 12299.877001229963, 12305.75388492234, 12337.0, 12406.62780116598, 3925.6270654288082, 4002.4996875390575, 4010.0776821330965, 4028.3554631258858, 4151.481064866892, 107735.0, 110590.44704776505, 111061.33407998887, 119613.40193299064, 126222.36888815589, 11479.196456247982, 11498.827517587242, 11712.180147389601, 11757.059435245159, 12217.144799864102, 23119.653205201597, 23169.53660926772, 23170.536589268122, 23173.304800855665, 23176.884115579312, 7484.887726684104, 8068.112507624157, 8475.915240847637, 8675.655273432629, 8691.608877600524, 3542.3446662367546, 4644.4934074774, 4666.066786642685, 4763.523647635278, 4845.781939812717, 3698.2973235085246, 3848.037990502374, 3850.979490435037, 3855.1904100139286, 3857.672097871656, 582.251806428737, 689.8309914071085, 693.4071368979551, 694.1358009278481, 704.1550139832221, 536.8443151486103, 610.3926593039865, 630.9589876658002, 698.4656737595743, 699.1505321034865, 9574.642228229812, 10038.932561643158, 10124.139448146843, 10293.176545876311, 10569.365838049742, 559.0942672869895, 606.884691908536, 682.331315310998, 705.7670968580356, 714.9749758758419, 4601.884952876205, 4950.529699678525, 4980.203167493256, 4986.152354099811, 4988.276699878497, 106441.0, 115178.27232591518, 172465.0, 177301.0, 183672.0, 92168.07831921594, 92273.61589576161, 120612.39693801475, 137377.0, 149986.25006875113, 85831.0, 118816.40591796985, 120235.196472053, 120275.0, 124361.0, 10057.094861462503, 10487.26589138753, 10551.736206594896, 10579.15366770641, 10650.147988160774, 65572.67213664092, 65647.34352656412, 65655.34344656684, 66421.0, 67417.66291168513, 97404.0, 101573.0, 102074.0, 103889.48055259675, 106437.46781266044, 13422.597322080353, 13866.0, 13901.58295251144, 14099.577012689635, 14114.01201915897, 12021.278723276282, 12322.876771232173, 12661.240325580495, 12826.0, 13235.602931912059, 12368.628941131781, 12657.87342126567, 12859.807102893277, 14392.928035359757, 14650.706985860435, 14340.56978290653, 14614.488492902698, 14617.780733288797, 14685.412583496967, 14894.77657835155, 13636.454541818217, 13946.16323020622, 14224.431022758974, 14502.85497145015, 14851.0, 11383.203175777617, 11518.769624607628, 11568.826467603161, 12183.512659493521, 12589.18170318963, 10309.896901030894, 12048.51805927753, 12129.636110916686, 12399.318037508023, 12451.377431128227], "value": 8181.723750673679, "unit": "score"}], "name": "dromaeo_css", "value": 7463.046736640285, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 114.0, 113.0, 114.0, 114.0, 113.0, 117.0, 114.0, 114.0, 113.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 107.0, 108.0, 141.0, 107.0, 103.0, 110.0, 105.0, 135.0, 107.0], "value": 116.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 183.0, 181.0, 185.0, 185.0, 185.0, 180.0, 183.0, 185.0, 181.0], "value": 183.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 59.0, 88.0, 63.0, 59.0, 59.0, 80.0, 80.0, 57.0], "value": 68.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 70.0, 93.0, 94.0, 97.0, 100.0, 127.0, 97.0, 70.0, 89.0], "value": 92.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 88.0, 86.0, 90.0, 86.0, 89.0, 87.0, 89.0, 94.0], "value": 88.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 93.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 92.0], "value": 93.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 85.0, 86.0, 85.0, 84.0, 85.0, 84.0, 84.0, 85.0], "value": 84.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 52.0, 53.0, 53.0, 54.0, 55.0, 54.0, 56.0, 56.0, 56.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 75.0, 70.0, 72.0, 68.0, 68.0, 68.0, 68.0, 70.0], "value": 70.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 83.0, 82.0, 80.0, 81.0, 84.0, 86.0, 83.0, 109.0], "value": 85.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 144.0, 141.0, 133.0, 132.0, 143.0, 148.0, 139.0, 143.0, 135.0], "value": 140.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 159.0, 158.0, 160.0, 159.0, 158.0, 159.0, 160.0, 162.0], "value": 159.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 81.0, 85.0, 85.0, 86.0, 65.0, 64.0, 66.0, 63.0], "value": 73.1, "unit": "score"}], "name": "kraken", "value": 1425.4, "alertThreshold": 2.0}]} 11:44:33 INFO - Return code: 0 11:44:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:44:33 INFO - # TBPL SUCCESS # 11:44:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:44:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:44:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:44:33 INFO - 2016-11-14 11:44:33.833 screenresolution[1673:9994] starting screenresolution argv=screenresolution get 11:44:33 INFO - 2016-11-14 11:44:33.835 screenresolution[1673:9994] Display 0: 1600x1200x32@60 11:44:33 INFO - 2016-11-14 11:44:33.841 screenresolution[1674:9997] starting screenresolution argv=screenresolution list 11:44:33 INFO - Available Modes on Display 0 11:44:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:44:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:44:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:44:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:44:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:44:34 INFO - Intel Iris: 11:44:34 INFO - Chipset Model: Intel Iris 11:44:34 INFO - Type: GPU 11:44:34 INFO - Bus: Built-In 11:44:34 INFO - VRAM (Dynamic, Max): 1536 MB 11:44:34 INFO - Vendor: Intel (0x8086) 11:44:34 INFO - Device ID: 0x0a2e 11:44:34 INFO - Revision ID: 0x0009 11:44:34 INFO - Displays: 11:44:34 INFO - Display: 11:44:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:44:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:44:34 INFO - Display Serial Number: 1600x1200 60 11:44:34 INFO - Main Display: Yes 11:44:34 INFO - Mirror: Off 11:44:34 INFO - Online: Yes 11:44:34 INFO - Rotation: Supported 11:44:34 INFO - Return code: 0 11:44:34 INFO - Running post-action listener: _resource_record_post_action 11:44:34 INFO - [mozharness: 2016-11-14 19:44:34.071798Z] Finished run-tests step (success) 11:44:34 INFO - Running post-run listener: _resource_record_post_run 11:44:34 INFO - Total resource usage - Wall time: 1195s; CPU: 53.0%; Read bytes: 38654976; Write bytes: 495381504; Read time: 380; Write time: 2190 11:44:34 INFO - TinderboxPrint: CPU usage
53.5% 11:44:34 INFO - TinderboxPrint: I/O read bytes / time
38,654,976 / 380 11:44:34 INFO - TinderboxPrint: I/O write bytes / time
495,381,504 / 2,190 11:44:34 INFO - TinderboxPrint: CPU idle
2,224.2 (46.5%) 11:44:34 INFO - TinderboxPrint: CPU system
958.5 (20.0%) 11:44:34 INFO - TinderboxPrint: CPU user
1,599.0 (33.4%) 11:44:34 INFO - TinderboxPrint: Swap in / out
233,906,176 / 0 11:44:34 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 192373248; Write bytes: 188499968; Read time: 17507; Write time: 451 11:44:34 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 36566016; Write bytes: 295601152; Read time: 355; Write time: 1700 11:44:34 INFO - Running post-run listener: _upload_blobber_files 11:44:34 INFO - Blob upload gear active. 11:44:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:44:34 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 11:44:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:44:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:44:34 INFO - (blobuploader) - INFO - Open directory for files ... 11:44:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:44:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:44:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:44:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:44:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:44:36 INFO - (blobuploader) - INFO - Done attempting. 11:44:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:44:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:44:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:44:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:44:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:44:37 INFO - (blobuploader) - INFO - Done attempting. 11:44:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:44:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:44:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:44:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:44:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:44:39 INFO - (blobuploader) - INFO - Done attempting. 11:44:39 INFO - (blobuploader) - INFO - Iteration through files over. 11:44:39 INFO - Return code: 0 11:44:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:44:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:44:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/00089003960fa269f8264975493603a038b6868790fe4333b569506fe3f1aa6316aa64f670a5a4ab3babfb0f6b5114235472d79738b03ded279cf6ff8c3e0b14", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3671e40932a5d80cea0a7b8ffd06bdd194d06d43d236417bdfb03c61f072f9b49ba39b3bc781a37044501ec27ea313b0945a817f21837cc5915686927bdf2f8a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f917e8ac28aa2ac622dbbb14e048c74725f9b9959a9f8ba3da3ef5f9b136383cb3526f14dfbf6ccb6f57cabfb1f0c8a0fc5ba0e6949a56f77473b9639e040ba3"} 11:44:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:44:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:44:39 INFO - Contents: 11:44:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/00089003960fa269f8264975493603a038b6868790fe4333b569506fe3f1aa6316aa64f670a5a4ab3babfb0f6b5114235472d79738b03ded279cf6ff8c3e0b14", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3671e40932a5d80cea0a7b8ffd06bdd194d06d43d236417bdfb03c61f072f9b49ba39b3bc781a37044501ec27ea313b0945a817f21837cc5915686927bdf2f8a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f917e8ac28aa2ac622dbbb14e048c74725f9b9959a9f8ba3da3ef5f9b136383cb3526f14dfbf6ccb6f57cabfb1f0c8a0fc5ba0e6949a56f77473b9639e040ba3"} 11:44:39 INFO - Running post-run listener: copy_logs_to_upload_dir 11:44:39 INFO - Copying logs to upload dir... 11:44:39 INFO - mkdir: /builds/slave/test/build/upload/logs 11:44:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.197882 ========= master_lag: 2.59 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-11-14 11:44:42.282402) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 11:44:42.287088) ========= 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.8mBDbauXmO/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.gY2LNsn3EL/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/00089003960fa269f8264975493603a038b6868790fe4333b569506fe3f1aa6316aa64f670a5a4ab3babfb0f6b5114235472d79738b03ded279cf6ff8c3e0b14", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3671e40932a5d80cea0a7b8ffd06bdd194d06d43d236417bdfb03c61f072f9b49ba39b3bc781a37044501ec27ea313b0945a817f21837cc5915686927bdf2f8a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f917e8ac28aa2ac622dbbb14e048c74725f9b9959a9f8ba3da3ef5f9b136383cb3526f14dfbf6ccb6f57cabfb1f0c8a0fc5ba0e6949a56f77473b9639e040ba3"} build_url:https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011121 build_url: 'https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/00089003960fa269f8264975493603a038b6868790fe4333b569506fe3f1aa6316aa64f670a5a4ab3babfb0f6b5114235472d79738b03ded279cf6ff8c3e0b14", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3671e40932a5d80cea0a7b8ffd06bdd194d06d43d236417bdfb03c61f072f9b49ba39b3bc781a37044501ec27ea313b0945a817f21837cc5915686927bdf2f8a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f917e8ac28aa2ac622dbbb14e048c74725f9b9959a9f8ba3da3ef5f9b136383cb3526f14dfbf6ccb6f57cabfb1f0c8a0fc5ba0e6949a56f77473b9639e040ba3"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 11:44:42.326684) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:44:42.327001) ========= 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.8mBDbauXmO/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.gY2LNsn3EL/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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.005266 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:44:42.376390) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 11:44:42.376709) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 11:44:42.775442) ========= ========= Total master_lag: 2.72 =========