builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0027 starttime: 1478619949.89 results: success (0) buildid: 20161108062935 builduid: e46360cda33a4597ac8e8f6b717065c5 revision: 71a57bc90cf23e334c6c680c929f5b0c5c836ada ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-08 07:45:49.888923) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-08 07:45:49.889411) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-08 07:45:49.889697) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-08 07:45:49.915872) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 07:45:49.916178) ========= 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.LoXUO3uUXy/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.jbSuBR9QHN/Listeners TMPDIR=/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-08 07:45:49-- 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% 14.7M=0.001s 2016-11-08 07:45:50 (14.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.109874 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 07:45:50.050690) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 07:45:50.051160) ========= 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.LoXUO3uUXy/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.jbSuBR9QHN/Listeners TMPDIR=/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.027593 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 07:45:50.102789) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-08 07:45:50.103130) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 71a57bc90cf23e334c6c680c929f5b0c5c836ada --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 71a57bc90cf23e334c6c680c929f5b0c5c836ada --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.LoXUO3uUXy/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.jbSuBR9QHN/Listeners TMPDIR=/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-08 07:45:50,180 truncating revision to first 12 chars 2016-11-08 07:45:50,180 Setting DEBUG logging. 2016-11-08 07:45:50,180 attempt 1/10 2016-11-08 07:45:50,180 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/71a57bc90cf2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-08 07:45:51,156 unpacking tar archive at: mozilla-aurora-71a57bc90cf2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.259449 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-08 07:45:51.384761) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-08 07:45:51.385133) ========= script_repo_revision: 71a57bc90cf23e334c6c680c929f5b0c5c836ada ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-08 07:45:51.385600) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-08 07:45:51.385870) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-08 07:45:51.406086) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-11-08 07:45:51.406630) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.LoXUO3uUXy/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.jbSuBR9QHN/Listeners TMPDIR=/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 07:45:51 INFO - MultiFileLogger online at 20161108 07:45:51 in /builds/slave/test 07:45:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 07:45:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:45:51 INFO - {'append_to_log': False, 07:45:51 INFO - 'base_work_dir': '/builds/slave/test', 07:45:51 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:45:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:45:51 INFO - 'branch': 'Mozilla-Aurora', 07:45:51 INFO - 'buildbot_json_path': 'buildprops.json', 07:45:51 INFO - 'config_files': ('talos/mac_config.py',), 07:45:51 INFO - 'default_actions': ('clobber', 07:45:51 INFO - 'read-buildbot-config', 07:45:51 INFO - 'download-and-extract', 07:45:51 INFO - 'populate-webroot', 07:45:51 INFO - 'create-virtualenv', 07:45:51 INFO - 'install', 07:45:51 INFO - 'run-tests'), 07:45:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:45:51 INFO - 'download_minidump_stackwalk': True, 07:45:51 INFO - 'download_symbols': 'ondemand', 07:45:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:45:51 INFO - 'tooltool.py': '/tools/tooltool.py', 07:45:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:45:51 INFO - '/tools/misc-python/virtualenv.py')}, 07:45:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:45:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:45:51 INFO - 'installer_path': 'installer.exe', 07:45:51 INFO - 'log_level': 'info', 07:45:51 INFO - 'log_name': 'talos', 07:45:51 INFO - 'log_to_console': True, 07:45:51 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:45:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:45:51 INFO - 'opt_config_files': (), 07:45:51 INFO - 'pip_index': False, 07:45:51 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:45:51 INFO - 'cmd': ('bash', 07:45:51 INFO - '-c', 07:45:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:45:51 INFO - 'enabled': True, 07:45:51 INFO - 'halt_on_failure': False, 07:45:51 INFO - 'name': 'check_screen_resolution'},), 07:45:51 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:45:51 INFO - 'cmd': ('bash', 07:45:51 INFO - '-c', 07:45:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:45:51 INFO - 'enabled': True, 07:45:51 INFO - 'halt_on_failure': False, 07:45:51 INFO - 'name': 'check_screen_resolution'},), 07:45:51 INFO - 'run_cmd_checks_enabled': True, 07:45:51 INFO - 'sps_profile': False, 07:45:51 INFO - 'sps_profile_interval': 0, 07:45:51 INFO - 'suite': 'dromaeojs-e10s', 07:45:51 INFO - 'system_bits': '32', 07:45:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:45:51 INFO - 'title': 't-yosemite-r7-0027', 07:45:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:45:51 INFO - 'use_talos_json': True, 07:45:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:45:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:45:51 INFO - 'work_dir': 'build'} 07:45:51 INFO - [mozharness: 2016-11-08 15:45:51.606537Z] Running clobber step. 07:45:51 INFO - Running pre-action listener: _resource_record_pre_action 07:45:51 INFO - Running main action method: clobber 07:45:51 INFO - rmtree: /builds/slave/test/build 07:45:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:45:54 INFO - Running post-action listener: _resource_record_post_action 07:45:54 INFO - [mozharness: 2016-11-08 15:45:54.042693Z] Finished clobber step (success) 07:45:54 INFO - [mozharness: 2016-11-08 15:45:54.042832Z] Running read-buildbot-config step. 07:45:54 INFO - Running pre-action listener: _resource_record_pre_action 07:45:54 INFO - Running main action method: read_buildbot_config 07:45:54 INFO - Using buildbot properties: 07:45:54 INFO - { 07:45:54 INFO - "project": "", 07:45:54 INFO - "product": "firefox", 07:45:54 INFO - "script_repo_revision": "production", 07:45:54 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 07:45:54 INFO - "repository": "", 07:45:54 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 07:45:54 INFO - "buildid": "20161108062935", 07:45:54 INFO - "pgo_build": "False", 07:45:54 INFO - "basedir": "/builds/slave/test", 07:45:54 INFO - "buildnumber": 9, 07:45:54 INFO - "slavename": "t-yosemite-r7-0027", 07:45:54 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 07:45:54 INFO - "platform": "yosemite_r7", 07:45:54 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 07:45:54 INFO - "branch": "mozilla-aurora", 07:45:54 INFO - "repo_path": "releases/mozilla-aurora", 07:45:54 INFO - "revision": "71a57bc90cf23e334c6c680c929f5b0c5c836ada", 07:45:54 INFO - "stage_platform": "macosx64", 07:45:54 INFO - "builduid": "e46360cda33a4597ac8e8f6b717065c5", 07:45:54 INFO - "slavebuilddir": "test" 07:45:54 INFO - } 07:45:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/XvVa7nOqSVWPp9QkrsM2mg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 07:45:54 INFO - Running post-action listener: _resource_record_post_action 07:45:54 INFO - [mozharness: 2016-11-08 15:45:54.046303Z] Finished read-buildbot-config step (success) 07:45:54 INFO - [mozharness: 2016-11-08 15:45:54.046407Z] Running download-and-extract step. 07:45:54 INFO - Running pre-action listener: _resource_record_pre_action 07:45:54 INFO - Running main action method: download_and_extract 07:45:54 INFO - mkdir: /builds/slave/test/build/tests 07:45:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:45:54 INFO - trying https://queue.taskcluster.net/v1/task/XvVa7nOqSVWPp9QkrsM2mg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 07:45:54 INFO - Downloading https://queue.taskcluster.net/v1/task/XvVa7nOqSVWPp9QkrsM2mg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 07:45:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XvVa7nOqSVWPp9QkrsM2mg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 07:45:55 INFO - Downloaded 1199 bytes. 07:45:55 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 07:45:55 INFO - Using the following test package requirements: 07:45:55 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 07:45:55 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:45:55 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 07:45:55 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:45:55 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 07:45:55 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:45:55 INFO - u'jsshell-mac.zip'], 07:45:55 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:45:55 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 07:45:55 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 07:45:55 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:45:55 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 07:45:55 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:45:55 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 07:45:55 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:45:55 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 07:45:55 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:45:55 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 07:45:55 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 07:45:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XvVa7nOqSVWPp9QkrsM2mg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 07:45:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XvVa7nOqSVWPp9QkrsM2mg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:45:55 INFO - Fetch https://queue.taskcluster.net/v1/task/XvVa7nOqSVWPp9QkrsM2mg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 07:45:55 INFO - Expected file size: 16423323 07:46:02 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 07:46:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XvVa7nOqSVWPp9QkrsM2mg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 07:46:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XvVa7nOqSVWPp9QkrsM2mg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:46:02 INFO - Fetch https://queue.taskcluster.net/v1/task/XvVa7nOqSVWPp9QkrsM2mg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 07:46:03 INFO - Expected file size: 16423323 07:46:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XvVa7nOqSVWPp9QkrsM2mg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 07:46:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XvVa7nOqSVWPp9QkrsM2mg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 07:46:10 INFO - Fetch https://queue.taskcluster.net/v1/task/XvVa7nOqSVWPp9QkrsM2mg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 07:46:10 INFO - Expected file size: 14414089 07:46:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:11 INFO - trying https://queue.taskcluster.net/v1/task/XvVa7nOqSVWPp9QkrsM2mg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 07:46:11 INFO - Downloading https://queue.taskcluster.net/v1/task/XvVa7nOqSVWPp9QkrsM2mg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 07:46:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XvVa7nOqSVWPp9QkrsM2mg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 07:46:14 INFO - Downloaded 115460605 bytes. 07:46:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XvVa7nOqSVWPp9QkrsM2mg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 07:46:14 INFO - mkdir: /builds/slave/test/properties 07:46:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:46:14 INFO - Writing to file /builds/slave/test/properties/build_url 07:46:14 INFO - Contents: 07:46:14 INFO - build_url:https://queue.taskcluster.net/v1/task/XvVa7nOqSVWPp9QkrsM2mg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 07:46:15 INFO - Running post-action listener: _resource_record_post_action 07:46:15 INFO - Running post-action listener: set_extra_try_arguments 07:46:15 INFO - [mozharness: 2016-11-08 15:46:15.296956Z] Finished download-and-extract step (success) 07:46:15 INFO - [mozharness: 2016-11-08 15:46:15.297091Z] Running populate-webroot step. 07:46:15 INFO - Running pre-action listener: _resource_record_pre_action 07:46:15 INFO - Running main action method: populate_webroot 07:46:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:46:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:46:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:46:15 INFO - '--tppagecycles', 07:46:15 INFO - '7'], 07:46:15 INFO - 'tests': ['tsvgm']}}, 07:46:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:46:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:46:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:46:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:46:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:46:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:46:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:15 INFO - 'talos_options': ['--disable-e10s'], 07:46:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:46:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:46:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:15 INFO - 'talos_options': ['--disable-e10s'], 07:46:15 INFO - 'tests': ['damp', 'tps']}, 07:46:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:15 INFO - 'tests': ['damp', 'tps']}, 07:46:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:46:15 INFO - 'tests': ['dromaeo_dom']}, 07:46:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:46:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:46:15 INFO - 'tests': ['basic_compositor_video']}, 07:46:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:46:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:46:15 INFO - 'tests': ['a11yr', 07:46:15 INFO - 'ts_paint', 07:46:15 INFO - 'tpaint', 07:46:15 INFO - 'sessionrestore', 07:46:15 INFO - 'sessionrestore_no_auto_restore', 07:46:15 INFO - 'tabpaint']}, 07:46:15 INFO - 'other-e10s': {'tests': ['a11yr', 07:46:15 INFO - 'ts_paint', 07:46:15 INFO - 'tpaint', 07:46:15 INFO - 'sessionrestore', 07:46:15 INFO - 'sessionrestore_no_auto_restore', 07:46:15 INFO - 'tabpaint']}, 07:46:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:46:15 INFO - 'ts_paint', 07:46:15 INFO - 'tpaint', 07:46:15 INFO - 'sessionrestore', 07:46:15 INFO - 'sessionrestore_no_auto_restore', 07:46:15 INFO - 'tabpaint']}, 07:46:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:46:15 INFO - 'ts_paint', 07:46:15 INFO - 'tpaint', 07:46:15 INFO - 'sessionrestore', 07:46:15 INFO - 'sessionrestore_no_auto_restore', 07:46:15 INFO - 'tabpaint']}, 07:46:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:46:15 INFO - 'tests': ['a11yr', 07:46:15 INFO - 'ts_paint', 07:46:15 INFO - 'tpaint', 07:46:15 INFO - 'sessionrestore', 07:46:15 INFO - 'sessionrestore_no_auto_restore', 07:46:15 INFO - 'tabpaint']}, 07:46:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:46:15 INFO - 'tests': ['a11yr', 07:46:15 INFO - 'ts_paint', 07:46:15 INFO - 'tpaint', 07:46:15 INFO - 'sessionrestore', 07:46:15 INFO - 'sessionrestore_no_auto_restore', 07:46:15 INFO - 'tabpaint']}, 07:46:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:46:15 INFO - 'tests': ['tsvgx', 07:46:15 INFO - 'tsvgr_opacity', 07:46:15 INFO - 'tart', 07:46:15 INFO - 'tscrollx', 07:46:15 INFO - 'cart']}, 07:46:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:46:15 INFO - 'tsvgr_opacity', 07:46:15 INFO - 'tart', 07:46:15 INFO - 'tscrollx', 07:46:15 INFO - 'cart']}, 07:46:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:15 INFO - 'talos_options': ['--disable-e10s'], 07:46:15 INFO - 'tests': ['tp5o']}, 07:46:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:15 INFO - 'tests': ['tp5o']}, 07:46:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:15 INFO - 'talos_options': ['--disable-e10s', 07:46:15 INFO - '--xperf_path', 07:46:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:46:15 INFO - 'tests': ['tp5n']}, 07:46:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:15 INFO - 'talos_options': ['--xperf_path', 07:46:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:46:15 INFO - 'tests': ['tp5n']}}, 07:46:15 INFO - 'talos.zip': {'path': '', 07:46:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:46:15 INFO - Running post-action listener: _resource_record_post_action 07:46:15 INFO - [mozharness: 2016-11-08 15:46:15.316017Z] Finished populate-webroot step (success) 07:46:15 INFO - [mozharness: 2016-11-08 15:46:15.316121Z] Running create-virtualenv step. 07:46:15 INFO - Running pre-action listener: _resource_record_pre_action 07:46:15 INFO - Running main action method: create_virtualenv 07:46:15 INFO - Creating virtualenv /builds/slave/test/build/venv 07:46:15 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:46:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:46:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:46:15 INFO - Using real prefix '/tools/python27' 07:46:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:46:16 INFO - Installing distribute.............................................................................................................................................................................................done. 07:46:18 INFO - Installing pip.................done. 07:46:19 INFO - Return code: 0 07:46:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:46:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:19 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 0x104f1c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e92570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe841563790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d30d30>, '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 0x104b96db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d28b20>, '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.LoXUO3uUXy/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.jbSuBR9QHN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:46:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:46:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:46:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LoXUO3uUXy/Render', 07:46:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:19 INFO - 'HOME': '/Users/cltbld', 07:46:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:19 INFO - 'LOGNAME': 'cltbld', 07:46:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:19 INFO - 'MOZ_NO_REMOTE': '1', 07:46:19 INFO - 'NO_EM_RESTART': '1', 07:46:19 INFO - 'PAGER': '/bin/cat', 07:46:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:19 INFO - 'PWD': '/builds/slave/test', 07:46:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:19 INFO - 'SHELL': '/bin/bash', 07:46:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jbSuBR9QHN/Listeners', 07:46:19 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 07:46:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:19 INFO - 'USER': 'cltbld', 07:46:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:19 INFO - 'XPC_FLAGS': '0x0', 07:46:19 INFO - 'XPC_SERVICE_NAME': '0', 07:46:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:19 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:46:19 INFO - Cleaning up... 07:46:19 INFO - Return code: 0 07:46:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:46:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:19 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 0x104f1c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e92570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe841563790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d30d30>, '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 0x104b96db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d28b20>, '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.LoXUO3uUXy/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.jbSuBR9QHN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:46:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:46:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:46:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LoXUO3uUXy/Render', 07:46:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:19 INFO - 'HOME': '/Users/cltbld', 07:46:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:19 INFO - 'LOGNAME': 'cltbld', 07:46:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:19 INFO - 'MOZ_NO_REMOTE': '1', 07:46:19 INFO - 'NO_EM_RESTART': '1', 07:46:19 INFO - 'PAGER': '/bin/cat', 07:46:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:19 INFO - 'PWD': '/builds/slave/test', 07:46:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:19 INFO - 'SHELL': '/bin/bash', 07:46:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jbSuBR9QHN/Listeners', 07:46:19 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 07:46:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:19 INFO - 'USER': 'cltbld', 07:46:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:19 INFO - 'XPC_FLAGS': '0x0', 07:46:19 INFO - 'XPC_SERVICE_NAME': '0', 07:46:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:19 INFO - Downloading/unpacking psutil>=3.1.1 07:46:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:46:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:46:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:46:22 INFO - Installing collected packages: psutil 07:46:22 INFO - Running setup.py install for psutil 07:46:22 INFO - building 'psutil._psutil_osx' extension 07:46:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 07:46:23 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 07:46:23 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 07:46:23 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 07:46:23 INFO - building 'psutil._psutil_posix' extension 07:46:23 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 07:46:23 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:46:23 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:46:23 INFO - ^ 07:46:23 INFO - 1 warning generated. 07:46:23 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 07:46:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:46:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:46:23 INFO - Successfully installed psutil 07:46:23 INFO - Cleaning up... 07:46:23 INFO - Return code: 0 07:46:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:46:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:23 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 0x104f1c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e92570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe841563790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d30d30>, '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 0x104b96db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d28b20>, '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.LoXUO3uUXy/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.jbSuBR9QHN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:46:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:46:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:46:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LoXUO3uUXy/Render', 07:46:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:23 INFO - 'HOME': '/Users/cltbld', 07:46:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:23 INFO - 'LOGNAME': 'cltbld', 07:46:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:23 INFO - 'MOZ_NO_REMOTE': '1', 07:46:23 INFO - 'NO_EM_RESTART': '1', 07:46:23 INFO - 'PAGER': '/bin/cat', 07:46:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:23 INFO - 'PWD': '/builds/slave/test', 07:46:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:23 INFO - 'SHELL': '/bin/bash', 07:46:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jbSuBR9QHN/Listeners', 07:46:23 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 07:46:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:23 INFO - 'USER': 'cltbld', 07:46:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:23 INFO - 'XPC_FLAGS': '0x0', 07:46:23 INFO - 'XPC_SERVICE_NAME': '0', 07:46:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:46:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:46:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:46:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:46:26 INFO - Installing collected packages: mozsystemmonitor 07:46:26 INFO - Running setup.py install for mozsystemmonitor 07:46:26 INFO - Successfully installed mozsystemmonitor 07:46:26 INFO - Cleaning up... 07:46:26 INFO - Return code: 0 07:46:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:46:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104f1c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e92570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe841563790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d30d30>, '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 0x104b96db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d28b20>, '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.LoXUO3uUXy/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.jbSuBR9QHN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:46:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:46:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:46:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LoXUO3uUXy/Render', 07:46:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:26 INFO - 'HOME': '/Users/cltbld', 07:46:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:26 INFO - 'LOGNAME': 'cltbld', 07:46:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:26 INFO - 'MOZ_NO_REMOTE': '1', 07:46:26 INFO - 'NO_EM_RESTART': '1', 07:46:26 INFO - 'PAGER': '/bin/cat', 07:46:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:26 INFO - 'PWD': '/builds/slave/test', 07:46:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:26 INFO - 'SHELL': '/bin/bash', 07:46:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jbSuBR9QHN/Listeners', 07:46:26 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 07:46:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:26 INFO - 'USER': 'cltbld', 07:46:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:26 INFO - 'XPC_FLAGS': '0x0', 07:46:26 INFO - 'XPC_SERVICE_NAME': '0', 07:46:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:27 INFO - Downloading/unpacking jsonschema==2.5.1 07:46:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:46:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:46:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:29 INFO - Downloading functools32-3.2.3-2.tar.gz 07:46:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:46:30 INFO - warning: no files found matching '*.txt' 07:46:30 INFO - no previously-included directories found matching 'build' 07:46:30 INFO - no previously-included directories found matching 'dist' 07:46:30 INFO - no previously-included directories found matching '.git*' 07:46:30 INFO - Installing collected packages: jsonschema, functools32 07:46:30 INFO - Running setup.py install for functools32 07:46:30 INFO - warning: no files found matching '*.txt' 07:46:30 INFO - no previously-included directories found matching 'build' 07:46:30 INFO - no previously-included directories found matching 'dist' 07:46:30 INFO - no previously-included directories found matching '.git*' 07:46:30 INFO - Successfully installed jsonschema functools32 07:46:30 INFO - Cleaning up... 07:46:30 INFO - Return code: 0 07:46:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:46:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104f1c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e92570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe841563790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d30d30>, '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 0x104b96db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d28b20>, '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.LoXUO3uUXy/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.jbSuBR9QHN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:46:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:46:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:46:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LoXUO3uUXy/Render', 07:46:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:30 INFO - 'HOME': '/Users/cltbld', 07:46:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:30 INFO - 'LOGNAME': 'cltbld', 07:46:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:30 INFO - 'MOZ_NO_REMOTE': '1', 07:46:30 INFO - 'NO_EM_RESTART': '1', 07:46:30 INFO - 'PAGER': '/bin/cat', 07:46:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:30 INFO - 'PWD': '/builds/slave/test', 07:46:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:30 INFO - 'SHELL': '/bin/bash', 07:46:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jbSuBR9QHN/Listeners', 07:46:30 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 07:46:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:30 INFO - 'USER': 'cltbld', 07:46:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:30 INFO - 'XPC_FLAGS': '0x0', 07:46:30 INFO - 'XPC_SERVICE_NAME': '0', 07:46:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:46:30 INFO - Cleaning up... 07:46:30 INFO - Return code: 0 07:46:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:46:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104f1c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e92570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe841563790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d30d30>, '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 0x104b96db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d28b20>, '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.LoXUO3uUXy/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.jbSuBR9QHN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:46:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:46:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:46:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LoXUO3uUXy/Render', 07:46:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:30 INFO - 'HOME': '/Users/cltbld', 07:46:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:30 INFO - 'LOGNAME': 'cltbld', 07:46:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:30 INFO - 'MOZ_NO_REMOTE': '1', 07:46:30 INFO - 'NO_EM_RESTART': '1', 07:46:30 INFO - 'PAGER': '/bin/cat', 07:46:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:30 INFO - 'PWD': '/builds/slave/test', 07:46:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:30 INFO - 'SHELL': '/bin/bash', 07:46:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jbSuBR9QHN/Listeners', 07:46:30 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 07:46:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:30 INFO - 'USER': 'cltbld', 07:46:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:30 INFO - 'XPC_FLAGS': '0x0', 07:46:30 INFO - 'XPC_SERVICE_NAME': '0', 07:46:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:30 INFO - Downloading/unpacking blobuploader==1.2.4 07:46:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:33 INFO - Downloading blobuploader-1.2.4.tar.gz 07:46:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:46:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:46:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:46:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:46: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 07:46: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 07:46: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 07:46: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 07:46: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 07:46: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 07:46:34 INFO - Downloading docopt-0.6.1.tar.gz 07:46:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:46:34 INFO - Installing collected packages: blobuploader, requests, docopt 07:46:34 INFO - Running setup.py install for blobuploader 07:46:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:46:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:46:34 INFO - Running setup.py install for requests 07:46:35 INFO - Running setup.py install for docopt 07:46:35 INFO - Successfully installed blobuploader requests docopt 07:46:35 INFO - Cleaning up... 07:46:35 INFO - Return code: 0 07:46:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:46:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:35 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 0x104f1c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e92570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe841563790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d30d30>, '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 0x104b96db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d28b20>, '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.LoXUO3uUXy/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.jbSuBR9QHN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:46:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:46:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:46:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LoXUO3uUXy/Render', 07:46:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:35 INFO - 'HOME': '/Users/cltbld', 07:46:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:35 INFO - 'LOGNAME': 'cltbld', 07:46:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:35 INFO - 'MOZ_NO_REMOTE': '1', 07:46:35 INFO - 'NO_EM_RESTART': '1', 07:46:35 INFO - 'PAGER': '/bin/cat', 07:46:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:35 INFO - 'PWD': '/builds/slave/test', 07:46:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:35 INFO - 'SHELL': '/bin/bash', 07:46:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jbSuBR9QHN/Listeners', 07:46:35 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 07:46:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:35 INFO - 'USER': 'cltbld', 07:46:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:35 INFO - 'XPC_FLAGS': '0x0', 07:46:35 INFO - 'XPC_SERVICE_NAME': '0', 07:46:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:46:35 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-emdHXu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:46:35 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-B57tQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:46:35 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-xy7f_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:46:36 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-tQv9YS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:46:36 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-MNZfP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:46:36 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-j88M7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:46:36 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-GyfBGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:46:36 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-uO2OTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:46:36 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-5mJ2g8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:46:36 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-te_7dg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:46:36 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-n6vbJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:46:36 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-H4Yd1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:46:37 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-KBdjlO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:46:37 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-3hmRf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:46:37 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-NjfNA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:46:37 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-ETi9Gs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:46:37 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-EpXv0u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:46:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:46:37 INFO - Running setup.py install for manifestparser 07:46:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:46:37 INFO - Running setup.py install for mozcrash 07:46:37 INFO - Running setup.py install for mozdebug 07:46:37 INFO - Running setup.py install for mozdevice 07:46:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:46:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:46:38 INFO - Running setup.py install for mozfile 07:46:38 INFO - Running setup.py install for mozhttpd 07:46:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:46:38 INFO - Running setup.py install for mozinfo 07:46:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:46:38 INFO - Running setup.py install for mozInstall 07:46:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:46:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:46:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:46:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:46:38 INFO - Running setup.py install for mozleak 07:46:38 INFO - Running setup.py install for mozlog 07:46:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:46:38 INFO - Running setup.py install for moznetwork 07:46:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:46:39 INFO - Running setup.py install for mozprocess 07:46:39 INFO - Running setup.py install for mozprofile 07:46:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:46:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:46:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:46:39 INFO - Running setup.py install for mozrunner 07:46:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:46:39 INFO - Running setup.py install for mozscreenshot 07:46:39 INFO - Running setup.py install for moztest 07:46:39 INFO - Running setup.py install for mozversion 07:46:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:46:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:46:40 INFO - Cleaning up... 07:46:40 INFO - Return code: 0 07:46:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:46:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:40 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 0x104f1c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e92570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe841563790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d30d30>, '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 0x104b96db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d28b20>, '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.LoXUO3uUXy/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.jbSuBR9QHN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:46:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:46:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:46:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LoXUO3uUXy/Render', 07:46:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:40 INFO - 'HOME': '/Users/cltbld', 07:46:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:40 INFO - 'LOGNAME': 'cltbld', 07:46:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:40 INFO - 'MOZ_NO_REMOTE': '1', 07:46:40 INFO - 'NO_EM_RESTART': '1', 07:46:40 INFO - 'PAGER': '/bin/cat', 07:46:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:40 INFO - 'PWD': '/builds/slave/test', 07:46:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:40 INFO - 'SHELL': '/bin/bash', 07:46:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jbSuBR9QHN/Listeners', 07:46:40 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 07:46:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:40 INFO - 'USER': 'cltbld', 07:46:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:40 INFO - 'XPC_FLAGS': '0x0', 07:46:40 INFO - 'XPC_SERVICE_NAME': '0', 07:46:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:46:40 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-PbxI4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:46:40 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:46:40 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-dALyEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:46:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:46:40 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-oUPldH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:46:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:46:40 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-XbJVnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:46:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:46:40 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-2tbQfw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:46:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:46:40 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-h4sfk2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:46:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:46:40 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-iJl1sL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:46:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:46:41 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-99b8gU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:46:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:46:41 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-TUUjGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:46:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:46:41 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-XFPkeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:46:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:46:41 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-IoaNYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:46:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:46:41 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-NQQTDh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:46:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:46:41 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-i2Jc2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:46:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:46:41 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-wB956D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:46:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:46:41 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-XSNd7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:46:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:46:41 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-4oWuga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:46:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:46:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:46:42 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-FYZdS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:46:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:46:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:46:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:46:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:46:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:46:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:46:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:46:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:44 INFO - Downloading blessings-1.6.tar.gz 07:46:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:46:44 INFO - Installing collected packages: blessings 07:46:44 INFO - Running setup.py install for blessings 07:46:44 INFO - Successfully installed blessings 07:46:44 INFO - Cleaning up... 07:46:44 INFO - Return code: 0 07:46:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:46:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:46:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:46:45 INFO - Reading from file tmpfile_stdout 07:46:45 INFO - Current package versions: 07:46:45 INFO - blessings == 1.6 07:46:45 INFO - blobuploader == 1.2.4 07:46:45 INFO - docopt == 0.6.1 07:46:45 INFO - functools32 == 3.2.3-2 07:46:45 INFO - jsonschema == 2.5.1 07:46:45 INFO - manifestparser == 1.1 07:46:45 INFO - mozInstall == 1.12 07:46:45 INFO - mozcrash == 0.17 07:46:45 INFO - mozdebug == 0.1 07:46:45 INFO - mozdevice == 0.48 07:46:45 INFO - mozfile == 1.2 07:46:45 INFO - mozhttpd == 0.7 07:46:45 INFO - mozinfo == 0.9 07:46:45 INFO - mozleak == 0.1 07:46:45 INFO - mozlog == 3.4 07:46:45 INFO - moznetwork == 0.27 07:46:45 INFO - mozprocess == 0.23 07:46:45 INFO - mozprofile == 0.28 07:46:45 INFO - mozrunner == 6.12 07:46:45 INFO - mozscreenshot == 0.1 07:46:45 INFO - mozsystemmonitor == 0.3 07:46:45 INFO - moztest == 0.7 07:46:45 INFO - mozversion == 1.4 07:46:45 INFO - psutil == 3.1.1 07:46:45 INFO - requests == 1.2.3 07:46:45 INFO - wsgiref == 0.1.2 07:46:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:46:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:45 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 0x104f1c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e92570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe841563790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d30d30>, '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 0x104b96db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d28b20>, '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.LoXUO3uUXy/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.jbSuBR9QHN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:46:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:46:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:46:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LoXUO3uUXy/Render', 07:46:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:45 INFO - 'HOME': '/Users/cltbld', 07:46:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:45 INFO - 'LOGNAME': 'cltbld', 07:46:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:45 INFO - 'MOZ_NO_REMOTE': '1', 07:46:45 INFO - 'NO_EM_RESTART': '1', 07:46:45 INFO - 'PAGER': '/bin/cat', 07:46:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:45 INFO - 'PWD': '/builds/slave/test', 07:46:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:45 INFO - 'SHELL': '/bin/bash', 07:46:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jbSuBR9QHN/Listeners', 07:46:45 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 07:46:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:45 INFO - 'USER': 'cltbld', 07:46:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:45 INFO - 'XPC_FLAGS': '0x0', 07:46:45 INFO - 'XPC_SERVICE_NAME': '0', 07:46:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:46:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:46:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:46:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:46:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:46:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:46:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:46:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:46:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:46:45 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:46:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:46:45 INFO - Cleaning up... 07:46:45 INFO - Return code: 0 07:46:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:46:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104f1c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e92570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe841563790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d30d30>, '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 0x104b96db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d28b20>, '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.LoXUO3uUXy/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.jbSuBR9QHN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:46:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:46:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:46:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LoXUO3uUXy/Render', 07:46:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:45 INFO - 'HOME': '/Users/cltbld', 07:46:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:45 INFO - 'LOGNAME': 'cltbld', 07:46:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:45 INFO - 'MOZ_NO_REMOTE': '1', 07:46:45 INFO - 'NO_EM_RESTART': '1', 07:46:45 INFO - 'PAGER': '/bin/cat', 07:46:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:45 INFO - 'PWD': '/builds/slave/test', 07:46:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:45 INFO - 'SHELL': '/bin/bash', 07:46:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jbSuBR9QHN/Listeners', 07:46:45 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 07:46:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:45 INFO - 'USER': 'cltbld', 07:46:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:45 INFO - 'XPC_FLAGS': '0x0', 07:46:45 INFO - 'XPC_SERVICE_NAME': '0', 07:46:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:46:46 INFO - Cleaning up... 07:46:46 INFO - Return code: 0 07:46:46 INFO - Running post-action listener: _resource_record_post_action 07:46:46 INFO - Running post-action listener: _start_resource_monitoring 07:46:46 INFO - Starting resource monitoring. 07:46:46 INFO - [mozharness: 2016-11-08 15:46:46.122707Z] Finished create-virtualenv step (success) 07:46:46 INFO - [mozharness: 2016-11-08 15:46:46.123557Z] Running install step. 07:46:46 INFO - Running pre-action listener: _resource_record_pre_action 07:46:46 INFO - Running main action method: install 07:46:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:46:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:46:46 INFO - Reading from file tmpfile_stdout 07:46:46 INFO - Detecting whether we're running mozinstall >=1.0... 07:46:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:46:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:46:46 INFO - Reading from file tmpfile_stdout 07:46:46 INFO - Output received: 07:46:46 INFO - Usage: mozinstall [options] installer 07:46:46 INFO - Options: 07:46:46 INFO - -h, --help show this help message and exit 07:46:46 INFO - -d DEST, --destination=DEST 07:46:46 INFO - Directory to install application into. [default: 07:46:46 INFO - "/builds/slave/test"] 07:46:46 INFO - --app=APP Application being installed. [default: firefox] 07:46:46 INFO - mkdir: /builds/slave/test/build/application 07:46:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:46:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 07:47:18 INFO - Reading from file tmpfile_stdout 07:47:18 INFO - Output received: 07:47:18 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 07:47:18 INFO - Running post-action listener: _resource_record_post_action 07:47:18 INFO - [mozharness: 2016-11-08 15:47:18.910940Z] Finished install step (success) 07:47:18 INFO - [mozharness: 2016-11-08 15:47:18.911101Z] Running run-tests step. 07:47:18 INFO - Running pre-action listener: _resource_record_pre_action 07:47:18 INFO - Running main action method: run_tests 07:47:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:47:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:47:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:47:18 INFO - 2016-11-08 07:47:18.925 screenresolution[1634:7632] starting screenresolution argv=screenresolution get 07:47:18 INFO - 2016-11-08 07:47:18.928 screenresolution[1634:7632] Display 0: 1600x1200x32@60 07:47:18 INFO - 2016-11-08 07:47:18.933 screenresolution[1635:7634] starting screenresolution argv=screenresolution list 07:47:18 INFO - Available Modes on Display 0 07:47:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:47:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:47:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:47:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:47:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:47:19 INFO - Intel Iris: 07:47:19 INFO - Chipset Model: Intel Iris 07:47:19 INFO - Type: GPU 07:47:19 INFO - Bus: Built-In 07:47:19 INFO - VRAM (Dynamic, Max): 1536 MB 07:47:19 INFO - Vendor: Intel (0x8086) 07:47:19 INFO - Device ID: 0x0a2e 07:47:19 INFO - Revision ID: 0x0009 07:47:19 INFO - Displays: 07:47:19 INFO - Display: 07:47:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:47:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:47:19 INFO - Display Serial Number: 1600x1200 60 07:47:19 INFO - Main Display: Yes 07:47:19 INFO - Mirror: Off 07:47:19 INFO - Online: Yes 07:47:19 INFO - Rotation: Supported 07:47:19 INFO - Return code: 0 07:47:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:47:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:47:19 INFO - Python 2.7.3 07:47:19 INFO - Return code: 0 07:47:19 INFO - grabbing minidump binary from tooltool 07:47:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:19 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 0x104d30d30>, '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 0x104b96db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d28b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:47:19 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:47:19 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 07:47:19 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:47:19 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:47:19 INFO - Return code: 0 07:47:19 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:47:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:47:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:47:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:47:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:47:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XvVa7nOqSVWPp9QkrsM2mg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:47:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XvVa7nOqSVWPp9QkrsM2mg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0027 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:47:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LoXUO3uUXy/Render', 07:47:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:19 INFO - 'HOME': '/Users/cltbld', 07:47:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:19 INFO - 'LOGNAME': 'cltbld', 07:47:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:47:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:47:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:19 INFO - 'MOZ_NO_REMOTE': '1', 07:47:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:47:19 INFO - 'NO_EM_RESTART': '1', 07:47:19 INFO - 'PAGER': '/bin/cat', 07:47:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:19 INFO - 'PWD': '/builds/slave/test', 07:47:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:47:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:19 INFO - 'SHELL': '/bin/bash', 07:47:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jbSuBR9QHN/Listeners', 07:47:19 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 07:47:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:19 INFO - 'USER': 'cltbld', 07:47:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:19 INFO - 'XPC_FLAGS': '0x0', 07:47:19 INFO - 'XPC_SERVICE_NAME': '0', 07:47:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XvVa7nOqSVWPp9QkrsM2mg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:47:19 INFO - mozversion application_buildid: 20161108062935 07:47:19 INFO - mozversion application_changeset: 71a57bc90cf23e334c6c680c929f5b0c5c836ada 07:47:19 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:47:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:47:19 INFO - mozversion application_name: Firefox 07:47:19 INFO - mozversion application_remotingname: firefox-dev 07:47:19 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:47:19 INFO - mozversion application_vendor: Mozilla 07:47:19 INFO - mozversion application_version: 51.0a2 07:47:19 INFO - mozversion platform_buildid: 20161108062935 07:47:19 INFO - mozversion platform_changeset: 71a57bc90cf23e334c6c680c929f5b0c5c836ada 07:47:19 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:47:19 INFO - mozversion platform_version: 51.0a2 07:47:19 INFO - using testdate: 1478620039 07:47:19 INFO - actual date: 1478620039 07:47:19 INFO - starting webserver on 'localhost:49279' 07:47:19 INFO - SUITE-START | Running 2 tests 07:47:19 INFO - TEST-START | dromaeo_css 07:47:19 INFO - operating with platform_type : mac_ 07:47:19 INFO - Initialising browser for dromaeo_css test... 07:47:19 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/tmpsd0ZvR/profile http://localhost:49279/getInfo.html) 07:47:22 INFO - PROCESS | 1645 | __metrics Screen width/height:1600/1200 07:47:22 INFO - PROCESS | 1645 | colorDepth:24 07:47:22 INFO - PROCESS | 1645 | Browser inner width/height: 1024/689 07:47:22 INFO - PROCESS | 1645 | __metrics 07:47:22 ERROR - PROCESS | 1645 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 07:47:23 INFO - TEST-INFO | 1645: exit 0 07:47:23 INFO - Browser initialized. 07:47:23 INFO - Running cycle 1/1 for dromaeo_css test... 07:47:23 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/tmpsd0ZvR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:47:35 INFO - PROCESS | 1648 | RSS: Main: 225726464 07:47:35 INFO - PROCESS | 1648 | 07:48:24 INFO - PROCESS | 1648 | 1478620104778 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:50:37 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49279/tests/dromaeo/cssquery-ext.html) 07:50:38 INFO - PROCESS | 1648 | RSS: Main: 238817280 07:50:38 INFO - PROCESS | 1648 | 07:53:41 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-ext.html (next: http://localhost:49279/tests/dromaeo/cssquery-jquery.html) 07:53:41 INFO - PROCESS | 1648 | RSS: Main: 248168448 07:53:41 INFO - PROCESS | 1648 | 07:56:43 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49279/tests/dromaeo/cssquery-mootools.html) 07:56:44 INFO - PROCESS | 1648 | RSS: Main: 251875328 07:56:44 INFO - PROCESS | 1648 | 07:59:46 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49279/tests/dromaeo/cssquery-prototype.html) 07:59:46 INFO - PROCESS | 1648 | RSS: Main: 252366848 07:59:46 INFO - PROCESS | 1648 | 08:02:49 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49279/tests/dromaeo/cssquery-yui.html) 08:02:50 INFO - PROCESS | 1648 | RSS: Main: 257445888 08:02:50 INFO - PROCESS | 1648 | 08:05:52 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-yui.html (next: http://localhost:49279/tests/dromaeo/cssquery-dojo.html) 08:05:53 INFO - PROCESS | 1648 | RSS: Main: 259248128 08:05:53 INFO - PROCESS | 1648 | 08:05:53 INFO - PROCESS | 1648 | __start_tp_report 08:05:53 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 08:05:53 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 08:05:53 INFO - PROCESS | 1648 | |i|pagename|runs| 08:05:53 INFO - PROCESS | 1648 | |0;dojo.html;2930;3473.426884564047;3501.6498350165;3516.8241587920606;3522.418800897852;5918.171455996158;5996.070609055603;6010.429009244121;6036.728347224374;6037.305709843369;5877.030290002144;5922;6011.398860113997;6013.699315034252;6029.457348838604;4459.732416055047;4487.326900964848;5410;5466.398696143421;5514.117741161415;5466.699331536764;5498.395176530578;5499.257600223978;5510.118381059031;5528.474794894479;5361.51746342831;5416;5488.643238189505;5507.697076660782;5544.362398324204;5427.83716488506;5429.67421954684;5451.836444906659;5462.535684466825;5492.588055895784;4538.455385353779;5375.946240537583;5400.945990540123;5411.485908838654;5457.727113644302;5794.072948328289;6041.395860413923;6067.453929146354;6090.390960903918;6106.053561697944;6201.255849298113;6267;6275.717592708339;6277.372262773732;6305.085762564402;6317.905231421532;6319.431251187415;6355.110284560165;6359.936400635981;6364.872702545969;5958.344582095966;6053.364396738323;6057.545684073668;6059.545534084961;6081.391860813883;6325.114483972247;6372.872542549123;6403.871922561522;6418.518611104186;6429.7749578764515;6334.809955701337;6350.079238510482;6352.8411789704705;6376.234851817811;6376.74493020274;5019.598432125495;5211.2443695663915;5233.712145832016;5708.40061793514;5716.942365662366;6287.245530536365;6352.936470635327;6365.49076073913;6367.522435817332;6386.329435409215;5318.335208098988;6004.819855404345;6333.176687030748;6348.904766428507;6351.237851457762;4948.38145231846;4976.701397916137;4998.850034498971;5056.115179843513;5064.924026139611;4501.932471012938;4548.158590660738;4555.544445555418;4582.083583283356;4587.3807036050375;5427.728613569306;5787.102999035156;6017.518598512109;6170.10533472644;6188.659623720649;6235.875282494325;6332.430081292614;6344.206974128234;6345.270293916166;6350.7777227796805;6045.425684559959;6095.2685677718955;6129.478994285447;6141.179174348115;6144.047672610753;5563.026470367669;5573.052581061148;5584.664920104807;5586.972065139648;5610.18652295423;6460.547761656733;6465.644389558525;6496.935030649727;6508.60948343101;6537.803865884031;6263.655498947602;6273;6282.748690052529;6318.684065796784;6320.715567799552;6477.578957367756;6480.740770369132;6486.740530378921;6500.6424646643;6515.2833188348295;6335.366463353628;6355.841103972438;6364.236291645032;6367.299597044414;6368.649724265025;5436.891262174813;6131.938680613137;6250.9998400255745;6260;6318.557700960889;6283.403076707706;6313.55805093639;6327.430531252209;6330.683465826783;6367.204099487564;6297.433231009231;6325.114483972339;6339.683015849281;6344.27040890285;6353.872922541431;5956.315023772322;6134.969325153525;6137.447629713347;6151.046587778901;6275.811725648238;6237.781677641261;6273.811785646438;6316.494680425463;6322.841928951629;6325.987841945267;6171.84570385744;6187.783427580013;6201.875962480815;6210.5652604317265;6229.626222426669 08:05:53 INFO - PROCESS | 1648 | |1;ext.html;477.7778333075119;499.555395697829;513.4147072337535;536.0859734153269;538.3701069748394;33483;40816.79591602041;40950.180996380055;40966.79516602413;41066.76799696014;41187;41592.58407415925;42108.78945605276;42164.367534487006;42295.78852105735;9755.8048839023;9778.413295202276;9779.168770654504;9804.36271642341;9809.264305177105;9669.226461883032;9765.12113909748;9780.559874805615;9788.923218445965;9817.312788104835;9778.90221097787;9797;9807.852882206773;9810.852837207447;9832.26258030647;9702.805943881083;9728.416295022285;9774.853377199348;9790.5594248259;9791.412515249107;9624.615015399446;9659.806803863954;9724;9746.171575416098;9746.561404736733;39565.80217098925;39816.20367592661;39910;39975.8001209995;40020;2910.7816913731554;3098.2719061020643;3186.553882456458;3283.9983804939484;3357.513160591725;23159.305220843235;30231.848840755876;30459.2385190372;31086.844565777254;31704;2776.5279902416437;3243.3026899216547;3255.820929848881;3264.7714659973813;3369.8146601936883;503585;508123;512850;514706;515140;61535.76928461495;61789;61955.69022154951;62257.688711556155;62310.688446558386;30605;34968.12579685528;35860;36670;36936.26127477489;14378.35297411619;17022.914885425493;17064.573385665208;17243.56891077708;17248.137593120293;12883.742325153444;13146.145500542434;13234.205947643171;13243.940484761197;13270.137441066492;19328.68639124066;19569;19593.8040619592;19633;19679.40961771149;8004.83990320202;8020.518768873886;8043;8116.8782468263025;8273.131321211307;847.3179090831816;966.4298064142049;1014.2190513304714;1018.2363227579316;1086.8587083679072;25068.623970640456;30288;30626.69373306283;30949.91675291354;31053.223669408446;1023.5752162852482;1035.6064695415694;1036.6268143468346;1068.9412082335546;1075.7525769073156;14041.85958140426;16729.749053764204;16852.494425167264;17079.48761537156;17282.913585431994;717134;719445;731118;732169;733100;52756;53212.201816972774;53252;53279.46720532823;53476.46523534715;1318.775808112623;1335.886449651771;1354.634248752851;1364.5087768403366;1367.9110857794212;29311.7068829309;29409.988764990732;30522.389552209275;31489.685103148677;31965.68034319627;50224;50610.49389506205;50625.74687126541;50767.2384914234;50828.491715082375;630081;631256;637491;638053;642013.7899310474;25950;26114.347141320857;26462.470750584496;26594.069207577642;26595.601065984414;46233;47496.7625161872;47770.52229477661;47781.522184779096;48263;38616.61383386242;39331.80334098311;39684.60315396809;40854.59145408508;41024.1795164101;39122;39313.606863930996;39382.803085985535;40041.79979100202;40475.1904961905;35731.10672233111;38117.618823811405;39057.414138787375;39991.2001759969;41545.37681934834;24907.626385603868;29339.41321173607;33673.663263368035;34372.82813585916;35328.823355883054;22872.656910146696;24118.276451706475;25811.225663230132;26031.666749912896;26043.348916277246 08:05:53 INFO - PROCESS | 1648 | |2;jquery.html;376.75134411288536;377.46588577163317;384.39265959783546;386.4956232117087;407.26488687918294;18896.527586810338;20466;20652.690209646848;20772.857492837888;20791.480212994684;19773.406797796088;20017.099230534626;20082.29711960082;20194.394168174942;20493.282735104276;4721.811127554911;5829.446202610756;6087.239095113111;6536.659984703125;6621.304762999888;6552.7051282692155;6755.189377274709;6839.863202735943;6841.452683785285;6860.108185935821;5036.773345199456;6709.865802683943;6724.495662825308;6731.899021514681;6980.813261745516;6441.645709486;6626.635535045571;6711.765088221913;6724.731010759564;6743.190817101955;5790.68151251681;5792.594518383715;5829.708514574254;5831.037878750001;5894.233749612523;24298.39254018646;24574.139905103413;24684.506309873883;24767.50464990708;24835.13077042313;2280.566692328452;2342.1802369170823;2472.3819045238693;2488;2668.9599656005175;14720.852791472056;15193.392264309414;15266.542003739905;15397.307121179574;15558.377664893504;1798.2177752677496;1873.4286042756953;1896.6117717299423;1912.8947907865063;1955.0517998770586;116638.41680791542;117594;125130.74869251282;131986.3400683;136412.31793841068;11694.766104678029;11797.941010294893;11916.344601046852;11922.940385298018;12084.516619335303;14458.132512049311;14478;14537.78193327101;14588;14613.561593152222;8598.699045533376;8689.956550217335;8798.296136309207;8806.515641639771;8913;8652.740417787476;8766.60550275239;8888.377813552988;8901.688440904667;9378.109079637423;3804.847806087781;4004.65960393364;4060.4924384451942;4546.88632784183;4606.355110284563;1719.2693105430142;1939.7575303087115;1954.7067939808858;1967.7638683358089;1977.4378241189586;854.918782715641;903.8282726281985;907.5552979040223;961.0197598449543;964.71058682395;17558.38545650896;20759.68860467094;21046.47383815417;21209.575808483743;21267.680984785242;862.7023676831483;883.3198437203317;966.8114717630135;969.7453420796676;987.8715766950394;10505.684829454976;11040.834387484194;11124.443777811077;11136.220464567565;11137.610183643534;600312;601904;605742;607326;616970;101054;135474.32262838623;137744.31127844297;138390;138862.61137388498;949.7245798718294;990;1017.5624481472889;1021.4484178543652;1026.1226651213256;18740.7188892164;19279.51801204981;19490.512737181685;19621.901890490455;19752.90123549373;57507;59788.70105649618;60437;60777.088343675765;61820;84452;84617.57691211505;85475.57262213649;85816;86452.13547864693;6602.801915942529;8030.598470076356;8125.553094579618;8207.794805129919;8266.545340006358;10698.518566664363;12280.078994075302;12673;12684.429200685807;12948.287844168284;10546.57813687444;10833.512491937725;11090;11156.274842135235;11170.050545703707;10616.575336986743;10794.298370605886;10850.457477125954;11249.381284029458;11265.943670281596;11046.171537134587;11078;11133.719622243221;11424.200305978502;11487.310761354345;8011.39914506426;8208.015038195215;8319.667213311643;8374.49753014821;8461.788455288666;9296.535173241446;9342.346035777431;10088.899111008795;10465.476726163814;10898.237123401286 08:05:53 INFO - PROCESS | 1648 | |3;mootools.html;1331.700367417331;1552.5575211064845;1712.5975395781988;1739.8434140927313;1883.7959587282878;8133.959330203355;8395.244428001479;8721.738347849567;9270.907290927096;9284.025177356372;8688.304935605152;9029;9034.503102329369;9073.09269073094;9100.681476148337;2044.8057434543693;2410.795082417988;2412.1557454890735;2414.082648593532;2460.790832779216;2417.2748175547267;2436.0986435019067;2447.9755202448014;2458.299384675368;2458.9262322130276;2426.1387207541334;2430.586800243954;2442.6213936839818;2463.7659422354845;2467.1241709193246;2410.7468715784853;2426.9271921842374;2428.6964129483813;2441.8534887906694;2446.8654224017673;2418.22616762636;2431.477232395026;2436.4517983453757;2440.646106314592;2444.327809852287;8948.955255223747;8964.282857371394;8985.955070224607;9012.954935225282;9115.726528204164;5362.142057270857;5509.531689806371;5532.446755324476;5535.861603459905;5552.305961754781;3638.490611314418;3671.1005803578028;3690.7785532867847;3692.187718701908;3751.718621103428;1098.132475344477;1101.7576133250673;1103.9227254092216;1115.5091759625739;1129.5086637312713;11062.280951738112;12008.279503229747;12050.758984820255;12098.455569499394;12120.81818772719;4051.817668204879;4504.301833215857;4575.473820510684;4745.14587374269;4765.11845308619;9180.403273787182;9269.582868770922;9272.675456358995;9287.396319239228;9298.53507324631;5362.195670649434;5368.141097424472;5371.865703357447;5386.057439947994;5392.299001129828;4508.504064552896;4644.558766917137;4868.172410690191;4996.650234483552;5027.82402615914;3857.9807100964317;3885.86399476017;3972.781497017634;4000.879973600797;4009.7393669411395;1000.6897861662908;1194.2237545595433;1201.6815543880878;1205.048012070472;1206.5415142246065;785.658238666182;877.7147427086222;892.9910700892908;925.5279807298326;942.0955882352881;5917.319508256605;5943.435373639497;6003.099535069687;6156.78451254204;6276.874462510816;810.4934415990007;932.5616960028775;956.7416797464646;975.2100798353357;1010.6412223660642;3508.5088087667746;3886.8250928708276;3938.8424463021734;3966.940495892564;4031;9682.273829462818;10349.327293725884;10616.097631701237;10916.235863489479;10964.232503724823;10786.191035672198;10818.729531761768;10925.235233533576;10965.177611679155;10970.232083754061;7913.208679132041;8205.343572514304;8274.544900030436;8380.203880631208;8400.873986890201;4720.669553131248;5927.940720592739;6046.2139921809885;6071.483923866521;6169.136320914986;9868.421052631544;10203.336783109075;10274.434906080238;10358.326708763907;10448.798388185456;9064.592093355683;10169.745756356151;10179.251602067548;10472.371657700562;10565.788684226427;7072.292770723092;7320.597367144858;7497.062867141607;7603.809904752426;7667.194944530967;8006;8605.784855378666;8713.215810577078;8723.520206388455;8724.302055835646;7535.510191837513;7555.433342499225;7597;7783.961080194563;7792.37660987131;7476.887846682195;7525.473216874985;7548.773536793905;7551.546907185587;7667.616619168908;7098.503104782822;7231.819204519718;7233.095863017123;7253.165885922976;7261.237570055279;4886.65793394459;4904.8773780655765;4924.704517728947;5009.624278179078;5066.695998240118;4270.252705776415;5004.149294619996;5058.822941197041;5070.746462676778;5102.948970510248 08:05:53 INFO - PROCESS | 1648 | |4;prototype.html;301.1357404249803;303.13757360309927;312.08870099310013;315.163241593569;315.2166865339632;4898.09385263726;5327.893442131155;5519.668819870805;5521.861953451165;5541.9722901385485;5336.02567050192;5469.206964990074;5487.542848005751;5495.642783219088;5525.778968841251;3586.063525696121;3983.6414722674954;4193.888619515831;4268.566916857392;4293.828246870122;3896.610338966109;3897.395903634927;3933.4856080408963;3991.42124391963;4145.730527515717;3173.6350319713297;3646.1404683611286;4096.406021126935;4123.525794533622;4172.374143878427;3866.969840833585;4160.83356665733;4170.749755014709;4182.477190351206;4197.244495990736;3173.6191657001077;3484.7212223022098;3620.837062332201;3631.382664946965;3651.634836516327;4003.459532963042;4390.8902277443;4398.8020539075815;4402.471703395581;5095.923561146586;4723.338732577442;4756.28655701644;4764.546258676784;4816.7350795706225;4817.4219093708625;4756.405449318835;5331.253624492574;5336;5803.912941305884;5894.351621321651;3459.128922993909;3913.1391093959282;3940.8423663053445;3941.975086477508;3985.900352491182;5305.4164041955355;6069.118573242309;6077.301110372319;6151.72317245725;6209.968950155266;3977.423273625308;4037.2934736421007;4045.4943132108488;4048.2915489789757;4061.918761624751;3509.420945543957;3747.6065013173225;3848.499695039627;3851.8651847185774;4019.7538762983568;3772.07624111705;3791.710818321784;4391.780410979438;4719.065183274841;4746.050789841976;5567.9420910027775;5850.23946886902;5896.498797602166;5942.762289508458;5964.671943043174;1283.4288741510125;1307.6338625184962;1327.701267214869;1344.341272776352;1376.2293115854952;780.8828675698691;781.9804504887423;874.0036358551257;913.36064754672;913.72588223534;4306.676999225071;4571.405717256735;4713.905721885543;5005.74971251436;5403.783848646089;4808.831690890802;5659.405762394971;5893;5894.410558944157;5963.701814909324;4976;5429.294191755125;5455.290812194468;5487.670739755627;5547.306586676666;2416.6495858100475;2572.215474280325;2580.6258092576472;2639.1686618715044;2658.9069382571906;4305.332673435622;4814.879628009257;5145.511176438233;5173.948260517422;5177.844664660066;4656.511066338054;4800.023985129243;5113.821016264413;5652.406497317723;6182.876342473125;5218.165093585008;5451.400345961941;5895.675737834375;6088.4824789893355;6183.752649894044;5346.625736198429;6075.817725468243;6087.57386982907;6092.329843717099;6109.511239100772;4963.677360971526;5278.5249327560705;5528.253685752533;5866.266716660418;5994.201739478052;6268.780592679234;6347;6357.268914074941;6361.395667411589;6381.234251889618;3340.5301667266326;3681.723870709654;3957.5053118360206;4012.2947747207904;4029.1135950090934;4904.5340692634145;5803.535717142534;5919.970400147971;5937.882611628929;5939.4357536034;5067.695938243717;5672.177534257592;5765.4522820332;5806.796762113306;5917.520619845039;5057.797688092435;5827.562932779973;5850.736716847837;5866.2373891393845;5878.470937615635;4738.739369334719;4873.537013983666;5358.98179345923;5471.699056551928;5756.6685492375655;4895;5885.352611212848;5892.850894075786;5940.61386009908;5987.550933680079;5370.570354371563;5782.681952492653;5782.710864456676;5802.796902108406;5832.825015249549 08:05:53 INFO - PROCESS | 1648 | |5;yui.html;700.5691499727666;701.7649087555669;753.329536712326;782.0498094814799;796.8087658961844;13665.248411337372;13805.964552658541;14596.759275461585;15379.692406151884;15458.922705386485;13978.440862365518;13979.720405591883;14016.299185040758;14037.36831842567;14097.718045639107;646.1051443750416;659.9274079851212;794.56696100625;798.9720359787409;814.4421071565996;829.2495291760936;832.4381042796089;833.2001278772356;835.2983493865152;839.6725277141888;805.5207151744731;873.0134947509338;877.0002197494861;880.216607219575;882.8101958079012;871.6252011634995;873.8558137907238;874.9650013999433;875.0767939823484;875.3259989807813;647.9902801457935;648.7080813633836;650.4308729861372;650.7169381319142;651.0754728285846;14522.782158267635;14672.11967281956;14684.486042988445;14704.558863234013;14717.411303547846;14413.639659008608;14512.564623061326;14605.269736513132;14614.561563153122;14641.34113964874;9675.322727409084;11517.539298428053;11894.107941904393;11927.94036029823;12345.13584049117;3652.9634703653155;3676.246369494247;3737.0657335666083;3750.3811871041244;3841.615838416164;122798.77201227963;123113.38443307726;124610.37694811559;125632;127750.36124819316;9544.856827147598;9928.900710992797;10254.897451025543;10614.991575800286;10984.340939543654;20280.89859550693;20389.18443262253;20498.077586508643;20536.691949620767;20547;7614.771556853303;7646.579438130956;7695.461317707706;7726.690932362755;8024.996875390576;4433.889152771207;4455.754933478625;4468.709533880287;4469.061497085649;4540.341650460665;3381.3575420670486;3483.8432270547887;3507.035565219585;3518.8416521256604;3810.8094595270127;707.2750430808462;724.1744411371042;733.2044731466312;733.230108386203;738.6343759838807;599.838043728191;608.5880756644631;636.5703150373572;662.4634046422414;677.7898851355997;8625.69810056645;9162.587683554257;9258.398204116711;9311.767205819773;9344.532773361305;601.7382438639206;606.902895536712;621.254494606474;642.4474951541671;657.1260223902199;4223.176480586256;4476.1495315890525;4485.573870482299;4505.639548836085;4530.252508336153;97354;137500.31249843686;148719;159112;162152;124635;134673.65326346806;140077.59922400647;141220;142639;78732;91438.08561914296;98079;106040.34899127584;118999.81000189888;8361.331093512383;8603.52680602573;8661.913380866363;8781.25359344463;8796;59379;60461;60838.08742868772;60927.69536152468;62561.68719156375;60274;88672;91836;96480;96926;12599.18105323151;12968.416421261254;13061.542846000344;13345.733085338434;13460.461581536629;14063.718725625225;14652.413903443743;15230.466933657712;15288.312025959081;15600.051827414909;14134.929325353307;14185.219812909976;14323.71352572922;14341.78487322712;14574.85425145735;11313;13679.589612311647;13798;13940.79088813689;14149.858501414854;13022.544210952572;13133.277669728257;13573.932130339284;13656.248906310248;13775.724485510033;10315.587376504856;10947.397893115955;11359.375234362189;11408.258463199865;11410.258333208314;11347.546098156312;11629.18595698293;11831.704207394883;11862.40687965581;11905.52377904874 08:05:53 INFO - PROCESS | 1648 | __end_tp_report 08:05:53 INFO - PROCESS | 1648 | __start_cc_report 08:05:53 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,362 08:05:53 INFO - PROCESS | 1648 | __end_cc_report 08:05:53 INFO - PROCESS | 1648 | __startTimestamp1478621153001__endTimestamp 08:05:53 INFO - PROCESS | 1648 | 08:05:53 INFO - PROCESS | 1648 | ------- Summary: start ------- 08:05:53 INFO - PROCESS | 1648 | Number of tests: 6 08:05:53 INFO - PROCESS | 1648 | 08:05:53 INFO - PROCESS | 1648 | [#0] dojo.html Cycles:165 Average:5872.69 Median:6137.45 stddev:673.58 (11.0%) stddev-sans-first:634.86 08:05:53 INFO - PROCESS | 1648 | Values: 2930.0 3473.4 3501.6 3516.8 3522.4 5918.2 5996.1 6010.4 6036.7 6037.3 5877.0 5922.0 6011.4 6013.7 6029.5 4459.7 4487.3 5410.0 5466.4 5514.1 5466.7 5498.4 5499.3 5510.1 5528.5 5361.5 5416.0 5488.6 5507.7 5544.4 5427.8 5429.7 5451.8 5462.5 5492.6 4538.5 5375.9 5400.9 5411.5 5457.7 5794.1 6041.4 6067.5 6090.4 6106.1 6201.3 6267.0 6275.7 6277.4 6305.1 6317.9 6319.4 6355.1 6359.9 6364.9 5958.3 6053.4 6057.5 6059.5 6081.4 6325.1 6372.9 6403.9 6418.5 6429.8 6334.8 6350.1 6352.8 6376.2 6376.7 5019.6 5211.2 5233.7 5708.4 5716.9 6287.2 6352.9 6365.5 6367.5 6386.3 5318.3 6004.8 6333.2 6348.9 6351.2 4948.4 4976.7 4998.9 5056.1 5064.9 4501.9 4548.2 4555.5 4582.1 4587.4 5427.7 5787.1 6017.5 6170.1 6188.7 6235.9 6332.4 6344.2 6345.3 6350.8 6045.4 6095.3 6129.5 6141.2 6144.0 5563.0 5573.1 5584.7 5587.0 5610.2 6460.5 6465.6 6496.9 6508.6 6537.8 6263.7 6273.0 6282.7 6318.7 6320.7 6477.6 6480.7 6486.7 6500.6 6515.3 6335.4 6355.8 6364.2 6367.3 6368.6 5436.9 6131.9 6251.0 6260.0 6318.6 6283.4 6313.6 6327.4 6330.7 6367.2 6297.4 6325.1 6339.7 6344.3 6353.9 5956.3 6135.0 6137.4 6151.0 6275.8 6237.8 6273.8 6316.5 6322.8 6326.0 6171.8 6187.8 6201.9 6210.6 6229.6 08:05:53 INFO - PROCESS | 1648 | 08:05:53 INFO - PROCESS | 1648 | [#1] ext.html Cycles:180 Average:74065.33 Median:39942.90 stddev:169186.92 (423.6%) stddev-sans-first:169571.31 08:05:53 INFO - PROCESS | 1648 | Values: 477.8 499.6 513.4 536.1 538.4 33483.0 40816.8 40950.2 40966.8 41066.8 41187.0 41592.6 42108.8 42164.4 42295.8 9755.8 9778.4 9779.2 9804.4 9809.3 9669.2 9765.1 9780.6 9788.9 9817.3 9778.9 9797.0 9807.9 9810.9 9832.3 9702.8 9728.4 9774.9 9790.6 9791.4 9624.6 9659.8 9724.0 9746.2 9746.6 39565.8 39816.2 39910.0 39975.8 40020.0 2910.8 3098.3 3186.6 3284.0 3357.5 23159.3 30231.8 30459.2 31086.8 31704.0 2776.5 3243.3 3255.8 3264.8 3369.8 503585.0 508123.0 512850.0 514706.0 515140.0 61535.8 61789.0 61955.7 62257.7 62310.7 30605.0 34968.1 35860.0 36670.0 36936.3 14378.4 17022.9 17064.6 17243.6 17248.1 12883.7 13146.1 13234.2 13243.9 13270.1 19328.7 19569.0 19593.8 19633.0 19679.4 8004.8 8020.5 8043.0 8116.9 8273.1 847.3 966.4 1014.2 1018.2 1086.9 25068.6 30288.0 30626.7 30949.9 31053.2 1023.6 1035.6 1036.6 1068.9 1075.8 14041.9 16729.7 16852.5 17079.5 17282.9 717134.0 719445.0 731118.0 732169.0 733100.0 52756.0 53212.2 53252.0 53279.5 53476.5 1318.8 1335.9 1354.6 1364.5 1367.9 29311.7 29410.0 30522.4 31489.7 31965.7 50224.0 50610.5 50625.7 50767.2 50828.5 630081.0 631256.0 637491.0 638053.0 642013.8 25950.0 26114.3 26462.5 26594.1 26595.6 46233.0 47496.8 47770.5 47781.5 48263.0 38616.6 39331.8 39684.6 40854.6 41024.2 39122.0 39313.6 39382.8 40041.8 40475.2 35731.1 38117.6 39057.4 39991.2 41545.4 24907.6 29339.4 33673.7 34372.8 35328.8 22872.7 24118.3 25811.2 26031.7 26043.3 08:05:53 INFO - PROCESS | 1648 | 08:05:53 INFO - PROCESS | 1648 | [#2] jquery.html Cycles:180 Average:36103.84 Median:13578.44 stddev:101506.81 (747.6%) stddev-sans-first:101756.12 08:05:53 INFO - PROCESS | 1648 | Values: 376.8 377.5 384.4 386.5 407.3 18896.5 20466.0 20652.7 20772.9 20791.5 19773.4 20017.1 20082.3 20194.4 20493.3 4721.8 5829.4 6087.2 6536.7 6621.3 6552.7 6755.2 6839.9 6841.5 6860.1 5036.8 6709.9 6724.5 6731.9 6980.8 6441.6 6626.6 6711.8 6724.7 6743.2 5790.7 5792.6 5829.7 5831.0 5894.2 24298.4 24574.1 24684.5 24767.5 24835.1 2280.6 2342.2 2472.4 2488.0 2669.0 14720.9 15193.4 15266.5 15397.3 15558.4 1798.2 1873.4 1896.6 1912.9 1955.1 116638.4 117594.0 125130.7 131986.3 136412.3 11694.8 11797.9 11916.3 11922.9 12084.5 14458.1 14478.0 14537.8 14588.0 14613.6 8598.7 8690.0 8798.3 8806.5 8913.0 8652.7 8766.6 8888.4 8901.7 9378.1 3804.8 4004.7 4060.5 4546.9 4606.4 1719.3 1939.8 1954.7 1967.8 1977.4 854.9 903.8 907.6 961.0 964.7 17558.4 20759.7 21046.5 21209.6 21267.7 862.7 883.3 966.8 969.7 987.9 10505.7 11040.8 11124.4 11136.2 11137.6 600312.0 601904.0 605742.0 607326.0 616970.0 101054.0 135474.3 137744.3 138390.0 138862.6 949.7 990.0 1017.6 1021.4 1026.1 18740.7 19279.5 19490.5 19621.9 19752.9 57507.0 59788.7 60437.0 60777.1 61820.0 84452.0 84617.6 85475.6 85816.0 86452.1 6602.8 8030.6 8125.6 8207.8 8266.5 10698.5 12280.1 12673.0 12684.4 12948.3 10546.6 10833.5 11090.0 11156.3 11170.1 10616.6 10794.3 10850.5 11249.4 11265.9 11046.2 11078.0 11133.7 11424.2 11487.3 8011.4 8208.0 8319.7 8374.5 8461.8 9296.5 9342.3 10088.9 10465.5 10898.2 08:05:53 INFO - PROCESS | 1648 | 08:05:53 INFO - PROCESS | 1648 | [#3] mootools.html Cycles:180 Average:5764.05 Median:4960.68 stddev:3224.89 (65.0%) stddev-sans-first:3216.73 08:05:53 INFO - PROCESS | 1648 | Values: 1331.7 1552.6 1712.6 1739.8 1883.8 8134.0 8395.2 8721.7 9270.9 9284.0 8688.3 9029.0 9034.5 9073.1 9100.7 2044.8 2410.8 2412.2 2414.1 2460.8 2417.3 2436.1 2448.0 2458.3 2458.9 2426.1 2430.6 2442.6 2463.8 2467.1 2410.7 2426.9 2428.7 2441.9 2446.9 2418.2 2431.5 2436.5 2440.6 2444.3 8949.0 8964.3 8986.0 9013.0 9115.7 5362.1 5509.5 5532.4 5535.9 5552.3 3638.5 3671.1 3690.8 3692.2 3751.7 1098.1 1101.8 1103.9 1115.5 1129.5 11062.3 12008.3 12050.8 12098.5 12120.8 4051.8 4504.3 4575.5 4745.1 4765.1 9180.4 9269.6 9272.7 9287.4 9298.5 5362.2 5368.1 5371.9 5386.1 5392.3 4508.5 4644.6 4868.2 4996.7 5027.8 3858.0 3885.9 3972.8 4000.9 4009.7 1000.7 1194.2 1201.7 1205.0 1206.5 785.7 877.7 893.0 925.5 942.1 5917.3 5943.4 6003.1 6156.8 6276.9 810.5 932.6 956.7 975.2 1010.6 3508.5 3886.8 3938.8 3966.9 4031.0 9682.3 10349.3 10616.1 10916.2 10964.2 10786.2 10818.7 10925.2 10965.2 10970.2 7913.2 8205.3 8274.5 8380.2 8400.9 4720.7 5927.9 6046.2 6071.5 6169.1 9868.4 10203.3 10274.4 10358.3 10448.8 9064.6 10169.7 10179.3 10472.4 10565.8 7072.3 7320.6 7497.1 7603.8 7667.2 8006.0 8605.8 8713.2 8723.5 8724.3 7535.5 7555.4 7597.0 7784.0 7792.4 7476.9 7525.5 7548.8 7551.5 7667.6 7098.5 7231.8 7233.1 7253.2 7261.2 4886.7 4904.9 4924.7 5009.6 5066.7 4270.3 5004.1 5058.8 5070.7 5102.9 08:05:53 INFO - PROCESS | 1648 | 08:05:53 INFO - PROCESS | 1648 | [#4] prototype.html Cycles:180 Average:4582.03 Median:5031.77 stddev:1460.83 (29.0%) stddev-sans-first:1429.16 08:05:53 INFO - PROCESS | 1648 | Values: 301.1 303.1 312.1 315.2 315.2 4898.1 5327.9 5519.7 5521.9 5542.0 5336.0 5469.2 5487.5 5495.6 5525.8 3586.1 3983.6 4193.9 4268.6 4293.8 3896.6 3897.4 3933.5 3991.4 4145.7 3173.6 3646.1 4096.4 4123.5 4172.4 3867.0 4160.8 4170.7 4182.5 4197.2 3173.6 3484.7 3620.8 3631.4 3651.6 4003.5 4390.9 4398.8 4402.5 5095.9 4723.3 4756.3 4764.5 4816.7 4817.4 4756.4 5331.3 5336.0 5803.9 5894.4 3459.1 3913.1 3940.8 3942.0 3985.9 5305.4 6069.1 6077.3 6151.7 6210.0 3977.4 4037.3 4045.5 4048.3 4061.9 3509.4 3747.6 3848.5 3851.9 4019.8 3772.1 3791.7 4391.8 4719.1 4746.1 5567.9 5850.2 5896.5 5942.8 5964.7 1283.4 1307.6 1327.7 1344.3 1376.2 780.9 782.0 874.0 913.4 913.7 4306.7 4571.4 4713.9 5005.7 5403.8 4808.8 5659.4 5893.0 5894.4 5963.7 4976.0 5429.3 5455.3 5487.7 5547.3 2416.6 2572.2 2580.6 2639.2 2658.9 4305.3 4814.9 5145.5 5173.9 5177.8 4656.5 4800.0 5113.8 5652.4 6182.9 5218.2 5451.4 5895.7 6088.5 6183.8 5346.6 6075.8 6087.6 6092.3 6109.5 4963.7 5278.5 5528.3 5866.3 5994.2 6268.8 6347.0 6357.3 6361.4 6381.2 3340.5 3681.7 3957.5 4012.3 4029.1 4904.5 5803.5 5920.0 5937.9 5939.4 5067.7 5672.2 5765.5 5806.8 5917.5 5057.8 5827.6 5850.7 5866.2 5878.5 4738.7 4873.5 5359.0 5471.7 5756.7 4895.0 5885.4 5892.9 5940.6 5987.6 5370.6 5782.7 5782.7 5802.8 5832.8 08:05:53 INFO - PROCESS | 1648 | 08:05:53 INFO - PROCESS | 1648 | [#5] yui.html Cycles:180 Average:24698.00 Median:3780.60 stddev:39937.71 (1056.4%) stddev-sans-first:40009.10 08:05:53 INFO - PROCESS | 1648 | Values: 700.6 701.8 753.3 782.0 796.8 13665.2 13806.0 14596.8 15379.7 15458.9 13978.4 13979.7 14016.3 14037.4 14097.7 646.1 659.9 794.6 799.0 814.4 829.2 832.4 833.2 835.3 839.7 805.5 873.0 877.0 880.2 882.8 871.6 873.9 875.0 875.1 875.3 648.0 648.7 650.4 650.7 651.1 14522.8 14672.1 14684.5 14704.6 14717.4 14413.6 14512.6 14605.3 14614.6 14641.3 9675.3 11517.5 11894.1 11927.9 12345.1 3653.0 3676.2 3737.1 3750.4 3841.6 122798.8 123113.4 124610.4 125632.0 127750.4 9544.9 9928.9 10254.9 10615.0 10984.3 20280.9 20389.2 20498.1 20536.7 20547.0 7614.8 7646.6 7695.5 7726.7 8025.0 4433.9 4455.8 4468.7 4469.1 4540.3 3381.4 3483.8 3507.0 3518.8 3810.8 707.3 724.2 733.2 733.2 738.6 599.8 608.6 636.6 662.5 677.8 8625.7 9162.6 9258.4 9311.8 9344.5 601.7 606.9 621.3 642.4 657.1 4223.2 4476.1 4485.6 4505.6 4530.3 97354.0 137500.3 148719.0 159112.0 162152.0 124635.0 134673.7 140077.6 141220.0 142639.0 78732.0 91438.1 98079.0 106040.3 118999.8 8361.3 8603.5 8661.9 8781.3 8796.0 59379.0 60461.0 60838.1 60927.7 62561.7 60274.0 88672.0 91836.0 96480.0 96926.0 12599.2 12968.4 13061.5 13345.7 13460.5 14063.7 14652.4 15230.5 15288.3 15600.1 14134.9 14185.2 14323.7 14341.8 14574.9 11313.0 13679.6 13798.0 13940.8 14149.9 13022.5 13133.3 13573.9 13656.2 13775.7 10315.6 10947.4 11359.4 11408.3 11410.3 11347.5 11629.2 11831.7 11862.4 11905.5 08:05:53 INFO - PROCESS | 1648 | -------- Summary: end -------- 08:05:53 INFO - PROCESS | 1648 | 08:05:53 INFO - TEST-INFO | 1648: exit 0 08:05:53 INFO - TEST-OK | dromaeo_css | took 1114105ms 08:05:53 INFO - TEST-START | kraken 08:05:53 INFO - operating with platform_type : mac_ 08:05:53 INFO - Initialising browser for kraken test... 08:05:53 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/tmpeiKTGX/profile http://localhost:49279/getInfo.html) 08:05:56 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 08:05:56 INFO - PROCESS | 1661 | colorDepth:24 08:05:56 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 08:05:56 INFO - PROCESS | 1661 | __metrics 08:05:56 ERROR - PROCESS | 1661 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 08:05:57 INFO - TEST-INFO | 1661: exit 0 08:05:57 INFO - Browser initialized. 08:05:57 INFO - Running cycle 1/1 for kraken test... 08:05:57 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/tmpeiKTGX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:06:09 INFO - PROCESS | 1663 | RSS: Main: 225243136 08:06:09 INFO - PROCESS | 1663 | 08:06:12 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection) 08:06:13 INFO - PROCESS | 1663 | RSS: Main: 237854720 08:06:13 INFO - PROCESS | 1663 | 08:06:15 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-dft) 08:06:16 INFO - PROCESS | 1663 | RSS: Main: 245391360 08:06:16 INFO - PROCESS | 1663 | 08:06:19 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-fft) 08:06:20 INFO - PROCESS | 1663 | RSS: Main: 247263232 08:06:20 INFO - PROCESS | 1663 | 08:06:22 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator) 08:06:23 INFO - PROCESS | 1663 | RSS: Main: 249483264 08:06:23 INFO - PROCESS | 1663 | 08:06:25 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:06:25 INFO - PROCESS | 1663 | RSS: Main: 250482688 08:06:25 INFO - PROCESS | 1663 | 08:06:28 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom) 08:06:29 INFO - PROCESS | 1663 | RSS: Main: 251269120 08:06:29 INFO - PROCESS | 1663 | 08:06:32 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate) 08:06:33 INFO - PROCESS | 1663 | RSS: Main: 251564032 08:06:33 INFO - PROCESS | 1663 | 08:06:36 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial) 08:06:36 INFO - PROCESS | 1663 | RSS: Main: 251400192 08:06:36 INFO - PROCESS | 1663 | 08:06:38 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:06:39 INFO - PROCESS | 1663 | RSS: Main: 251252736 08:06:39 INFO - PROCESS | 1663 | 08:06:40 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:06:41 INFO - PROCESS | 1663 | RSS: Main: 251285504 08:06:41 INFO - PROCESS | 1663 | 08:06:43 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:06:44 INFO - PROCESS | 1663 | RSS: Main: 251310080 08:06:44 INFO - PROCESS | 1663 | 08:06:47 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:06:47 INFO - PROCESS | 1663 | RSS: Main: 251629568 08:06:47 INFO - PROCESS | 1663 | 08:06:50 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:06:51 INFO - PROCESS | 1663 | RSS: Main: 251723776 08:06:51 INFO - PROCESS | 1663 | 08:06:53 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49279/tests/kraken/driver.html?testName=ai-astar) 08:06:53 INFO - PROCESS | 1663 | RSS: Main: 253456384 08:06:53 INFO - PROCESS | 1663 | 08:06:53 INFO - PROCESS | 1663 | __start_tp_report 08:06:53 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 08:06:53 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 08:06:53 INFO - PROCESS | 1663 | |i|pagename|runs| 08:06:53 INFO - PROCESS | 1663 | |0;ai-astar;105;118;116;117;117;118;120;118;96;172 08:06:53 INFO - PROCESS | 1663 | |1;audio-beat-detection;159;127;141;173;118;112;110;113;158;126 08:06:53 INFO - PROCESS | 1663 | |2;audio-dft;265;182;182;252;274;250;234;282;189;277 08:06:53 INFO - PROCESS | 1663 | |3;audio-fft;83;60;59;83;58;57;60;58;65;85 08:06:53 INFO - PROCESS | 1663 | |4;audio-oscillator;83;71;103;60;92;102;120;99;79;86 08:06:53 INFO - PROCESS | 1663 | |5;imaging-gaussian-blur;78;132;92;88;77;132;93;98;117;88 08:06:53 INFO - PROCESS | 1663 | |6;imaging-darkroom;123;151;154;98;132;150;95;110;154;107 08:06:53 INFO - PROCESS | 1663 | |7;imaging-desaturate;91;96;95;91;95;94;93;94;90;89 08:06:53 INFO - PROCESS | 1663 | |8;json-parse-financial;57;56;58;58;60;62;60;60;60;60 08:06:53 INFO - PROCESS | 1663 | |9;json-stringify-tinderbox;71;72;71;82;76;75;69;71;71;71 08:06:53 INFO - PROCESS | 1663 | |10;stanford-crypto-aes;99;104;84;74;76;71;72;97;73;106 08:06:53 INFO - PROCESS | 1663 | |11;stanford-crypto-ccm;137;138;139;141;141;157;141;180;201;147 08:06:53 INFO - PROCESS | 1663 | |12;stanford-crypto-pbkdf2;164;165;167;229;167;169;162;166;163;162 08:06:53 INFO - PROCESS | 1663 | |13;stanford-crypto-sha256-iterative;67;69;68;69;69;64;65;80;68;59 08:06:53 INFO - PROCESS | 1663 | __end_tp_report 08:06:53 INFO - PROCESS | 1663 | __start_cc_report 08:06:53 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,937 08:06:53 INFO - PROCESS | 1663 | __end_cc_report 08:06:53 INFO - PROCESS | 1663 | __startTimestamp1478621213370__endTimestamp 08:06:53 INFO - PROCESS | 1663 | 08:06:53 INFO - PROCESS | 1663 | ------- Summary: start ------- 08:06:53 INFO - PROCESS | 1663 | Number of tests: 14 08:06:53 INFO - PROCESS | 1663 | 08:06:53 INFO - PROCESS | 1663 | [#0] ai-astar Cycles:10 Average:119.70 Median:118.00 stddev:19.86 (16.8%) stddev-sans-first:20.34 08:06:53 INFO - PROCESS | 1663 | Values: 105.0 118.0 116.0 117.0 117.0 118.0 120.0 118.0 96.0 172.0 08:06:53 INFO - PROCESS | 1663 | 08:06:53 INFO - PROCESS | 1663 | [#1] audio-beat-detection Cycles:10 Average:133.70 Median:134.00 stddev:22.71 (16.9%) stddev-sans-first:22.16 08:06:53 INFO - PROCESS | 1663 | Values: 159.0 127.0 141.0 173.0 118.0 112.0 110.0 113.0 158.0 126.0 08:06:53 INFO - PROCESS | 1663 | 08:06:53 INFO - PROCESS | 1663 | [#2] audio-dft Cycles:10 Average:238.70 Median:258.50 stddev:40.15 (15.5%) stddev-sans-first:41.44 08:06:53 INFO - PROCESS | 1663 | Values: 265.0 182.0 182.0 252.0 274.0 250.0 234.0 282.0 189.0 277.0 08:06:53 INFO - PROCESS | 1663 | 08:06:53 INFO - PROCESS | 1663 | [#3] audio-fft Cycles:10 Average:66.80 Median:62.50 stddev:11.85 (19.0%) stddev-sans-first:11.02 08:06:53 INFO - PROCESS | 1663 | Values: 83.0 60.0 59.0 83.0 58.0 57.0 60.0 58.0 65.0 85.0 08:06:53 INFO - PROCESS | 1663 | 08:06:53 INFO - PROCESS | 1663 | [#4] audio-oscillator Cycles:10 Average:89.50 Median:81.00 stddev:17.46 (21.6%) stddev-sans-first:18.36 08:06:53 INFO - PROCESS | 1663 | Values: 83.0 71.0 103.0 60.0 92.0 102.0 120.0 99.0 79.0 86.0 08:06:53 INFO - PROCESS | 1663 | 08:06:53 INFO - PROCESS | 1663 | [#5] imaging-gaussian-blur Cycles:10 Average:99.50 Median:88.00 stddev:20.42 (23.2%) stddev-sans-first:20.12 08:06:53 INFO - PROCESS | 1663 | Values: 78.0 132.0 92.0 88.0 77.0 132.0 93.0 98.0 117.0 88.0 08:06:53 INFO - PROCESS | 1663 | 08:06:53 INFO - PROCESS | 1663 | [#6] imaging-darkroom Cycles:10 Average:127.40 Median:152.50 stddev:23.94 (15.7%) stddev-sans-first:25.33 08:06:53 INFO - PROCESS | 1663 | Values: 123.0 151.0 154.0 98.0 132.0 150.0 95.0 110.0 154.0 107.0 08:06:53 INFO - PROCESS | 1663 | 08:06:53 INFO - PROCESS | 1663 | [#7] imaging-desaturate Cycles:10 Average:92.80 Median:94.00 stddev:2.39 (2.5%) stddev-sans-first:2.45 08:06:53 INFO - PROCESS | 1663 | Values: 91.0 96.0 95.0 91.0 95.0 94.0 93.0 94.0 90.0 89.0 08:06:53 INFO - PROCESS | 1663 | 08:06:53 INFO - PROCESS | 1663 | [#8] json-parse-financial Cycles:10 Average:59.10 Median:60.00 stddev:1.79 (3.0%) stddev-sans-first:1.73 08:06:53 INFO - PROCESS | 1663 | Values: 57.0 56.0 58.0 58.0 60.0 62.0 60.0 60.0 60.0 60.0 08:06:53 INFO - PROCESS | 1663 | 08:06:53 INFO - PROCESS | 1663 | [#9] json-stringify-tinderbox Cycles:10 Average:72.90 Median:71.50 stddev:3.81 (5.3%) stddev-sans-first:3.98 08:06:53 INFO - PROCESS | 1663 | Values: 71.0 72.0 71.0 82.0 76.0 75.0 69.0 71.0 71.0 71.0 08:06:53 INFO - PROCESS | 1663 | 08:06:53 INFO - PROCESS | 1663 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:75.00 stddev:14.34 (19.1%) stddev-sans-first:14.37 08:06:53 INFO - PROCESS | 1663 | Values: 99.0 104.0 84.0 74.0 76.0 71.0 72.0 97.0 73.0 106.0 08:06:53 INFO - PROCESS | 1663 | 08:06:53 INFO - PROCESS | 1663 | [#11] stanford-crypto-ccm Cycles:10 Average:152.20 Median:144.00 stddev:21.57 (15.0%) stddev-sans-first:22.17 08:06:53 INFO - PROCESS | 1663 | Values: 137.0 138.0 139.0 141.0 141.0 157.0 141.0 180.0 201.0 147.0 08:06:53 INFO - PROCESS | 1663 | 08:06:53 INFO - PROCESS | 1663 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.40 Median:166.50 stddev:20.37 (12.2%) stddev-sans-first:21.43 08:06:53 INFO - PROCESS | 1663 | Values: 164.0 165.0 167.0 229.0 167.0 169.0 162.0 166.0 163.0 162.0 08:06:53 INFO - PROCESS | 1663 | 08:06:53 INFO - PROCESS | 1663 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.50 stddev:5.31 (7.7%) stddev-sans-first:5.62 08:06:53 INFO - PROCESS | 1663 | Values: 67.0 69.0 68.0 69.0 69.0 64.0 65.0 80.0 68.0 59.0 08:06:53 INFO - PROCESS | 1663 | -------- Summary: end -------- 08:06:53 INFO - PROCESS | 1663 | 08:06:54 INFO - TEST-INFO | 1663: exit 0 08:06:54 INFO - TEST-OK | kraken | took 60552ms 08:06:54 INFO - SUITE-END | took 1174s 08:06:54 INFO - Completed test suite (00:19:35) 08:06:54 INFO - javascript benchmark 08:06:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7428.658716114299, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2930.0, 3473.426884564047, 3501.6498350165, 3516.8241587920606, 3522.418800897852, 5918.171455996158, 5996.070609055603, 6010.429009244121, 6036.728347224374, 6037.305709843369, 5877.030290002144, 5922.0, 6011.398860113997, 6013.699315034252, 6029.457348838604, 4459.732416055047, 4487.326900964848, 5410.0, 5466.398696143421, 5514.117741161415, 5466.699331536764, 5498.395176530578, 5499.257600223978, 5510.118381059031, 5528.474794894479, 5361.51746342831, 5416.0, 5488.643238189505, 5507.697076660782, 5544.362398324204, 5427.83716488506, 5429.67421954684, 5451.836444906659, 5462.535684466825, 5492.588055895784, 4538.455385353779, 5375.946240537583, 5400.945990540123, 5411.485908838654, 5457.727113644302, 5794.072948328289, 6041.395860413923, 6067.453929146354, 6090.390960903918, 6106.053561697944, 6201.255849298113, 6267.0, 6275.717592708339, 6277.372262773732, 6305.085762564402, 6317.905231421532, 6319.431251187415, 6355.110284560165, 6359.936400635981, 6364.872702545969, 5958.344582095966, 6053.364396738323, 6057.545684073668, 6059.545534084961, 6081.391860813883, 6325.114483972247, 6372.872542549123, 6403.871922561522, 6418.518611104186, 6429.7749578764515, 6334.809955701337, 6350.079238510482, 6352.8411789704705, 6376.234851817811, 6376.74493020274, 5019.598432125495, 5211.2443695663915, 5233.712145832016, 5708.40061793514, 5716.942365662366, 6287.245530536365, 6352.936470635327, 6365.49076073913, 6367.522435817332, 6386.329435409215, 5318.335208098988, 6004.819855404345, 6333.176687030748, 6348.904766428507, 6351.237851457762, 4948.38145231846, 4976.701397916137, 4998.850034498971, 5056.115179843513, 5064.924026139611, 4501.932471012938, 4548.158590660738, 4555.544445555418, 4582.083583283356, 4587.3807036050375, 5427.728613569306, 5787.102999035156, 6017.518598512109, 6170.10533472644, 6188.659623720649, 6235.875282494325, 6332.430081292614, 6344.206974128234, 6345.270293916166, 6350.7777227796805, 6045.425684559959, 6095.2685677718955, 6129.478994285447, 6141.179174348115, 6144.047672610753, 5563.026470367669, 5573.052581061148, 5584.664920104807, 5586.972065139648, 5610.18652295423, 6460.547761656733, 6465.644389558525, 6496.935030649727, 6508.60948343101, 6537.803865884031, 6263.655498947602, 6273.0, 6282.748690052529, 6318.684065796784, 6320.715567799552, 6477.578957367756, 6480.740770369132, 6486.740530378921, 6500.6424646643, 6515.2833188348295, 6335.366463353628, 6355.841103972438, 6364.236291645032, 6367.299597044414, 6368.649724265025, 5436.891262174813, 6131.938680613137, 6250.9998400255745, 6260.0, 6318.557700960889, 6283.403076707706, 6313.55805093639, 6327.430531252209, 6330.683465826783, 6367.204099487564, 6297.433231009231, 6325.114483972339, 6339.683015849281, 6344.27040890285, 6353.872922541431, 5956.315023772322, 6134.969325153525, 6137.447629713347, 6151.046587778901, 6275.811725648238, 6237.781677641261, 6273.811785646438, 6316.494680425463, 6322.841928951629, 6325.987841945267, 6171.84570385744, 6187.783427580013, 6201.875962480815, 6210.5652604317265, 6229.626222426669], "value": 5829.175034336467, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [477.7778333075119, 499.555395697829, 513.4147072337535, 536.0859734153269, 538.3701069748394, 33483.0, 40816.79591602041, 40950.180996380055, 40966.79516602413, 41066.76799696014, 41187.0, 41592.58407415925, 42108.78945605276, 42164.367534487006, 42295.78852105735, 9755.8048839023, 9778.413295202276, 9779.168770654504, 9804.36271642341, 9809.264305177105, 9669.226461883032, 9765.12113909748, 9780.559874805615, 9788.923218445965, 9817.312788104835, 9778.90221097787, 9797.0, 9807.852882206773, 9810.852837207447, 9832.26258030647, 9702.805943881083, 9728.416295022285, 9774.853377199348, 9790.5594248259, 9791.412515249107, 9624.615015399446, 9659.806803863954, 9724.0, 9746.171575416098, 9746.561404736733, 39565.80217098925, 39816.20367592661, 39910.0, 39975.8001209995, 40020.0, 2910.7816913731554, 3098.2719061020643, 3186.553882456458, 3283.9983804939484, 3357.513160591725, 23159.305220843235, 30231.848840755876, 30459.2385190372, 31086.844565777254, 31704.0, 2776.5279902416437, 3243.3026899216547, 3255.820929848881, 3264.7714659973813, 3369.8146601936883, 503585.0, 508123.0, 512850.0, 514706.0, 515140.0, 61535.76928461495, 61789.0, 61955.69022154951, 62257.688711556155, 62310.688446558386, 30605.0, 34968.12579685528, 35860.0, 36670.0, 36936.26127477489, 14378.35297411619, 17022.914885425493, 17064.573385665208, 17243.56891077708, 17248.137593120293, 12883.742325153444, 13146.145500542434, 13234.205947643171, 13243.940484761197, 13270.137441066492, 19328.68639124066, 19569.0, 19593.8040619592, 19633.0, 19679.40961771149, 8004.83990320202, 8020.518768873886, 8043.0, 8116.8782468263025, 8273.131321211307, 847.3179090831816, 966.4298064142049, 1014.2190513304714, 1018.2363227579316, 1086.8587083679072, 25068.623970640456, 30288.0, 30626.69373306283, 30949.91675291354, 31053.223669408446, 1023.5752162852482, 1035.6064695415694, 1036.6268143468346, 1068.9412082335546, 1075.7525769073156, 14041.85958140426, 16729.749053764204, 16852.494425167264, 17079.48761537156, 17282.913585431994, 717134.0, 719445.0, 731118.0, 732169.0, 733100.0, 52756.0, 53212.201816972774, 53252.0, 53279.46720532823, 53476.46523534715, 1318.775808112623, 1335.886449651771, 1354.634248752851, 1364.5087768403366, 1367.9110857794212, 29311.7068829309, 29409.988764990732, 30522.389552209275, 31489.685103148677, 31965.68034319627, 50224.0, 50610.49389506205, 50625.74687126541, 50767.2384914234, 50828.491715082375, 630081.0, 631256.0, 637491.0, 638053.0, 642013.7899310474, 25950.0, 26114.347141320857, 26462.470750584496, 26594.069207577642, 26595.601065984414, 46233.0, 47496.7625161872, 47770.52229477661, 47781.522184779096, 48263.0, 38616.61383386242, 39331.80334098311, 39684.60315396809, 40854.59145408508, 41024.1795164101, 39122.0, 39313.606863930996, 39382.803085985535, 40041.79979100202, 40475.1904961905, 35731.10672233111, 38117.618823811405, 39057.414138787375, 39991.2001759969, 41545.37681934834, 24907.626385603868, 29339.41321173607, 33673.663263368035, 34372.82813585916, 35328.823355883054, 22872.656910146696, 24118.276451706475, 25811.225663230132, 26031.666749912896, 26043.348916277246], "value": 19857.376894785968, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.75134411288536, 377.46588577163317, 384.39265959783546, 386.4956232117087, 407.26488687918294, 18896.527586810338, 20466.0, 20652.690209646848, 20772.857492837888, 20791.480212994684, 19773.406797796088, 20017.099230534626, 20082.29711960082, 20194.394168174942, 20493.282735104276, 4721.811127554911, 5829.446202610756, 6087.239095113111, 6536.659984703125, 6621.304762999888, 6552.7051282692155, 6755.189377274709, 6839.863202735943, 6841.452683785285, 6860.108185935821, 5036.773345199456, 6709.865802683943, 6724.495662825308, 6731.899021514681, 6980.813261745516, 6441.645709486, 6626.635535045571, 6711.765088221913, 6724.731010759564, 6743.190817101955, 5790.68151251681, 5792.594518383715, 5829.708514574254, 5831.037878750001, 5894.233749612523, 24298.39254018646, 24574.139905103413, 24684.506309873883, 24767.50464990708, 24835.13077042313, 2280.566692328452, 2342.1802369170823, 2472.3819045238693, 2488.0, 2668.9599656005175, 14720.852791472056, 15193.392264309414, 15266.542003739905, 15397.307121179574, 15558.377664893504, 1798.2177752677496, 1873.4286042756953, 1896.6117717299423, 1912.8947907865063, 1955.0517998770586, 116638.41680791542, 117594.0, 125130.74869251282, 131986.3400683, 136412.31793841068, 11694.766104678029, 11797.941010294893, 11916.344601046852, 11922.940385298018, 12084.516619335303, 14458.132512049311, 14478.0, 14537.78193327101, 14588.0, 14613.561593152222, 8598.699045533376, 8689.956550217335, 8798.296136309207, 8806.515641639771, 8913.0, 8652.740417787476, 8766.60550275239, 8888.377813552988, 8901.688440904667, 9378.109079637423, 3804.847806087781, 4004.65960393364, 4060.4924384451942, 4546.88632784183, 4606.355110284563, 1719.2693105430142, 1939.7575303087115, 1954.7067939808858, 1967.7638683358089, 1977.4378241189586, 854.918782715641, 903.8282726281985, 907.5552979040223, 961.0197598449543, 964.71058682395, 17558.38545650896, 20759.68860467094, 21046.47383815417, 21209.575808483743, 21267.680984785242, 862.7023676831483, 883.3198437203317, 966.8114717630135, 969.7453420796676, 987.8715766950394, 10505.684829454976, 11040.834387484194, 11124.443777811077, 11136.220464567565, 11137.610183643534, 600312.0, 601904.0, 605742.0, 607326.0, 616970.0, 101054.0, 135474.32262838623, 137744.31127844297, 138390.0, 138862.61137388498, 949.7245798718294, 990.0, 1017.5624481472889, 1021.4484178543652, 1026.1226651213256, 18740.7188892164, 19279.51801204981, 19490.512737181685, 19621.901890490455, 19752.90123549373, 57507.0, 59788.70105649618, 60437.0, 60777.088343675765, 61820.0, 84452.0, 84617.57691211505, 85475.57262213649, 85816.0, 86452.13547864693, 6602.801915942529, 8030.598470076356, 8125.553094579618, 8207.794805129919, 8266.545340006358, 10698.518566664363, 12280.078994075302, 12673.0, 12684.429200685807, 12948.287844168284, 10546.57813687444, 10833.512491937725, 11090.0, 11156.274842135235, 11170.050545703707, 10616.575336986743, 10794.298370605886, 10850.457477125954, 11249.381284029458, 11265.943670281596, 11046.171537134587, 11078.0, 11133.719622243221, 11424.200305978502, 11487.310761354345, 8011.39914506426, 8208.015038195215, 8319.667213311643, 8374.49753014821, 8461.788455288666, 9296.535173241446, 9342.346035777431, 10088.899111008795, 10465.476726163814, 10898.237123401286], "value": 9864.94884565357, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1331.700367417331, 1552.5575211064845, 1712.5975395781988, 1739.8434140927313, 1883.7959587282878, 8133.959330203355, 8395.244428001479, 8721.738347849567, 9270.907290927096, 9284.025177356372, 8688.304935605152, 9029.0, 9034.503102329369, 9073.09269073094, 9100.681476148337, 2044.8057434543693, 2410.795082417988, 2412.1557454890735, 2414.082648593532, 2460.790832779216, 2417.2748175547267, 2436.0986435019067, 2447.9755202448014, 2458.299384675368, 2458.9262322130276, 2426.1387207541334, 2430.586800243954, 2442.6213936839818, 2463.7659422354845, 2467.1241709193246, 2410.7468715784853, 2426.9271921842374, 2428.6964129483813, 2441.8534887906694, 2446.8654224017673, 2418.22616762636, 2431.477232395026, 2436.4517983453757, 2440.646106314592, 2444.327809852287, 8948.955255223747, 8964.282857371394, 8985.955070224607, 9012.954935225282, 9115.726528204164, 5362.142057270857, 5509.531689806371, 5532.446755324476, 5535.861603459905, 5552.305961754781, 3638.490611314418, 3671.1005803578028, 3690.7785532867847, 3692.187718701908, 3751.718621103428, 1098.132475344477, 1101.7576133250673, 1103.9227254092216, 1115.5091759625739, 1129.5086637312713, 11062.280951738112, 12008.279503229747, 12050.758984820255, 12098.455569499394, 12120.81818772719, 4051.817668204879, 4504.301833215857, 4575.473820510684, 4745.14587374269, 4765.11845308619, 9180.403273787182, 9269.582868770922, 9272.675456358995, 9287.396319239228, 9298.53507324631, 5362.195670649434, 5368.141097424472, 5371.865703357447, 5386.057439947994, 5392.299001129828, 4508.504064552896, 4644.558766917137, 4868.172410690191, 4996.650234483552, 5027.82402615914, 3857.9807100964317, 3885.86399476017, 3972.781497017634, 4000.879973600797, 4009.7393669411395, 1000.6897861662908, 1194.2237545595433, 1201.6815543880878, 1205.048012070472, 1206.5415142246065, 785.658238666182, 877.7147427086222, 892.9910700892908, 925.5279807298326, 942.0955882352881, 5917.319508256605, 5943.435373639497, 6003.099535069687, 6156.78451254204, 6276.874462510816, 810.4934415990007, 932.5616960028775, 956.7416797464646, 975.2100798353357, 1010.6412223660642, 3508.5088087667746, 3886.8250928708276, 3938.8424463021734, 3966.940495892564, 4031.0, 9682.273829462818, 10349.327293725884, 10616.097631701237, 10916.235863489479, 10964.232503724823, 10786.191035672198, 10818.729531761768, 10925.235233533576, 10965.177611679155, 10970.232083754061, 7913.208679132041, 8205.343572514304, 8274.544900030436, 8380.203880631208, 8400.873986890201, 4720.669553131248, 5927.940720592739, 6046.2139921809885, 6071.483923866521, 6169.136320914986, 9868.421052631544, 10203.336783109075, 10274.434906080238, 10358.326708763907, 10448.798388185456, 9064.592093355683, 10169.745756356151, 10179.251602067548, 10472.371657700562, 10565.788684226427, 7072.292770723092, 7320.597367144858, 7497.062867141607, 7603.809904752426, 7667.194944530967, 8006.0, 8605.784855378666, 8713.215810577078, 8723.520206388455, 8724.302055835646, 7535.510191837513, 7555.433342499225, 7597.0, 7783.961080194563, 7792.37660987131, 7476.887846682195, 7525.473216874985, 7548.773536793905, 7551.546907185587, 7667.616619168908, 7098.503104782822, 7231.819204519718, 7233.095863017123, 7253.165885922976, 7261.237570055279, 4886.65793394459, 4904.8773780655765, 4924.704517728947, 5009.624278179078, 5066.695998240118, 4270.252705776415, 5004.149294619996, 5058.822941197041, 5070.746462676778, 5102.948970510248], "value": 4629.272919072932, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.1357404249803, 303.13757360309927, 312.08870099310013, 315.163241593569, 315.2166865339632, 4898.09385263726, 5327.893442131155, 5519.668819870805, 5521.861953451165, 5541.9722901385485, 5336.02567050192, 5469.206964990074, 5487.542848005751, 5495.642783219088, 5525.778968841251, 3586.063525696121, 3983.6414722674954, 4193.888619515831, 4268.566916857392, 4293.828246870122, 3896.610338966109, 3897.395903634927, 3933.4856080408963, 3991.42124391963, 4145.730527515717, 3173.6350319713297, 3646.1404683611286, 4096.406021126935, 4123.525794533622, 4172.374143878427, 3866.969840833585, 4160.83356665733, 4170.749755014709, 4182.477190351206, 4197.244495990736, 3173.6191657001077, 3484.7212223022098, 3620.837062332201, 3631.382664946965, 3651.634836516327, 4003.459532963042, 4390.8902277443, 4398.8020539075815, 4402.471703395581, 5095.923561146586, 4723.338732577442, 4756.28655701644, 4764.546258676784, 4816.7350795706225, 4817.4219093708625, 4756.405449318835, 5331.253624492574, 5336.0, 5803.912941305884, 5894.351621321651, 3459.128922993909, 3913.1391093959282, 3940.8423663053445, 3941.975086477508, 3985.900352491182, 5305.4164041955355, 6069.118573242309, 6077.301110372319, 6151.72317245725, 6209.968950155266, 3977.423273625308, 4037.2934736421007, 4045.4943132108488, 4048.2915489789757, 4061.918761624751, 3509.420945543957, 3747.6065013173225, 3848.499695039627, 3851.8651847185774, 4019.7538762983568, 3772.07624111705, 3791.710818321784, 4391.780410979438, 4719.065183274841, 4746.050789841976, 5567.9420910027775, 5850.23946886902, 5896.498797602166, 5942.762289508458, 5964.671943043174, 1283.4288741510125, 1307.6338625184962, 1327.701267214869, 1344.341272776352, 1376.2293115854952, 780.8828675698691, 781.9804504887423, 874.0036358551257, 913.36064754672, 913.72588223534, 4306.676999225071, 4571.405717256735, 4713.905721885543, 5005.74971251436, 5403.783848646089, 4808.831690890802, 5659.405762394971, 5893.0, 5894.410558944157, 5963.701814909324, 4976.0, 5429.294191755125, 5455.290812194468, 5487.670739755627, 5547.306586676666, 2416.6495858100475, 2572.215474280325, 2580.6258092576472, 2639.1686618715044, 2658.9069382571906, 4305.332673435622, 4814.879628009257, 5145.511176438233, 5173.948260517422, 5177.844664660066, 4656.511066338054, 4800.023985129243, 5113.821016264413, 5652.406497317723, 6182.876342473125, 5218.165093585008, 5451.400345961941, 5895.675737834375, 6088.4824789893355, 6183.752649894044, 5346.625736198429, 6075.817725468243, 6087.57386982907, 6092.329843717099, 6109.511239100772, 4963.677360971526, 5278.5249327560705, 5528.253685752533, 5866.266716660418, 5994.201739478052, 6268.780592679234, 6347.0, 6357.268914074941, 6361.395667411589, 6381.234251889618, 3340.5301667266326, 3681.723870709654, 3957.5053118360206, 4012.2947747207904, 4029.1135950090934, 4904.5340692634145, 5803.535717142534, 5919.970400147971, 5937.882611628929, 5939.4357536034, 5067.695938243717, 5672.177534257592, 5765.4522820332, 5806.796762113306, 5917.520619845039, 5057.797688092435, 5827.562932779973, 5850.736716847837, 5866.2373891393845, 5878.470937615635, 4738.739369334719, 4873.537013983666, 5358.98179345923, 5471.699056551928, 5756.6685492375655, 4895.0, 5885.352611212848, 5892.850894075786, 5940.61386009908, 5987.550933680079, 5370.570354371563, 5782.681952492653, 5782.710864456676, 5802.796902108406, 5832.825015249549], "value": 4115.278060247759, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [700.5691499727666, 701.7649087555669, 753.329536712326, 782.0498094814799, 796.8087658961844, 13665.248411337372, 13805.964552658541, 14596.759275461585, 15379.692406151884, 15458.922705386485, 13978.440862365518, 13979.720405591883, 14016.299185040758, 14037.36831842567, 14097.718045639107, 646.1051443750416, 659.9274079851212, 794.56696100625, 798.9720359787409, 814.4421071565996, 829.2495291760936, 832.4381042796089, 833.2001278772356, 835.2983493865152, 839.6725277141888, 805.5207151744731, 873.0134947509338, 877.0002197494861, 880.216607219575, 882.8101958079012, 871.6252011634995, 873.8558137907238, 874.9650013999433, 875.0767939823484, 875.3259989807813, 647.9902801457935, 648.7080813633836, 650.4308729861372, 650.7169381319142, 651.0754728285846, 14522.782158267635, 14672.11967281956, 14684.486042988445, 14704.558863234013, 14717.411303547846, 14413.639659008608, 14512.564623061326, 14605.269736513132, 14614.561563153122, 14641.34113964874, 9675.322727409084, 11517.539298428053, 11894.107941904393, 11927.94036029823, 12345.13584049117, 3652.9634703653155, 3676.246369494247, 3737.0657335666083, 3750.3811871041244, 3841.615838416164, 122798.77201227963, 123113.38443307726, 124610.37694811559, 125632.0, 127750.36124819316, 9544.856827147598, 9928.900710992797, 10254.897451025543, 10614.991575800286, 10984.340939543654, 20280.89859550693, 20389.18443262253, 20498.077586508643, 20536.691949620767, 20547.0, 7614.771556853303, 7646.579438130956, 7695.461317707706, 7726.690932362755, 8024.996875390576, 4433.889152771207, 4455.754933478625, 4468.709533880287, 4469.061497085649, 4540.341650460665, 3381.3575420670486, 3483.8432270547887, 3507.035565219585, 3518.8416521256604, 3810.8094595270127, 707.2750430808462, 724.1744411371042, 733.2044731466312, 733.230108386203, 738.6343759838807, 599.838043728191, 608.5880756644631, 636.5703150373572, 662.4634046422414, 677.7898851355997, 8625.69810056645, 9162.587683554257, 9258.398204116711, 9311.767205819773, 9344.532773361305, 601.7382438639206, 606.902895536712, 621.254494606474, 642.4474951541671, 657.1260223902199, 4223.176480586256, 4476.1495315890525, 4485.573870482299, 4505.639548836085, 4530.252508336153, 97354.0, 137500.31249843686, 148719.0, 159112.0, 162152.0, 124635.0, 134673.65326346806, 140077.59922400647, 141220.0, 142639.0, 78732.0, 91438.08561914296, 98079.0, 106040.34899127584, 118999.81000189888, 8361.331093512383, 8603.52680602573, 8661.913380866363, 8781.25359344463, 8796.0, 59379.0, 60461.0, 60838.08742868772, 60927.69536152468, 62561.68719156375, 60274.0, 88672.0, 91836.0, 96480.0, 96926.0, 12599.18105323151, 12968.416421261254, 13061.542846000344, 13345.733085338434, 13460.461581536629, 14063.718725625225, 14652.413903443743, 15230.466933657712, 15288.312025959081, 15600.051827414909, 14134.929325353307, 14185.219812909976, 14323.71352572922, 14341.78487322712, 14574.85425145735, 11313.0, 13679.589612311647, 13798.0, 13940.79088813689, 14149.858501414854, 13022.544210952572, 13133.277669728257, 13573.932130339284, 13656.248906310248, 13775.724485510033, 10315.587376504856, 10947.397893115955, 11359.375234362189, 11408.258463199865, 11410.258333208314, 11347.546098156312, 11629.18595698293, 11831.704207394883, 11862.40687965581, 11905.52377904874], "value": 7724.6973775448805, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1577.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 118.0, 116.0, 117.0, 117.0, 118.0, 120.0, 118.0, 96.0, 172.0], "value": 119.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 127.0, 141.0, 173.0, 118.0, 112.0, 110.0, 113.0, 158.0, 126.0], "value": 133.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [265.0, 182.0, 182.0, 252.0, 274.0, 250.0, 234.0, 282.0, 189.0, 277.0], "value": 238.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 60.0, 59.0, 83.0, 58.0, 57.0, 60.0, 58.0, 65.0, 85.0], "value": 66.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 71.0, 103.0, 60.0, 92.0, 102.0, 120.0, 99.0, 79.0, 86.0], "value": 89.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 132.0, 92.0, 88.0, 77.0, 132.0, 93.0, 98.0, 117.0, 88.0], "value": 99.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 151.0, 154.0, 98.0, 132.0, 150.0, 95.0, 110.0, 154.0, 107.0], "value": 127.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 96.0, 95.0, 91.0, 95.0, 94.0, 93.0, 94.0, 90.0, 89.0], "value": 92.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 58.0, 58.0, 60.0, 62.0, 60.0, 60.0, 60.0, 60.0], "value": 59.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 71.0, 82.0, 76.0, 75.0, 69.0, 71.0, 71.0, 71.0], "value": 72.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 104.0, 84.0, 74.0, 76.0, 71.0, 72.0, 97.0, 73.0, 106.0], "value": 85.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 138.0, 139.0, 141.0, 141.0, 157.0, 141.0, 180.0, 201.0, 147.0], "value": 152.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 167.0, 229.0, 167.0, 169.0, 162.0, 166.0, 163.0, 162.0], "value": 171.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 68.0, 69.0, 69.0, 64.0, 65.0, 80.0, 68.0, 59.0], "value": 67.8, "unit": "score"}]}]} 08:06:54 INFO - Return code: 0 08:06:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:06:54 ERROR - # TBPL SUCCESS # 08:06:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:06:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:06:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:06:54 INFO - 2016-11-08 08:06:54.693 screenresolution[1668:10701] starting screenresolution argv=screenresolution get 08:06:54 INFO - 2016-11-08 08:06:54.695 screenresolution[1668:10701] Display 0: 1600x1200x32@60 08:06:54 INFO - 2016-11-08 08:06:54.701 screenresolution[1669:10704] starting screenresolution argv=screenresolution list 08:06:54 INFO - Available Modes on Display 0 08:06:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:06:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:06:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:06:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:06:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:06:54 INFO - Intel Iris: 08:06:54 INFO - Chipset Model: Intel Iris 08:06:54 INFO - Type: GPU 08:06:54 INFO - Bus: Built-In 08:06:54 INFO - VRAM (Dynamic, Max): 1536 MB 08:06:54 INFO - Vendor: Intel (0x8086) 08:06:54 INFO - Device ID: 0x0a2e 08:06:54 INFO - Revision ID: 0x0009 08:06:54 INFO - Displays: 08:06:54 INFO - Display: 08:06:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:06:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:06:54 INFO - Display Serial Number: 1600x1200 60 08:06:54 INFO - Main Display: Yes 08:06:54 INFO - Mirror: Off 08:06:54 INFO - Online: Yes 08:06:54 INFO - Rotation: Supported 08:06:54 INFO - Return code: 0 08:06:54 INFO - Running post-action listener: _resource_record_post_action 08:06:54 INFO - [mozharness: 2016-11-08 16:06:54.939319Z] Finished run-tests step (success) 08:06:54 INFO - Running post-run listener: _resource_record_post_run 08:06:55 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 38913024; Write bytes: 666623488; Read time: 384; Write time: 2138 08:06:55 INFO - TinderboxPrint: CPU usage
54.2% 08:06:55 INFO - TinderboxPrint: I/O read bytes / time
38,913,024 / 384 08:06:55 INFO - TinderboxPrint: I/O write bytes / time
666,623,488 / 2,138 08:06:55 INFO - TinderboxPrint: CPU idle
2,212.2 (45.8%) 08:06:55 INFO - TinderboxPrint: CPU system
976.8 (20.2%) 08:06:55 INFO - TinderboxPrint: CPU user
1,644.7 (34.0%) 08:06:55 INFO - TinderboxPrint: Swap in / out
401,997,824 / 0 08:06:55 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 355574272; Write bytes: 356926976; Read time: 27585; Write time: 734 08:06:55 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 37938176; Write bytes: 299538432; Read time: 368; Write time: 1367 08:06:55 INFO - Running post-run listener: _upload_blobber_files 08:06:55 INFO - Blob upload gear active. 08:06:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:06:55 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 08:06:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:06:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:06:55 INFO - (blobuploader) - INFO - Open directory for files ... 08:06:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:06:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:06:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:06:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:06:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:06:56 INFO - (blobuploader) - INFO - Done attempting. 08:06:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:06:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:06:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:06:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:06:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:06:57 INFO - (blobuploader) - INFO - Done attempting. 08:06:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:06:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:06:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:06:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:06:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:06:59 INFO - (blobuploader) - INFO - Done attempting. 08:06:59 INFO - (blobuploader) - INFO - Iteration through files over. 08:06:59 INFO - Return code: 0 08:06:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:06:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:06:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d70c35e78521de05e29006aee20b6322cfbfa17e23784257b96e9537320426d5e7950c3e5dc00e2bebe71e2f26f4458792432e50c77cbd1d1dfd17867d3de4f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9db770048ad95b7d21ab626313a700e6f9d58be7773af47f61ccd5cf9df7f73f6e11a5259c654a308466b1bd87ee0ff94d35e52277c4337f087f811cc1791290", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a6f73774bf7b598acc2a98988ae52f3fc2857edfa42787e9432801a0b9837bf7db7672dad767dad37ea23f263285c7d186cc14cbad2a797a8d2b04d5bdff7bbd"} 08:06:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:06:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:06:59 INFO - Contents: 08:06:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d70c35e78521de05e29006aee20b6322cfbfa17e23784257b96e9537320426d5e7950c3e5dc00e2bebe71e2f26f4458792432e50c77cbd1d1dfd17867d3de4f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9db770048ad95b7d21ab626313a700e6f9d58be7773af47f61ccd5cf9df7f73f6e11a5259c654a308466b1bd87ee0ff94d35e52277c4337f087f811cc1791290", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a6f73774bf7b598acc2a98988ae52f3fc2857edfa42787e9432801a0b9837bf7db7672dad767dad37ea23f263285c7d186cc14cbad2a797a8d2b04d5bdff7bbd"} 08:06:59 INFO - Running post-run listener: copy_logs_to_upload_dir 08:06:59 INFO - Copying logs to upload dir... 08:06:59 INFO - mkdir: /builds/slave/test/build/upload/logs 08:06:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.591963 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-11-08 08:07:00.057488) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-08 08:07:00.058892) ========= 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.LoXUO3uUXy/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.jbSuBR9QHN/Listeners TMPDIR=/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d70c35e78521de05e29006aee20b6322cfbfa17e23784257b96e9537320426d5e7950c3e5dc00e2bebe71e2f26f4458792432e50c77cbd1d1dfd17867d3de4f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9db770048ad95b7d21ab626313a700e6f9d58be7773af47f61ccd5cf9df7f73f6e11a5259c654a308466b1bd87ee0ff94d35e52277c4337f087f811cc1791290", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a6f73774bf7b598acc2a98988ae52f3fc2857edfa42787e9432801a0b9837bf7db7672dad767dad37ea23f263285c7d186cc14cbad2a797a8d2b04d5bdff7bbd"} build_url:https://queue.taskcluster.net/v1/task/XvVa7nOqSVWPp9QkrsM2mg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011070 build_url: 'https://queue.taskcluster.net/v1/task/XvVa7nOqSVWPp9QkrsM2mg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d70c35e78521de05e29006aee20b6322cfbfa17e23784257b96e9537320426d5e7950c3e5dc00e2bebe71e2f26f4458792432e50c77cbd1d1dfd17867d3de4f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9db770048ad95b7d21ab626313a700e6f9d58be7773af47f61ccd5cf9df7f73f6e11a5259c654a308466b1bd87ee0ff94d35e52277c4337f087f811cc1791290", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a6f73774bf7b598acc2a98988ae52f3fc2857edfa42787e9432801a0b9837bf7db7672dad767dad37ea23f263285c7d186cc14cbad2a797a8d2b04d5bdff7bbd"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-08 08:07:00.099628) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2016-11-08 08:07:00.100013) ========= 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.LoXUO3uUXy/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.jbSuBR9QHN/Listeners TMPDIR=/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005249 ========= master_lag: 2.85 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2016-11-08 08:07:02.951673) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-08 08:07:02.952260) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-08 08:07:02.964621) ========= ========= Total master_lag: 3.01 =========