builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0045 starttime: 1474361470.15 results: success (0) buildid: 20160920004004 builduid: 962ab5660e8f4467a8a41a7e977b6b34 revision: ef0680dc3d4feb015a07b3edefe0b9d2a095bdec ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-20 01:51:10.148744) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-20 01:51:10.149227) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-20 01:51:10.149499) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-20 01:51:10.206296) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 01:51:10.206691) ========= 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.JBo4VhXiJe/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.tZ77qm38mH/Listeners TMPDIR=/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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-09-20 01:51:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 12.5M=0.001s 2016-09-20 01:51:10 (12.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.180323 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 01:51:10.409994) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 01:51:10.410312) ========= 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.JBo4VhXiJe/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.tZ77qm38mH/Listeners TMPDIR=/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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.021036 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 01:51:10.458505) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-20 01:51:10.458852) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ef0680dc3d4feb015a07b3edefe0b9d2a095bdec --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 ef0680dc3d4feb015a07b3edefe0b9d2a095bdec --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.JBo4VhXiJe/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.tZ77qm38mH/Listeners TMPDIR=/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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-09-20 01:51:10,531 truncating revision to first 12 chars 2016-09-20 01:51:10,531 Setting DEBUG logging. 2016-09-20 01:51:10,532 attempt 1/10 2016-09-20 01:51:10,532 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ef0680dc3d4f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-20 01:51:11,295 unpacking tar archive at: mozilla-aurora-ef0680dc3d4f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.042149 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-20 01:51:11.524012) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-20 01:51:11.524327) ========= script_repo_revision: ef0680dc3d4feb015a07b3edefe0b9d2a095bdec ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-20 01:51:11.524746) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-20 01:51:11.525052) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-20 01:51:11.544525) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-09-20 01:51:11.545236) ========= /tools/buildbot/bin/python 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', '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.JBo4VhXiJe/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.tZ77qm38mH/Listeners TMPDIR=/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 01:51:11 INFO - MultiFileLogger online at 20160920 01:51:11 in /builds/slave/test 01:51:11 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 01:51:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:51:11 INFO - {'append_to_log': False, 01:51:11 INFO - 'base_work_dir': '/builds/slave/test', 01:51:11 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 01:51:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:51:11 INFO - 'branch': 'Mozilla-Aurora', 01:51:11 INFO - 'buildbot_json_path': 'buildprops.json', 01:51:11 INFO - 'config_files': ('talos/mac_config.py',), 01:51:11 INFO - 'default_actions': ('clobber', 01:51:11 INFO - 'read-buildbot-config', 01:51:11 INFO - 'download-and-extract', 01:51:11 INFO - 'populate-webroot', 01:51:11 INFO - 'create-virtualenv', 01:51:11 INFO - 'install', 01:51:11 INFO - 'run-tests'), 01:51:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:51:11 INFO - 'download_minidump_stackwalk': True, 01:51:11 INFO - 'download_symbols': 'ondemand', 01:51:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:51:11 INFO - 'tooltool.py': '/tools/tooltool.py', 01:51:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:51:11 INFO - '/tools/misc-python/virtualenv.py')}, 01:51:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:51:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:51:11 INFO - 'installer_path': 'installer.exe', 01:51:11 INFO - 'log_level': 'info', 01:51:11 INFO - 'log_name': 'talos', 01:51:11 INFO - 'log_to_console': True, 01:51:11 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:51:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:51:11 INFO - 'opt_config_files': (), 01:51:11 INFO - 'pip_index': False, 01:51:11 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:51:11 INFO - 'cmd': ('bash', 01:51:11 INFO - '-c', 01:51:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:51:11 INFO - 'enabled': True, 01:51:11 INFO - 'halt_on_failure': False, 01:51:11 INFO - 'name': 'check_screen_resolution'},), 01:51:11 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:51:11 INFO - 'cmd': ('bash', 01:51:11 INFO - '-c', 01:51:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:51:11 INFO - 'enabled': True, 01:51:11 INFO - 'halt_on_failure': False, 01:51:11 INFO - 'name': 'check_screen_resolution'},), 01:51:11 INFO - 'run_cmd_checks_enabled': True, 01:51:11 INFO - 'sps_profile': False, 01:51:11 INFO - 'sps_profile_interval': 0, 01:51:11 INFO - 'suite': 'dromaeojs-e10s', 01:51:11 INFO - 'system_bits': '32', 01:51:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:51:11 INFO - 'title': 't-yosemite-r7-0045', 01:51:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:51:11 INFO - 'use_talos_json': True, 01:51:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:51:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:51:11 INFO - 'work_dir': 'build'} 01:51:11 INFO - [mozharness: 2016-09-20 08:51:11.750875Z] Running clobber step. 01:51:11 INFO - Running pre-action listener: _resource_record_pre_action 01:51:11 INFO - Running main action method: clobber 01:51:11 INFO - rmtree: /builds/slave/test/build 01:51:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:51:12 INFO - Running post-action listener: _resource_record_post_action 01:51:12 INFO - [mozharness: 2016-09-20 08:51:12.263837Z] Finished clobber step (success) 01:51:12 INFO - [mozharness: 2016-09-20 08:51:12.264010Z] Running read-buildbot-config step. 01:51:12 INFO - Running pre-action listener: _resource_record_pre_action 01:51:12 INFO - Running main action method: read_buildbot_config 01:51:12 INFO - Using buildbot properties: 01:51:12 INFO - { 01:51:12 INFO - "project": "", 01:51:12 INFO - "product": "firefox", 01:51:12 INFO - "script_repo_revision": "production", 01:51:12 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 01:51:12 INFO - "repository": "", 01:51:12 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 01:51:12 INFO - "buildid": "20160920004004", 01:51:12 INFO - "stage_platform": "macosx64", 01:51:12 INFO - "basedir": "/builds/slave/test", 01:51:12 INFO - "nightly_build": "True", 01:51:12 INFO - "buildnumber": 397, 01:51:12 INFO - "slavename": "t-yosemite-r7-0045", 01:51:12 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 01:51:12 INFO - "platform": "yosemite_r7", 01:51:12 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 01:51:12 INFO - "branch": "mozilla-aurora", 01:51:12 INFO - "repo_path": "releases/mozilla-aurora", 01:51:12 INFO - "revision": "ef0680dc3d4feb015a07b3edefe0b9d2a095bdec", 01:51:12 INFO - "pgo_build": "False", 01:51:12 INFO - "builduid": "962ab5660e8f4467a8a41a7e977b6b34", 01:51:12 INFO - "slavebuilddir": "test" 01:51:12 INFO - } 01:51:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/DIusKtKnRQi-LImv4L1tiQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 01:51:12 INFO - Running post-action listener: _resource_record_post_action 01:51:12 INFO - [mozharness: 2016-09-20 08:51:12.267915Z] Finished read-buildbot-config step (success) 01:51:12 INFO - [mozharness: 2016-09-20 08:51:12.268052Z] Running download-and-extract step. 01:51:12 INFO - Running pre-action listener: _resource_record_pre_action 01:51:12 INFO - Running main action method: download_and_extract 01:51:12 INFO - mkdir: /builds/slave/test/build/tests 01:51:12 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')]} 01:51:12 INFO - trying https://queue.taskcluster.net/v1/task/DIusKtKnRQi-LImv4L1tiQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 01:51:12 INFO - Downloading https://queue.taskcluster.net/v1/task/DIusKtKnRQi-LImv4L1tiQ/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 01:51:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DIusKtKnRQi-LImv4L1tiQ/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 01:51:13 INFO - Downloaded 1199 bytes. 01:51:13 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 01:51:13 INFO - Using the following test package requirements: 01:51:13 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 01:51:13 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 01:51:13 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 01:51:13 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 01:51:13 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 01:51:13 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 01:51:13 INFO - u'jsshell-mac.zip'], 01:51:13 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 01:51:13 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 01:51:13 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 01:51:13 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 01:51:13 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 01:51:13 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 01:51:13 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 01:51:13 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 01:51:13 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 01:51:13 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 01:51:13 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 01:51:13 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 01:51:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DIusKtKnRQi-LImv4L1tiQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 01:51:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DIusKtKnRQi-LImv4L1tiQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 01:51:13 INFO - Fetch https://queue.taskcluster.net/v1/task/DIusKtKnRQi-LImv4L1tiQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 01:51:13 INFO - Expected file size: 16426177 01:51:20 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 01:51:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DIusKtKnRQi-LImv4L1tiQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 01:51:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DIusKtKnRQi-LImv4L1tiQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 01:51:20 INFO - Fetch https://queue.taskcluster.net/v1/task/DIusKtKnRQi-LImv4L1tiQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 01:51:21 INFO - Expected file size: 16426177 01:51:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DIusKtKnRQi-LImv4L1tiQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 01:51:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DIusKtKnRQi-LImv4L1tiQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 01:51:27 INFO - Fetch https://queue.taskcluster.net/v1/task/DIusKtKnRQi-LImv4L1tiQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 01:51:28 INFO - Expected file size: 14414059 01:51:29 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')]} 01:51:29 INFO - trying https://queue.taskcluster.net/v1/task/DIusKtKnRQi-LImv4L1tiQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 01:51:29 INFO - Downloading https://queue.taskcluster.net/v1/task/DIusKtKnRQi-LImv4L1tiQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 01:51:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DIusKtKnRQi-LImv4L1tiQ/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 01:51:34 INFO - Downloaded 115327070 bytes. 01:51:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DIusKtKnRQi-LImv4L1tiQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 01:51:34 INFO - mkdir: /builds/slave/test/properties 01:51:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:51:34 INFO - Writing to file /builds/slave/test/properties/build_url 01:51:34 INFO - Contents: 01:51:34 INFO - build_url:https://queue.taskcluster.net/v1/task/DIusKtKnRQi-LImv4L1tiQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 01:51:35 INFO - Running post-action listener: _resource_record_post_action 01:51:35 INFO - Running post-action listener: set_extra_try_arguments 01:51:35 INFO - [mozharness: 2016-09-20 08:51:35.522378Z] Finished download-and-extract step (success) 01:51:35 INFO - [mozharness: 2016-09-20 08:51:35.522505Z] Running populate-webroot step. 01:51:35 INFO - Running pre-action listener: _resource_record_pre_action 01:51:35 INFO - Running main action method: populate_webroot 01:51:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:51:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:51:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:51:35 INFO - '--tppagecycles', 01:51:35 INFO - '7'], 01:51:35 INFO - 'tests': ['tsvgm']}}, 01:51:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:51:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:51:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:51:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:51:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:51:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:51:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:51:35 INFO - 'talos_options': ['--disable-e10s'], 01:51:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:51:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:51:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:51:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:51:35 INFO - 'talos_options': ['--disable-e10s'], 01:51:35 INFO - 'tests': ['damp', 'tps']}, 01:51:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:51:35 INFO - 'tests': ['damp', 'tps']}, 01:51:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:51:35 INFO - 'tests': ['dromaeo_dom']}, 01:51:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:51:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:51:35 INFO - 'tests': ['basic_compositor_video']}, 01:51:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:51:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:51:35 INFO - 'tests': ['a11yr', 01:51:35 INFO - 'ts_paint', 01:51:35 INFO - 'tpaint', 01:51:35 INFO - 'sessionrestore', 01:51:35 INFO - 'sessionrestore_no_auto_restore', 01:51:35 INFO - 'tabpaint']}, 01:51:35 INFO - 'other-e10s': {'tests': ['a11yr', 01:51:35 INFO - 'ts_paint', 01:51:35 INFO - 'tpaint', 01:51:35 INFO - 'sessionrestore', 01:51:35 INFO - 'sessionrestore_no_auto_restore', 01:51:35 INFO - 'tabpaint']}, 01:51:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:51:35 INFO - 'ts_paint', 01:51:35 INFO - 'tpaint', 01:51:35 INFO - 'sessionrestore', 01:51:35 INFO - 'sessionrestore_no_auto_restore', 01:51:35 INFO - 'tabpaint']}, 01:51:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:51:35 INFO - 'ts_paint', 01:51:35 INFO - 'tpaint', 01:51:35 INFO - 'sessionrestore', 01:51:35 INFO - 'sessionrestore_no_auto_restore', 01:51:35 INFO - 'tabpaint']}, 01:51:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:51:35 INFO - 'tests': ['a11yr', 01:51:35 INFO - 'ts_paint', 01:51:35 INFO - 'tpaint', 01:51:35 INFO - 'sessionrestore', 01:51:35 INFO - 'sessionrestore_no_auto_restore', 01:51:35 INFO - 'tabpaint']}, 01:51:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:51:35 INFO - 'tests': ['a11yr', 01:51:35 INFO - 'ts_paint', 01:51:35 INFO - 'tpaint', 01:51:35 INFO - 'sessionrestore', 01:51:35 INFO - 'sessionrestore_no_auto_restore', 01:51:35 INFO - 'tabpaint']}, 01:51:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:51:35 INFO - 'tests': ['tsvgx', 01:51:35 INFO - 'tsvgr_opacity', 01:51:35 INFO - 'tart', 01:51:35 INFO - 'tscrollx', 01:51:35 INFO - 'cart']}, 01:51:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:51:35 INFO - 'tsvgr_opacity', 01:51:35 INFO - 'tart', 01:51:35 INFO - 'tscrollx', 01:51:35 INFO - 'cart']}, 01:51:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:51:35 INFO - 'talos_options': ['--disable-e10s'], 01:51:35 INFO - 'tests': ['tp5o']}, 01:51:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:51:35 INFO - 'tests': ['tp5o']}, 01:51:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:51:35 INFO - 'talos_options': ['--disable-e10s', 01:51:35 INFO - '--xperf_path', 01:51:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:51:35 INFO - 'tests': ['tp5n']}, 01:51:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:51:35 INFO - 'talos_options': ['--xperf_path', 01:51:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:51:35 INFO - 'tests': ['tp5n']}}, 01:51:35 INFO - 'talos.zip': {'path': '', 01:51:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:51:35 INFO - Running post-action listener: _resource_record_post_action 01:51:35 INFO - [mozharness: 2016-09-20 08:51:35.541261Z] Finished populate-webroot step (success) 01:51:35 INFO - [mozharness: 2016-09-20 08:51:35.541390Z] Running create-virtualenv step. 01:51:35 INFO - Running pre-action listener: _resource_record_pre_action 01:51:35 INFO - Running main action method: create_virtualenv 01:51:35 INFO - Creating virtualenv /builds/slave/test/build/venv 01:51:35 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 01:51:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:51:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:51:35 INFO - Using real prefix '/tools/python27' 01:51:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:51:36 INFO - Installing distribute.............................................................................................................................................................................................done. 01:51:39 INFO - Installing pip.................done. 01:51:39 INFO - Return code: 0 01:51:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:51:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:51:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:51:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:51:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:51:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c813490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c789570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6c858ee80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c627d30>, '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 0x10c48ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c61fb20>, '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.JBo4VhXiJe/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.tZ77qm38mH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 01:51:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:51:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:51:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JBo4VhXiJe/Render', 01:51:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:51:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:51:39 INFO - 'HOME': '/Users/cltbld', 01:51:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:51:39 INFO - 'LOGNAME': 'cltbld', 01:51:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:51:39 INFO - 'MOZ_NO_REMOTE': '1', 01:51:39 INFO - 'NO_EM_RESTART': '1', 01:51:39 INFO - 'PAGER': '/bin/cat', 01:51:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:51:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:51:39 INFO - 'PWD': '/builds/slave/test', 01:51:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:51:39 INFO - 'SHELL': '/bin/bash', 01:51:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tZ77qm38mH/Listeners', 01:51:39 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 01:51:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:51:39 INFO - 'USER': 'cltbld', 01:51:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:51:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:51:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:51:39 INFO - 'XPC_FLAGS': '0x0', 01:51:39 INFO - 'XPC_SERVICE_NAME': '0', 01:51:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:51:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:51:39 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 01:51:39 INFO - Cleaning up... 01:51:39 INFO - Return code: 0 01:51:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:51:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:51:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:51:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:51:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:51:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c813490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c789570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6c858ee80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c627d30>, '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 0x10c48ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c61fb20>, '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.JBo4VhXiJe/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.tZ77qm38mH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 01:51:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:51:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:51:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JBo4VhXiJe/Render', 01:51:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:51:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:51:39 INFO - 'HOME': '/Users/cltbld', 01:51:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:51:39 INFO - 'LOGNAME': 'cltbld', 01:51:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:51:39 INFO - 'MOZ_NO_REMOTE': '1', 01:51:39 INFO - 'NO_EM_RESTART': '1', 01:51:39 INFO - 'PAGER': '/bin/cat', 01:51:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:51:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:51:39 INFO - 'PWD': '/builds/slave/test', 01:51:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:51:39 INFO - 'SHELL': '/bin/bash', 01:51:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tZ77qm38mH/Listeners', 01:51:39 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 01:51:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:51:39 INFO - 'USER': 'cltbld', 01:51:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:51:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:51:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:51:39 INFO - 'XPC_FLAGS': '0x0', 01:51:39 INFO - 'XPC_SERVICE_NAME': '0', 01:51:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:51:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:51:39 INFO - Downloading/unpacking psutil>=3.1.1 01:51:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:51:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:51:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:51:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:51:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:51:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:51:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:51:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:51:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:51:43 INFO - Installing collected packages: psutil 01:51:43 INFO - Running setup.py install for psutil 01:51:43 INFO - building 'psutil._psutil_osx' extension 01:51:43 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 01:51:43 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 01:51:43 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 01:51:43 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 01:51:43 INFO - building 'psutil._psutil_posix' extension 01:51:43 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 01:51:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:51:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:51:43 INFO - ^ 01:51:43 INFO - 1 warning generated. 01:51:43 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 01:51:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:51:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:51:43 INFO - Successfully installed psutil 01:51:43 INFO - Cleaning up... 01:51:44 INFO - Return code: 0 01:51:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:51:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:51:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:51:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:51:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:51:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c813490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c789570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6c858ee80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c627d30>, '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 0x10c48ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c61fb20>, '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.JBo4VhXiJe/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.tZ77qm38mH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 01:51:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:51:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 01:51:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JBo4VhXiJe/Render', 01:51:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:51:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:51:44 INFO - 'HOME': '/Users/cltbld', 01:51:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:51:44 INFO - 'LOGNAME': 'cltbld', 01:51:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:51:44 INFO - 'MOZ_NO_REMOTE': '1', 01:51:44 INFO - 'NO_EM_RESTART': '1', 01:51:44 INFO - 'PAGER': '/bin/cat', 01:51:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:51:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:51:44 INFO - 'PWD': '/builds/slave/test', 01:51:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:51:44 INFO - 'SHELL': '/bin/bash', 01:51:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tZ77qm38mH/Listeners', 01:51:44 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 01:51:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:51:44 INFO - 'USER': 'cltbld', 01:51:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:51:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:51:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:51:44 INFO - 'XPC_FLAGS': '0x0', 01:51:44 INFO - 'XPC_SERVICE_NAME': '0', 01:51:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:51:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:51:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:51:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:51:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:51:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:51:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:51:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:51:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:51:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:51:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:51:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:51:46 INFO - Installing collected packages: mozsystemmonitor 01:51:46 INFO - Running setup.py install for mozsystemmonitor 01:51:47 INFO - Successfully installed mozsystemmonitor 01:51:47 INFO - Cleaning up... 01:51:47 INFO - Return code: 0 01:51:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:51:47 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')]} 01:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:51:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:47 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')]} 01:51:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:51:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:47 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 0x10c813490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c789570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6c858ee80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c627d30>, '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 0x10c48ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c61fb20>, '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.JBo4VhXiJe/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.tZ77qm38mH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 01:51:47 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 01:51:47 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 01:51:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JBo4VhXiJe/Render', 01:51:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:51:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:51:47 INFO - 'HOME': '/Users/cltbld', 01:51:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:51:47 INFO - 'LOGNAME': 'cltbld', 01:51:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:51:47 INFO - 'MOZ_NO_REMOTE': '1', 01:51:47 INFO - 'NO_EM_RESTART': '1', 01:51:47 INFO - 'PAGER': '/bin/cat', 01:51:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:51:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:51:47 INFO - 'PWD': '/builds/slave/test', 01:51:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:51:47 INFO - 'SHELL': '/bin/bash', 01:51:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tZ77qm38mH/Listeners', 01:51:47 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 01:51:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:51:47 INFO - 'USER': 'cltbld', 01:51:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:51:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:51:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:51:47 INFO - 'XPC_FLAGS': '0x0', 01:51:47 INFO - 'XPC_SERVICE_NAME': '0', 01:51:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:51:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:51:47 INFO - Downloading/unpacking jsonschema==2.5.1 01:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:51:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:51:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:51:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:51:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:51:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:51:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:51:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:51:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:51:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:51:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:51:50 INFO - Downloading functools32-3.2.3-2.tar.gz 01:51:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:51:50 INFO - warning: no files found matching '*.txt' 01:51:50 INFO - no previously-included directories found matching 'build' 01:51:50 INFO - no previously-included directories found matching 'dist' 01:51:50 INFO - no previously-included directories found matching '.git*' 01:51:50 INFO - Installing collected packages: jsonschema, functools32 01:51:50 INFO - Running setup.py install for functools32 01:51:50 INFO - warning: no files found matching '*.txt' 01:51:50 INFO - no previously-included directories found matching 'build' 01:51:50 INFO - no previously-included directories found matching 'dist' 01:51:50 INFO - no previously-included directories found matching '.git*' 01:51:50 INFO - Successfully installed jsonschema functools32 01:51:50 INFO - Cleaning up... 01:51:50 INFO - Return code: 0 01:51:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:51:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:51:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:51:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:51:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:50 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 0x10c813490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c789570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6c858ee80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c627d30>, '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 0x10c48ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c61fb20>, '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.JBo4VhXiJe/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.tZ77qm38mH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 01:51:50 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 01:51:50 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 01:51:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JBo4VhXiJe/Render', 01:51:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:51:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:51:50 INFO - 'HOME': '/Users/cltbld', 01:51:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:51:50 INFO - 'LOGNAME': 'cltbld', 01:51:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:51:50 INFO - 'MOZ_NO_REMOTE': '1', 01:51:50 INFO - 'NO_EM_RESTART': '1', 01:51:50 INFO - 'PAGER': '/bin/cat', 01:51:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:51:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:51:50 INFO - 'PWD': '/builds/slave/test', 01:51:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:51:50 INFO - 'SHELL': '/bin/bash', 01:51:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tZ77qm38mH/Listeners', 01:51:50 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 01:51:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:51:50 INFO - 'USER': 'cltbld', 01:51:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:51:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:51:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:51:50 INFO - 'XPC_FLAGS': '0x0', 01:51:50 INFO - 'XPC_SERVICE_NAME': '0', 01:51:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:51:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:51:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:51:50 INFO - Cleaning up... 01:51:50 INFO - Return code: 0 01:51:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:51:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:51:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:51:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:51:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:50 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 0x10c813490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c789570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6c858ee80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c627d30>, '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 0x10c48ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c61fb20>, '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.JBo4VhXiJe/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.tZ77qm38mH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 01:51:50 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 01:51:50 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 01:51:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JBo4VhXiJe/Render', 01:51:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:51:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:51:50 INFO - 'HOME': '/Users/cltbld', 01:51:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:51:50 INFO - 'LOGNAME': 'cltbld', 01:51:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:51:50 INFO - 'MOZ_NO_REMOTE': '1', 01:51:50 INFO - 'NO_EM_RESTART': '1', 01:51:50 INFO - 'PAGER': '/bin/cat', 01:51:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:51:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:51:50 INFO - 'PWD': '/builds/slave/test', 01:51:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:51:50 INFO - 'SHELL': '/bin/bash', 01:51:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tZ77qm38mH/Listeners', 01:51:50 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 01:51:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:51:50 INFO - 'USER': 'cltbld', 01:51:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:51:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:51:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:51:50 INFO - 'XPC_FLAGS': '0x0', 01:51:50 INFO - 'XPC_SERVICE_NAME': '0', 01:51:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:51:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:51:51 INFO - Downloading/unpacking blobuploader==1.2.4 01:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:51:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:51:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:51:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:51:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:51:53 INFO - Downloading blobuploader-1.2.4.tar.gz 01:51:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:51:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:51:53 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 01:51:53 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 01:51:53 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 01:51:53 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 01:51:53 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 01:51:53 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 01:51:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:51:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:51:54 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 01:51:54 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 01:51:54 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 01:51:54 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 01:51:54 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 01:51:54 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 01:51:54 INFO - Downloading docopt-0.6.1.tar.gz 01:51:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:51:54 INFO - Installing collected packages: blobuploader, requests, docopt 01:51:54 INFO - Running setup.py install for blobuploader 01:51:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:51:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:51:54 INFO - Running setup.py install for requests 01:51:55 INFO - Running setup.py install for docopt 01:51:55 INFO - Successfully installed blobuploader requests docopt 01:51:55 INFO - Cleaning up... 01:51:55 INFO - Return code: 0 01:51:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:51:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:51:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:51:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:51:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:51:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:55 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 0x10c813490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c789570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6c858ee80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c627d30>, '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 0x10c48ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c61fb20>, '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.JBo4VhXiJe/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.tZ77qm38mH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 01:51:55 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 01:51:55 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 01:51:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JBo4VhXiJe/Render', 01:51:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:51:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:51:55 INFO - 'HOME': '/Users/cltbld', 01:51:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:51:55 INFO - 'LOGNAME': 'cltbld', 01:51:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:51:55 INFO - 'MOZ_NO_REMOTE': '1', 01:51:55 INFO - 'NO_EM_RESTART': '1', 01:51:55 INFO - 'PAGER': '/bin/cat', 01:51:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:51:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:51:55 INFO - 'PWD': '/builds/slave/test', 01:51:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:51:55 INFO - 'SHELL': '/bin/bash', 01:51:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tZ77qm38mH/Listeners', 01:51:55 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 01:51:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:51:55 INFO - 'USER': 'cltbld', 01:51:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:51:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:51:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:51:55 INFO - 'XPC_FLAGS': '0x0', 01:51:55 INFO - 'XPC_SERVICE_NAME': '0', 01:51:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:51:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:51:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:51:56 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-J1hlNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:51:56 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-JI2lin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:51:56 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-Kaq5lB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:51:56 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-p0LXhp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:51:56 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-9M5ti2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:51:56 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-WbXDxn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:51:56 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-kE5h2F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:51:56 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-ooyw_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:51:56 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-bha408-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:51:56 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-ZG1W9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:51:57 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-SinVNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:51:57 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-AxRjq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:51:57 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-nqkXOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:51:57 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-MTBUxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:51:57 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-OpXLTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:51:57 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-I9wUfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:51:57 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-ml_N5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:51:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:51:57 INFO - Running setup.py install for manifestparser 01:51:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:51:57 INFO - Running setup.py install for mozcrash 01:51:58 INFO - Running setup.py install for mozdebug 01:51:58 INFO - Running setup.py install for mozdevice 01:51:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:51:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:51:58 INFO - Running setup.py install for mozfile 01:51:58 INFO - Running setup.py install for mozhttpd 01:51:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:51:58 INFO - Running setup.py install for mozinfo 01:51:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:51:58 INFO - Running setup.py install for mozInstall 01:51:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:51:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:51:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:51:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:51:58 INFO - Running setup.py install for mozleak 01:51:59 INFO - Running setup.py install for mozlog 01:51:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:51:59 INFO - Running setup.py install for moznetwork 01:51:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:51:59 INFO - Running setup.py install for mozprocess 01:51:59 INFO - Running setup.py install for mozprofile 01:51:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:51:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:51:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:51:59 INFO - Running setup.py install for mozrunner 01:51:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:51:59 INFO - Running setup.py install for mozscreenshot 01:52:00 INFO - Running setup.py install for moztest 01:52:00 INFO - Running setup.py install for mozversion 01:52:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:52:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:52:00 INFO - Cleaning up... 01:52:00 INFO - Return code: 0 01:52:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:52:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:52:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:52:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:00 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 0x10c813490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c789570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6c858ee80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c627d30>, '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 0x10c48ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c61fb20>, '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.JBo4VhXiJe/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.tZ77qm38mH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 01:52:00 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 01:52:00 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 01:52:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JBo4VhXiJe/Render', 01:52:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:52:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:52:00 INFO - 'HOME': '/Users/cltbld', 01:52:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:52:00 INFO - 'LOGNAME': 'cltbld', 01:52:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:00 INFO - 'MOZ_NO_REMOTE': '1', 01:52:00 INFO - 'NO_EM_RESTART': '1', 01:52:00 INFO - 'PAGER': '/bin/cat', 01:52:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:52:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:52:00 INFO - 'PWD': '/builds/slave/test', 01:52:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:52:00 INFO - 'SHELL': '/bin/bash', 01:52:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tZ77qm38mH/Listeners', 01:52:00 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 01:52:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:52:00 INFO - 'USER': 'cltbld', 01:52:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:52:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:52:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:00 INFO - 'XPC_FLAGS': '0x0', 01:52:00 INFO - 'XPC_SERVICE_NAME': '0', 01:52:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:52:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:52:00 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-Qc9dFM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:52:00 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)) 01:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:52:00 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-TqGEO1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:52:00 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)) 01:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:52:00 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-9dzNIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:52:00 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)) 01:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:52:00 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-gTeyoO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:52:01 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)) 01:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:52:01 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-47lH8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:52:01 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)) 01:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:52:01 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-ULa3bQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:52:01 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)) 01:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:52:01 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-ealZtn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:52:01 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)) 01:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:52:01 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-IOmvA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:52:01 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)) 01:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:52:01 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-awORoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:52:01 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)) 01:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:52:01 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-UpGgcT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:52:01 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)) 01:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:52:01 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-ZgUQdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:52:01 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)) 01:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:52:01 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-LGKzEb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:52:01 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)) 01:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:52:01 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-q9hmLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:52:02 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)) 01:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:52:02 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-zgrecO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:52:02 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)) 01:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:52:02 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-8v5j1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:52:02 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)) 01:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:52:02 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-3TYum5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:52:02 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)) 01:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:52:02 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-qeH5W_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:52:02 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)) 01:52:02 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)) 01:52:02 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)) 01:52:02 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)) 01:52:02 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)) 01:52:02 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)) 01:52:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:52:02 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 01:52:02 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 01:52:02 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 01:52:02 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 01:52:02 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 01:52:02 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 01:52:04 INFO - Downloading blessings-1.6.tar.gz 01:52:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:52:04 INFO - Installing collected packages: blessings 01:52:05 INFO - Running setup.py install for blessings 01:52:05 INFO - Successfully installed blessings 01:52:05 INFO - Cleaning up... 01:52:05 INFO - Return code: 0 01:52:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:52:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:52:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:52:05 INFO - Reading from file tmpfile_stdout 01:52:05 INFO - Current package versions: 01:52:05 INFO - blessings == 1.6 01:52:05 INFO - blobuploader == 1.2.4 01:52:05 INFO - docopt == 0.6.1 01:52:05 INFO - functools32 == 3.2.3-2 01:52:05 INFO - jsonschema == 2.5.1 01:52:05 INFO - manifestparser == 1.1 01:52:05 INFO - mozInstall == 1.12 01:52:05 INFO - mozcrash == 0.17 01:52:05 INFO - mozdebug == 0.1 01:52:05 INFO - mozdevice == 0.48 01:52:05 INFO - mozfile == 1.2 01:52:05 INFO - mozhttpd == 0.7 01:52:05 INFO - mozinfo == 0.9 01:52:05 INFO - mozleak == 0.1 01:52:05 INFO - mozlog == 3.4 01:52:05 INFO - moznetwork == 0.27 01:52:05 INFO - mozprocess == 0.23 01:52:05 INFO - mozprofile == 0.28 01:52:05 INFO - mozrunner == 6.12 01:52:05 INFO - mozscreenshot == 0.1 01:52:05 INFO - mozsystemmonitor == 0.3 01:52:05 INFO - moztest == 0.7 01:52:05 INFO - mozversion == 1.4 01:52:05 INFO - psutil == 3.1.1 01:52:05 INFO - requests == 1.2.3 01:52:05 INFO - wsgiref == 0.1.2 01:52:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:52:05 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')]} 01:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:05 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')]} 01:52:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:05 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 0x10c813490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c789570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6c858ee80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c627d30>, '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 0x10c48ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c61fb20>, '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.JBo4VhXiJe/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.tZ77qm38mH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 01:52:05 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 01:52:05 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 01:52:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JBo4VhXiJe/Render', 01:52:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:52:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:52:05 INFO - 'HOME': '/Users/cltbld', 01:52:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:52:05 INFO - 'LOGNAME': 'cltbld', 01:52:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:05 INFO - 'MOZ_NO_REMOTE': '1', 01:52:05 INFO - 'NO_EM_RESTART': '1', 01:52:05 INFO - 'PAGER': '/bin/cat', 01:52:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:52:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:52:05 INFO - 'PWD': '/builds/slave/test', 01:52:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:52:05 INFO - 'SHELL': '/bin/bash', 01:52:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tZ77qm38mH/Listeners', 01:52:05 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 01:52:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:52:05 INFO - 'USER': 'cltbld', 01:52:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:52:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:52:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:05 INFO - 'XPC_FLAGS': '0x0', 01:52:05 INFO - 'XPC_SERVICE_NAME': '0', 01:52:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:52:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:05 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)) 01:52:05 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)) 01:52:05 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)) 01:52:05 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)) 01:52:05 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)) 01:52:05 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)) 01:52:05 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)) 01:52:05 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)) 01:52:05 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)) 01:52:05 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)) 01:52:05 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)) 01:52:05 INFO - Cleaning up... 01:52:05 INFO - Return code: 0 01:52:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:52:05 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')]} 01:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:05 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')]} 01:52:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:05 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 0x10c813490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c789570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6c858ee80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c627d30>, '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 0x10c48ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c61fb20>, '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.JBo4VhXiJe/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.tZ77qm38mH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 01:52:05 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 01:52:05 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 01:52:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JBo4VhXiJe/Render', 01:52:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:52:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:52:05 INFO - 'HOME': '/Users/cltbld', 01:52:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:52:05 INFO - 'LOGNAME': 'cltbld', 01:52:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:05 INFO - 'MOZ_NO_REMOTE': '1', 01:52:05 INFO - 'NO_EM_RESTART': '1', 01:52:05 INFO - 'PAGER': '/bin/cat', 01:52:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:52:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:52:05 INFO - 'PWD': '/builds/slave/test', 01:52:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:52:05 INFO - 'SHELL': '/bin/bash', 01:52:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tZ77qm38mH/Listeners', 01:52:05 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 01:52:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:52:05 INFO - 'USER': 'cltbld', 01:52:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:52:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:52:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:05 INFO - 'XPC_FLAGS': '0x0', 01:52:05 INFO - 'XPC_SERVICE_NAME': '0', 01:52:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:52:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:52:06 INFO - Cleaning up... 01:52:06 INFO - Return code: 0 01:52:06 INFO - Running post-action listener: _resource_record_post_action 01:52:06 INFO - Running post-action listener: _start_resource_monitoring 01:52:06 INFO - Starting resource monitoring. 01:52:06 INFO - [mozharness: 2016-09-20 08:52:06.088813Z] Finished create-virtualenv step (success) 01:52:06 INFO - [mozharness: 2016-09-20 08:52:06.089824Z] Running install step. 01:52:06 INFO - Running pre-action listener: _resource_record_pre_action 01:52:06 INFO - Running main action method: install 01:52:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:52:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:52:06 INFO - Reading from file tmpfile_stdout 01:52:06 INFO - Detecting whether we're running mozinstall >=1.0... 01:52:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:52:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:52:06 INFO - Reading from file tmpfile_stdout 01:52:06 INFO - Output received: 01:52:06 INFO - Usage: mozinstall [options] installer 01:52:06 INFO - Options: 01:52:06 INFO - -h, --help show this help message and exit 01:52:06 INFO - -d DEST, --destination=DEST 01:52:06 INFO - Directory to install application into. [default: 01:52:06 INFO - "/builds/slave/test"] 01:52:06 INFO - --app=APP Application being installed. [default: firefox] 01:52:06 INFO - mkdir: /builds/slave/test/build/application 01:52:06 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'] 01:52:06 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 01:52:38 INFO - Reading from file tmpfile_stdout 01:52:38 INFO - Output received: 01:52:38 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 01:52:38 INFO - Running post-action listener: _resource_record_post_action 01:52:38 INFO - [mozharness: 2016-09-20 08:52:38.961079Z] Finished install step (success) 01:52:38 INFO - [mozharness: 2016-09-20 08:52:38.961215Z] Running run-tests step. 01:52:38 INFO - Running pre-action listener: _resource_record_pre_action 01:52:38 INFO - Running main action method: run_tests 01:52:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:52:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:52:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:52:38 INFO - 2016-09-20 01:52:38.974 screenresolution[6732:113587] starting screenresolution argv=screenresolution get 01:52:38 INFO - 2016-09-20 01:52:38.977 screenresolution[6732:113587] Display 0: 1600x1200x32@60 01:52:38 INFO - 2016-09-20 01:52:38.983 screenresolution[6733:113592] starting screenresolution argv=screenresolution list 01:52:38 INFO - Available Modes on Display 0 01:52:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:52:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:52:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:52:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:52:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:52:39 INFO - Intel Iris: 01:52:39 INFO - Chipset Model: Intel Iris 01:52:39 INFO - Type: GPU 01:52:39 INFO - Bus: Built-In 01:52:39 INFO - VRAM (Dynamic, Max): 1536 MB 01:52:39 INFO - Vendor: Intel (0x8086) 01:52:39 INFO - Device ID: 0x0a2e 01:52:39 INFO - Revision ID: 0x0009 01:52:39 INFO - Displays: 01:52:39 INFO - Display: 01:52:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:52:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:52:39 INFO - Display Serial Number: 1600x1200 60 01:52:39 INFO - Main Display: Yes 01:52:39 INFO - Mirror: Off 01:52:39 INFO - Online: Yes 01:52:39 INFO - Rotation: Supported 01:52:39 INFO - Return code: 0 01:52:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:52:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:52:39 INFO - Python 2.7.3 01:52:39 INFO - Return code: 0 01:52:39 INFO - grabbing minidump binary from tooltool 01:52:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:52:39 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 0x10c627d30>, '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 0x10c48ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c61fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:52:39 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 01:52:39 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 01:52:39 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 01:52:39 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:52:39 INFO - Return code: 0 01:52:39 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:52:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:52:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:52:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:52:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:52:39 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/DIusKtKnRQi-LImv4L1tiQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0045', '--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 01:52:39 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/DIusKtKnRQi-LImv4L1tiQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0045 --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 01:52:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JBo4VhXiJe/Render', 01:52:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:52:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:52:39 INFO - 'HOME': '/Users/cltbld', 01:52:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:52:39 INFO - 'LOGNAME': 'cltbld', 01:52:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:52:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:52:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:39 INFO - 'MOZ_NO_REMOTE': '1', 01:52:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:52:39 INFO - 'NO_EM_RESTART': '1', 01:52:39 INFO - 'PAGER': '/bin/cat', 01:52:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:52:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:52:39 INFO - 'PWD': '/builds/slave/test', 01:52:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:52:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:52:39 INFO - 'SHELL': '/bin/bash', 01:52:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tZ77qm38mH/Listeners', 01:52:39 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 01:52:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:52:39 INFO - 'USER': 'cltbld', 01:52:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:52:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:52:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:39 INFO - 'XPC_FLAGS': '0x0', 01:52:39 INFO - 'XPC_SERVICE_NAME': '0', 01:52:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:52:39 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/DIusKtKnRQi-LImv4L1tiQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0045', '--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 01:52:39 INFO - mozversion application_buildid: 20160920004004 01:52:39 INFO - mozversion application_changeset: ef0680dc3d4feb015a07b3edefe0b9d2a095bdec 01:52:39 INFO - mozversion application_display_name: FirefoxDeveloperEdition 01:52:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:52:39 INFO - mozversion application_name: Firefox 01:52:39 INFO - mozversion application_remotingname: firefox-dev 01:52:39 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:52:39 INFO - mozversion application_vendor: Mozilla 01:52:39 INFO - mozversion application_version: 51.0a2 01:52:39 INFO - mozversion platform_buildid: 20160920004004 01:52:39 INFO - mozversion platform_changeset: ef0680dc3d4feb015a07b3edefe0b9d2a095bdec 01:52:39 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:52:39 INFO - mozversion platform_version: 51.0a2 01:52:39 INFO - using testdate: 1474361559 01:52:39 INFO - actual date: 1474361559 01:52:39 INFO - starting webserver on 'localhost:57658' 01:52:39 INFO - SUITE-START | Running 2 tests 01:52:39 INFO - TEST-START | dromaeo_css 01:52:39 INFO - operating with platform_type : mac_ 01:52:39 INFO - Initialising browser for dromaeo_css test... 01:52:39 INFO - TEST-INFO | started process 6743 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/tmpOYdW4h/profile http://localhost:57658/getInfo.html) 01:52:42 INFO - PROCESS | 6743 | __metrics Screen width/height:1600/1200 01:52:42 INFO - PROCESS | 6743 | colorDepth:24 01:52:42 INFO - PROCESS | 6743 | Browser inner width/height: 1024/689 01:52:42 INFO - PROCESS | 6743 | __metrics 01:52:42 ERROR - PROCESS | 6743 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 01:52:43 INFO - TEST-INFO | 6743: exit 0 01:52:43 INFO - Browser initialized. 01:52:43 INFO - Running cycle 1/1 for dromaeo_css test... 01:52:43 INFO - TEST-INFO | started process 6747 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/tmpOYdW4h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:52:55 INFO - PROCESS | 6747 | RSS: Main: 224837632 01:52:55 INFO - PROCESS | 6747 | 01:53:45 INFO - PROCESS | 6747 | 1474361625170 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] 01:55:56 INFO - PROCESS | 6747 | Cycle 1(1): loaded http://localhost:57658/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57658/tests/dromaeo/cssquery-ext.html) 01:55:58 INFO - PROCESS | 6747 | RSS: Main: 236433408 01:55:58 INFO - PROCESS | 6747 | 01:59:00 INFO - PROCESS | 6747 | Cycle 1(1): loaded http://localhost:57658/tests/dromaeo/cssquery-ext.html (next: http://localhost:57658/tests/dromaeo/cssquery-jquery.html) 01:59:00 INFO - PROCESS | 6747 | RSS: Main: 246657024 01:59:00 INFO - PROCESS | 6747 | 02:02:02 INFO - PROCESS | 6747 | Cycle 1(1): loaded http://localhost:57658/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57658/tests/dromaeo/cssquery-mootools.html) 02:02:03 INFO - PROCESS | 6747 | RSS: Main: 250650624 02:02:03 INFO - PROCESS | 6747 | 02:05:05 INFO - PROCESS | 6747 | Cycle 1(1): loaded http://localhost:57658/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57658/tests/dromaeo/cssquery-prototype.html) 02:05:05 INFO - PROCESS | 6747 | RSS: Main: 251342848 02:05:05 INFO - PROCESS | 6747 | 02:08:08 INFO - PROCESS | 6747 | Cycle 1(1): loaded http://localhost:57658/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57658/tests/dromaeo/cssquery-yui.html) 02:08:09 INFO - PROCESS | 6747 | RSS: Main: 255864832 02:08:09 INFO - PROCESS | 6747 | 02:11:11 INFO - PROCESS | 6747 | Cycle 1(1): loaded http://localhost:57658/tests/dromaeo/cssquery-yui.html (next: http://localhost:57658/tests/dromaeo/cssquery-dojo.html) 02:11:12 INFO - PROCESS | 6747 | RSS: Main: 257363968 02:11:12 INFO - PROCESS | 6747 | 02:11:12 INFO - PROCESS | 6747 | __start_tp_report 02:11:12 INFO - PROCESS | 6747 | _x_x_mozilla_page_load 02:11:12 INFO - PROCESS | 6747 | _x_x_mozilla_page_load_details 02:11:12 INFO - PROCESS | 6747 | |i|pagename|runs| 02:11:12 INFO - PROCESS | 6747 | |0;dojo.html;3331.583552055993;3344.732421406288;3360.823711700905;3370.4438767603347;3408.182036311285;5738.081906894898;5739.081746920494;5821.446962538552;5866.88266234675;5890.911636325459;5773.56698247631;5849.795257166;5898.557608179393;5913.438223368784;5920.082387229975;5220.451852555484;5286;5300.151975683892;5341.492558206984;5345.037893179227;4607.516210797869;5340.652857564246;5345.224942383352;5345.33183352081;5385;5204.479552044784;5206.661566998152;5316.707581083039;5337.626366154371;5378.058839703056;5013.699178049311;5211.478852114796;5270.130428479335;5318.202269659543;5386;5187.325647665779;5258.6318957672975;5263.4473380295285;5274.918641678447;5286.022085914118;5612.831615051555;5788.42115788422;5789;5795.362510123883;5956;6087.4521293083835;6153.969230153821;6159.260888693386;6205.844853878689;6248.250209974786;6236.719347629368;6259.906101408483;6264.968675156595;6265.906011409833;6272.40412160844;5882.705864706748;5892.322382926019;5897.705114744245;5920.200772895647;5953;6140.933729673037;6175.228096487939;6183.505319574423;6200.0699895015205;6212.968935155295;6151.0773383992755;6180.505559555225;6198.535109866688;6207.472364848948;6217.564770466114;6189.535784816157;6266.655333956676;6275.592086514362;6289.371062893674;6296.905546416808;6080.939190608037;6130.887362651087;6152.661603611844;6153.784617538365;6215.502759779207;6252.656103914328;6261.96869015652;6263.279722831841;6265.404786545271;6274.152989346379;4976.925346119811;4985.177445721415;4991.126552853309;4994.001199760062;5004.724740139327;4339.4792624884585;4348.586884245991;4379.321205213197;4432.3351497275025;4471.418715566955;5762.971185144047;5856.355800861902;5919.615225010447;5921.200637913913;5942.3166335871065;6236.532260080512;6240.375962403723;6248.156498872685;6257.874842503215;6271.592346497463;5668.2064510967675;5730.08318669011;5817.854553636193;5842.38654941225;5870.677112758839;4469.865904022885;4669.533046695304;4804.447488538863;5452.509274165344;5484.067708489566;6298.244210694655;6317.147185130132;6333.714982825784;6336.20797400325;6336.493080553637;6110.649890384107;6172.166757487861;6174.475169610454;6248.593841400476;6251.156093927261;6249.6562689052535;6320.873582528416;6323.557350985387;6343.143675603735;6343.302236754045;6214.782482613087;6246.406591373812;6271.278802937538;6282.963311053625;6293.905591416041;6113.871604717183;6150.630962142107;6152.384761523812;6261.123442717932;6270;6035.758569657164;6081.057436097412;6169.383061693795;6190.164327815867;6197.566170368212;6115.3578874217565;6120.7543792481;6169.660668663267;6176.320604733386;6183.628982261079;5804.65172089676;5910.379410161871;5919.141724449844;6022.759089636541;6055.2430946131735;6124.869201255597;6127.479164271087;6131.264248290234;6175;6205.906911396423;5997.910031349446;6071.180390647206;6073.848153796191;6080.969595151996;6095.725692343766 02:11:12 INFO - PROCESS | 6747 | |1;ext.html;461.8660588429358;470.7834396177758;472.8865072382628;520.0690763533275;522.8901930594576;40212.59787402125;42217;42283.154336913285;42376.78811605941;42410;43720.78139609306;44147;44171.337429938496;44187.116257674825;44192.3371149433;9671.274654400913;9837.163841073518;9884;9887.406755594651;9891.505424728735;9782.510874456284;9880.950595247014;9882.357646752975;9883.258755593324;9901.801963960717;9825.263105267099;9859.112679858812;9892.604295828158;9902.356346837469;9903.900960990406;9839.950800245988;9874.80250394988;9875.851862222073;9894.90105098947;9897.90102098977;9742.902570974271;9791.461469619167;9796.069373409515;9819.705408837746;9836.163926066292;41160.1767964639;41194;41394.37908431376;41465.792671036754;41601.79199103985;3352.9664703352896;3372.392969265531;3427.3488037272837;3508.1405055761247;3508.2106526031694;28646.713532864615;30379.544306835414;31235;31900.042998710076;32053.83973080143;3121.82829944353;3279.672032796725;3300.240944582735;3300.5544251525976;3306.123877172551;491098;492313;495233;495903.9999999964;497495;63628.36371636224;63913;64321.67839160774;64373.71252574922;64425.67787161128;34914.127146821025;35315.646843531234;35409.64590354115;36846.63153368486;67105.66447167733;16856.662866742598;16913;17012.91493542549;17034.48896533106;17072.317107315816;12962;13085.934570327088;13089.214647121204;13098.934505327412;13116.885064769602;19688.310909118398;19925.501862453264;19961.500962475762;19995.400137995883;20031.198752050048;6622.86754264912;7694.384449244047;7787.260210280015;7799.713047347238;7881.408894332948;830.754927296449;851.7359618518155;941.4398432932394;1007.3082153905852;1044.8432735089646;29747.85126074356;30739.8463007688;30812;30982.380352393277;31302.843485782425;950.8240975419432;1009.5103874620803;1045.6563316138725;1092.6667366453307;1133.4729350851894;15583.84416155824;16076.839231607768;16102.677946441005;16107.838921610868;16368.345266189219;588997;664152;677287;679353.2064679388;680450.597747018;47164.292535611996;50681;56848;58288;58394.41605583975;1338.8125662407272;1354.2686949047404;1373.8420081690533;1379.1035826712516;1382.1223523062927;24904.62643060319;29912.551311729905;30098.946536871103;30350.54474182845;30372.84813575918;52231.477685222664;52394;52575.47424525706;52590.73704631453;52695.94608107893;614336;620348;620765;622130;625540;27119.1864244073;27448.451030979668;27496.450070998868;27517.31206719848;27579.172624821287;47735.761321193175;48255.75872120617;48281.03437931152;49529.752351238014;49763.75118124386;32971;38394.23211535809;39702.00744981399;40521.594784051784;40795.59204407918;33482.66517334893;36040;39421.60578394294;39730.60269397269;40593.797031014656;38930.416043759935;40330.79834600926;40537.98655033648;40871.59128408797;41293.793531032155;32200.033998980067;35672.28655426825;35822;35833.82083089568;35926.461103083995;26341.73658263393;26421.867890660425;26519.469610608066;26603.866980664974;27133.72866271312 02:11:12 INFO - PROCESS | 6747 | |2;jquery.html;360.82680313449544;368.3075817463167;375.7332294071209;379.66779068315225;391.2527073290017;18770.343037993654;19982.900085499572;20685;20755.584888302226;20937.581248375023;11622.883771162285;11694.824577631322;17967.73048404275;19825.107870145843;20500.17999280027;5238.05714971305;5355.839324820242;5465.562754979592;5560.165975103747;5727.026405511073;5597.272354593897;6148.754049838001;6220.191375121228;6222.813315600517;6229.6573688447115;5942.732577034022;6159.722812473449;6165.660888651122;6178.783742569011;6179.69101544921;6097.756089756404;6140.171076904606;6206.255249370082;6214.440700336969;6218.253809542839;5234.319538460014;5412.512873841373;5427.104527752956;5446.863828404282;5485.314335708036;20877;24242.66665333406;25516.979320827144;25594.48811023769;25778.09776657808;2216.3240211735415;2382.559226543095;2399.8440101393353;2564.5896656534865;3024.9546256806166;8174.959125204396;9880.209583233323;10377.636782712645;10387.84418233727;10415.94792026035;1875.8311751942254;1946.698261769428;1948.2499237793552;1951.4145756273203;1997.530580313625;104681.42977855339;114693;130093.34953325173;132325.33837330848;135349.3232533841;9176.49529275883;9423.34036617444;9564;11567.537298507965;11672.70818229551;14576.19830909289;14597.92701036488;14648.340824662915;14650.63373415673;14660.340284687214;7133.322334378226;8348.499090054616;8693.391462597683;8740.169683880022;8808.20726134651;7465;8435.746927592181;8614.396992210484;8617.827643447095;8720.43317184381;4069.877903662895;4261.190373828963;4501.257292546693;4542.9772851136195;4562.361269422284;1647.3163637090472;1902.581432084939;1940.8544359173118;1959.549303660166;1992.3923203422805;835.9540225287546;875.9605817738217;916.1434059154711;975.6390135649855;1024.687470321559;20363.287284944956;20713.482162945744;21627.78372216289;21951.341459756233;22346.66480002801;414.1179288116293;419.83626385709596;442.18833653903556;442.7255101836882;898.3873946266336;5611.0741727615305;5883.764649413975;6151.6001459904965;6154.5384096192965;6236.594621349598;616610;637869;647685;658950;662016;79159;81115;118736.40631796786;132119.3394033043;135989.32005340108;430.5307215135517;434.4092034832625;449.1981812464735;450.794888325811;454.51140024473824;10752.83870741955;10996.725081873017;11077.335359878432;11215.990560849563;11221.541199643994;38033.43774315216;42485.78757106195;54498.727506362215;56413.05054160733;58247.70876145592;69865;75913;80127;82582.58708706658;83326;8108.3513318933165;8110.918890811016;8281.337493000425;8291.543965081979;8376.246137847624;12033;13019.674508137372;13048.739025219253;13058.412371443497;13183.209007459584;10945.890541094486;10959.397233152253;11270.985611295022;11366.602168924048;11493.080553555863;10920.2901811382;11031.669049928514;11179.60871369498;11430.485628146587;11482.368469734245;10110.545025474019;10994.185959316623;11289.322640641587;11297.039751621205;11648.708782280171;7993.8401231976195;8179.550124743197;8288.419810613199;8291.875621865556;8339.708110216114;9223.538823058687;11070.778584428106;11095.11239100886;11251.268667536584;11281.548738050715 02:11:12 INFO - PROCESS | 6747 | |3;mootools.html;1526.0462211118047;1545.443640289496;1756.903370314633;1886.9150888210029;1889.5370634194624;8042.91957080429;8320;8547.615357308921;9101.544922753868;9117.726468205949;8553;8894;8894.510801905893;8949.507777072258;8999.865002024959;1929.8131649035881;2022.423609271358;2262.3665373695308;2385.415573184568;2418.22616762636;1861.8231268029583;2379.7382287948312;2396.400899775056;2421.2010036687852;2428.3564855313357;2402.903883844644;2407.205622144688;2421.055788242587;2435.695538057743;2437.549053425113;2056.352249041562;2164.7011792924277;2388.7252965908883;2389.414593424605;2402.699662542182;2000.469875482998;2361.114582031738;2402.3633737059695;2402.5675378431874;2408.9156879509133;8039.31665808407;8638.568071596457;8918.955405222932;9021.503817290046;9026.774330641787;4646.581807637329;5272.499112584298;5411.269478620415;5432.511074003359;5441.83674489766;3557.3596752584526;3609.458581212839;3735.383661695817;3739.1026153723183;3744.4383342498572;1070.1331921143899;1092.5247517329988;1105.5301496863801;1123.0061395664814;1123.1464087293716;11772.587959421464;11818.468168932419;11893.881061189364;11895.88104118965;11941;4707.152712511781;4759.113820185202;4768.856934291907;4885.316055752198;4900.901981960341;10160.593576256866;10193.898061019443;10224.28430009907;10235.334703244265;10239.692809215736;5341.946580534222;5382.407935127133;5418.997485465202;5422.91865622016;5453.972730136324;4403.647708183337;4683.344331793552;4897.289892965571;4910.263460480956;4997.625178111656;3982;4015.3374693175883;4071.246819338432;4105.97947010263;4152.792360381969;1311.0560396514495;1317.1306937421448;1322.6098301001227;1324.543032653733;1334.3061607963805;896.0188593490118;909.963106930557;918.5131880103556;932.664240873285;941.1670671455811;5868.031774757117;6059.757609695563;6092.025275955826;6126.142340072393;6250.74520090615;938.3197182042965;945.3146468810195;985.5515740338129;1003.3177439341318;1011.6155860773007;3924.5682974872743;3927.626875446828;4096.713230073866;4115.538983660757;4165.854195103157;10536.841947370796;10892.910708929043;10910.836337454944;10924.235303528836;10949.233553651167;10050.899491004997;10676.839847402296;10713.982171693677;10769.892301077045;10813.729656758644;7906.802329941683;8137.674493020331;8253.009638843258;8256.215659512336;8290.212429819157;5911.852203694942;5939.346671866005;5993.820185394445;6044.939550604614;6117.449429551361;9568.138867501959;9785.461799601091;10009.349392289478;10095.54570044335;10142.695719128438;10234.744131396774;10239.180865530889;10256.282060255711;10277.126444252022;10289.588416463557;6147.508199343953;6834.624095674587;7063.858722825412;8298.253157215879;8400.285975692135;7229.313215244543;8404.957975210085;8459.534725589905;8502.617382217692;8614.569271536524;7452.850942981218;7498.362639175732;7593.392528597588;7611.847763044819;7711.575863327571;7324.08448943882;7362.5214361066355;7385.224551422023;7454.850902982019;7498.887516687363;6997.405220556309;7130.714771409085;7132.85734285301;7140.7143714252925;7156.212816590067;5075.365579302587;5075.949240507548;5093.719845408538;5108.489151084862;5153.40735815371;5170.1727723564045;5188.22176673502;5213.061648903082;5238.816641417532;5292.52367286946 02:11:12 INFO - PROCESS | 6747 | |4;prototype.html;291.5975953184605;298.5894395206591;302.2670025188918;310.96890310968905;316.7545152506807;5398.514133727964;5482.890342193154;5583.83248502545;5659.415363698161;5682.289713785772;4262.509811371693;5472.452754724525;5480.575050486872;5481.616286859921;5507.504324610784;3615.511905892697;4101.753894766323;4189.999999999993;4201.873943781691;4210.115875666113;3307.834608269577;3468.618451970281;3996.42051902474;4114.436514124628;4250.744955302676;3261.5596894419305;3829.8893320936895;3924.95988563031;3937.803109844511;4167.249895018896;4167.979160104211;4174.686898482611;4175.582441755831;4215.641670458015;4216.62050415461;3658.487811706363;3667.523221981152;3674.393725035366;3683.852645894161;3697.3899306614376;4505.977470112629;4944.431390390115;5119.462456442057;5466.829239041386;5467.906418716273;4821.590164835993;4823.421189457253;4828.95171048292;4834;4841.2722203902795;5852.209951656514;5896.764129434818;5899.764009439617;5910.261217347832;5940.702964851784;3703.8518459261595;3909.9218015639813;3920.4511368408444;3931.017245688578;3942.6254505821903;4845.854624361275;6131.14164017038;6141;6210;6221.44463884029;3571.3035957988463;4028.2749105160765;4030.3475575014104;4036.273470775289;4046.6964977626794;3745.045013521589;3812.5424949006297;3922.431247469101;4036.6972477064337;4085.7140000200293;4411.823527058882;4775.331453596499;4814.975925120352;4826.806927722922;4848.224284114595;4852.902941941212;5235.502627250406;5673.716314184357;5893.823185304448;5931.614445061144;1287.3434548380394;1298.0848501806204;1346.299924039494;1362.6457121148574;1377.6831328794433;791.8337149198618;866.5017614871474;905.9954700226457;930.0559931669361;935.5228833294932;5457.645253058538;5464.398916119224;5469.960707465569;5495.670259784426;5507.394186639466;5065.366829146356;5532.6680399176175;5979.5814292999075;6038.365971573009;6040.244969378828;4770.570648641639;5249.349078715224;5440.510354068153;5467.976848566056;5479.890402192013;2314.537092581457;2582.5609646360163;2601.5187190369843;2623.1737002844043;2673.639058727047;4392.626626736763;5123.410807757081;5164.32863727713;5199.870003249949;5205.661631993984;4389.200427824577;5147.1507201312115;5375.381831089475;6041.969790151021;6044.486218671462;6357.650329231844;6372.355472478869;6377.904331435032;6385.361463853577;6418.807435776934;5129.384473863011;5912.629801013381;6209.0996805462055;6230.193243959382;6267.749290028348;5322.787088516416;5993.3706960768495;6079.270487541523;6080.169493219243;6133.26400831903;5014.398272207359;5293.708846013506;5797;6341.619502829845;6398.104265402754;3914.9021274468364;3984.900377490586;4021.3967904814513;4038.2529232092156;4055.3308704063497;5351.678899266057;6114.57197996136;6164.445199932027;6176.3514830943905;6181.660008699385;5782.335031471266;5894.793682221101;6004.028006136816;6006.909896351645;6065.363136870565;4607.6313894889;5548.361938377138;5638.379778224474;5853.248972982691;6030.185924900258;4792.7363994980615;4961.950380496149;5836.299644042742;5862.325832529314;5875.383084776208;5221.608379371486;5522.337319521683;5967.850803729942;6006.369331220334;6048.758049678139;5490.972545137249;5821.27234095738;5870.8258348329655;5887.143920731927;5891.558133139946 02:11:12 INFO - PROCESS | 6747 | |5;yui.html;757.5909009135067;758.9962050189745;789.5736302396705;792.7502836606465;827.8492894876122;15034.398624055038;15072.849271507283;15552.922235388807;15588.844111558881;15593.922030389833;14108.717825643482;14190;14214.431422743104;14214.644633884158;14228.71542569148;826.7395770332356;863.4905405810571;890.0165317324361;892.6340200517789;898;853.8889944307232;869.1569177897429;870.1037930931151;871.1114663043692;872.7469033980138;926.6061923682441;933.6778811310121;934.6915517879117;935.9064093590621;936.6534382278567;874.1520724896872;883.6421249394006;916.5875356089787;927.3601215161517;927.6984979881565;671.6171782084214;687.3298533929429;688.9758858439981;689.152342618582;689.1557841643996;12467.625971220878;15448.227588620524;15477;15493.380264789395;15503.922480387639;10302.536385862653;12124.211926224856;13405.46378144873;14012.509562165376;14410.567682969528;11598.478068486855;11650;11984.940075299655;12082.577109801203;12387.75224495505;3784.5080139581955;3796.3925771876366;3817.1220619257724;3826.4834247376525;3875.1280961783655;87667;112153.43923280331;115391;116310;117127;9243.676471323472;10613.416262105504;10995.780084398268;11022.834657480144;11324.886751132548;20713.171473141207;20833.06251218699;20904.581908361746;20967.47581310449;20989.37031889046;7806.92193078062;7928.405369597303;7969.800754981055;8118.675252989814;8175.468594541336;4471.35165401015;4519.728816270968;4543.363929049936;4568.017876156642;4668.883277918079;3479.8434070466888;3557.5553055868018;3599.9820000899826;3617.656322649344;3632.636736326346;645.6481217736344;657.4575974820792;659.8779225843234;674.4132604634;674.7604600366898;581.982540523785;602.6083046020123;633.3595986395259;634.1122428599905;667.1660424469413;8531.189536993976;8635.611397487128;8806.823863522694;8934.910650893538;9308;502.59038883309984;598.7904233518234;609.2445367743966;616.1035693066577;622.5455417545218;3628.927421451609;4021.678265738734;4158.8336466541605;4483.103379324149;4560.95439045612;94364;96876;97358;153477.46522534854;168463;105667.4716626412;110349.79300414107;115168.12079698074;119054.40472797581;135358;73800.63099684467;101316.97366052784;109929.45035274772;117045.24432133525;118777.40611296888;7137.52352127117;7788.065432148179;8265.380096492667;8475.533845638549;8605.784855378666;66243.33756662371;66818.66590667015;67033;67967.32032679609;68615.76420577016;90308;100727;102767;103931;104646.47676761568;10816.513256903616;11197.432359469518;11315;11338.263012904135;11585.942070289595;12090.818637720266;12108.515659373526;12207.572734954234;12295.385230738606;12375.195612285173;11658.70853228676;11666.76666466649;11684.357360344922;11786.882131178578;11797.115216358636;11296.548138074386;11423.371714555778;11562.421878906189;11781.941090294493;11931.940340298243;10694.304870183412;11258.155638326994;11340.489677964346;11530.365829879438;11768.235064720766;8942.910570894208;9021.188093071392;9101.40840845343;9304.860427093463;9360.531973401166;7916.129225785044;8107.554084525408;8139.959300203461;8241.423100383156;8391.496510209407 02:11:12 INFO - PROCESS | 6747 | __end_tp_report 02:11:12 INFO - PROCESS | 6747 | __start_cc_report 02:11:12 INFO - PROCESS | 6747 | _x_x_mozilla_cycle_collect,361 02:11:12 INFO - PROCESS | 6747 | __end_cc_report 02:11:12 INFO - PROCESS | 6747 | __startTimestamp1474362672086__endTimestamp 02:11:12 INFO - PROCESS | 6747 | 02:11:12 INFO - PROCESS | 6747 | ------- Summary: start ------- 02:11:12 INFO - PROCESS | 6747 | Number of tests: 6 02:11:12 INFO - PROCESS | 6747 | 02:11:12 INFO - PROCESS | 6747 | [#0] dojo.html Cycles:165 Average:5773.21 Median:6071.18 stddev:653.13 (10.8%) stddev-sans-first:626.42 02:11:12 INFO - PROCESS | 6747 | Values: 3331.6 3344.7 3360.8 3370.4 3408.2 5738.1 5739.1 5821.4 5866.9 5890.9 5773.6 5849.8 5898.6 5913.4 5920.1 5220.5 5286.0 5300.2 5341.5 5345.0 4607.5 5340.7 5345.2 5345.3 5385.0 5204.5 5206.7 5316.7 5337.6 5378.1 5013.7 5211.5 5270.1 5318.2 5386.0 5187.3 5258.6 5263.4 5274.9 5286.0 5612.8 5788.4 5789.0 5795.4 5956.0 6087.5 6154.0 6159.3 6205.8 6248.3 6236.7 6259.9 6265.0 6265.9 6272.4 5882.7 5892.3 5897.7 5920.2 5953.0 6140.9 6175.2 6183.5 6200.1 6213.0 6151.1 6180.5 6198.5 6207.5 6217.6 6189.5 6266.7 6275.6 6289.4 6296.9 6080.9 6130.9 6152.7 6153.8 6215.5 6252.7 6262.0 6263.3 6265.4 6274.2 4976.9 4985.2 4991.1 4994.0 5004.7 4339.5 4348.6 4379.3 4432.3 4471.4 5763.0 5856.4 5919.6 5921.2 5942.3 6236.5 6240.4 6248.2 6257.9 6271.6 5668.2 5730.1 5817.9 5842.4 5870.7 4469.9 4669.5 4804.4 5452.5 5484.1 6298.2 6317.1 6333.7 6336.2 6336.5 6110.6 6172.2 6174.5 6248.6 6251.2 6249.7 6320.9 6323.6 6343.1 6343.3 6214.8 6246.4 6271.3 6283.0 6293.9 6113.9 6150.6 6152.4 6261.1 6270.0 6035.8 6081.1 6169.4 6190.2 6197.6 6115.4 6120.8 6169.7 6176.3 6183.6 5804.7 5910.4 5919.1 6022.8 6055.2 6124.9 6127.5 6131.3 6175.0 6205.9 5997.9 6071.2 6073.8 6081.0 6095.7 02:11:12 INFO - PROCESS | 6747 | 02:11:12 INFO - PROCESS | 6747 | [#1] ext.html Cycles:180 Average:71996.11 Median:41177.09 stddev:159302.34 (386.9%) stddev-sans-first:159658.69 02:11:12 INFO - PROCESS | 6747 | Values: 461.9 470.8 472.9 520.1 522.9 40212.6 42217.0 42283.2 42376.8 42410.0 43720.8 44147.0 44171.3 44187.1 44192.3 9671.3 9837.2 9884.0 9887.4 9891.5 9782.5 9881.0 9882.4 9883.3 9901.8 9825.3 9859.1 9892.6 9902.4 9903.9 9840.0 9874.8 9875.9 9894.9 9897.9 9742.9 9791.5 9796.1 9819.7 9836.2 41160.2 41194.0 41394.4 41465.8 41601.8 3353.0 3372.4 3427.3 3508.1 3508.2 28646.7 30379.5 31235.0 31900.0 32053.8 3121.8 3279.7 3300.2 3300.6 3306.1 491098.0 492313.0 495233.0 495904.0 497495.0 63628.4 63913.0 64321.7 64373.7 64425.7 34914.1 35315.6 35409.6 36846.6 67105.7 16856.7 16913.0 17012.9 17034.5 17072.3 12962.0 13085.9 13089.2 13098.9 13116.9 19688.3 19925.5 19961.5 19995.4 20031.2 6622.9 7694.4 7787.3 7799.7 7881.4 830.8 851.7 941.4 1007.3 1044.8 29747.9 30739.8 30812.0 30982.4 31302.8 950.8 1009.5 1045.7 1092.7 1133.5 15583.8 16076.8 16102.7 16107.8 16368.3 588997.0 664152.0 677287.0 679353.2 680450.6 47164.3 50681.0 56848.0 58288.0 58394.4 1338.8 1354.3 1373.8 1379.1 1382.1 24904.6 29912.6 30098.9 30350.5 30372.8 52231.5 52394.0 52575.5 52590.7 52695.9 614336.0 620348.0 620765.0 622130.0 625540.0 27119.2 27448.5 27496.5 27517.3 27579.2 47735.8 48255.8 48281.0 49529.8 49763.8 32971.0 38394.2 39702.0 40521.6 40795.6 33482.7 36040.0 39421.6 39730.6 40593.8 38930.4 40330.8 40538.0 40871.6 41293.8 32200.0 35672.3 35822.0 35833.8 35926.5 26341.7 26421.9 26519.5 26603.9 27133.7 02:11:12 INFO - PROCESS | 6747 | 02:11:12 INFO - PROCESS | 6747 | [#2] jquery.html Cycles:180 Average:35347.46 Median:416.98 stddev:107143.39 (25695.3%) stddev-sans-first:107411.75 02:11:12 INFO - PROCESS | 6747 | Values: 360.8 368.3 375.7 379.7 391.3 18770.3 19982.9 20685.0 20755.6 20937.6 11622.9 11694.8 17967.7 19825.1 20500.2 5238.1 5355.8 5465.6 5560.2 5727.0 5597.3 6148.8 6220.2 6222.8 6229.7 5942.7 6159.7 6165.7 6178.8 6179.7 6097.8 6140.2 6206.3 6214.4 6218.3 5234.3 5412.5 5427.1 5446.9 5485.3 20877.0 24242.7 25517.0 25594.5 25778.1 2216.3 2382.6 2399.8 2564.6 3025.0 8175.0 9880.2 10377.6 10387.8 10415.9 1875.8 1946.7 1948.2 1951.4 1997.5 104681.4 114693.0 130093.3 132325.3 135349.3 9176.5 9423.3 9564.0 11567.5 11672.7 14576.2 14597.9 14648.3 14650.6 14660.3 7133.3 8348.5 8693.4 8740.2 8808.2 7465.0 8435.7 8614.4 8617.8 8720.4 4069.9 4261.2 4501.3 4543.0 4562.4 1647.3 1902.6 1940.9 1959.5 1992.4 836.0 876.0 916.1 975.6 1024.7 20363.3 20713.5 21627.8 21951.3 22346.7 414.1 419.8 442.2 442.7 898.4 5611.1 5883.8 6151.6 6154.5 6236.6 616610.0 637869.0 647685.0 658950.0 662016.0 79159.0 81115.0 118736.4 132119.3 135989.3 430.5 434.4 449.2 450.8 454.5 10752.8 10996.7 11077.3 11216.0 11221.5 38033.4 42485.8 54498.7 56413.1 58247.7 69865.0 75913.0 80127.0 82582.6 83326.0 8108.4 8110.9 8281.3 8291.5 8376.2 12033.0 13019.7 13048.7 13058.4 13183.2 10945.9 10959.4 11271.0 11366.6 11493.1 10920.3 11031.7 11179.6 11430.5 11482.4 10110.5 10994.2 11289.3 11297.0 11648.7 7993.8 8179.6 8288.4 8291.9 8339.7 9223.5 11070.8 11095.1 11251.3 11281.5 02:11:12 INFO - PROCESS | 6747 | 02:11:12 INFO - PROCESS | 6747 | [#3] mootools.html Cycles:180 Average:5770.69 Median:4827.09 stddev:3222.84 (66.8%) stddev-sans-first:3216.09 02:11:12 INFO - PROCESS | 6747 | Values: 1526.0 1545.4 1756.9 1886.9 1889.5 8042.9 8320.0 8547.6 9101.5 9117.7 8553.0 8894.0 8894.5 8949.5 8999.9 1929.8 2022.4 2262.4 2385.4 2418.2 1861.8 2379.7 2396.4 2421.2 2428.4 2402.9 2407.2 2421.1 2435.7 2437.5 2056.4 2164.7 2388.7 2389.4 2402.7 2000.5 2361.1 2402.4 2402.6 2408.9 8039.3 8638.6 8919.0 9021.5 9026.8 4646.6 5272.5 5411.3 5432.5 5441.8 3557.4 3609.5 3735.4 3739.1 3744.4 1070.1 1092.5 1105.5 1123.0 1123.1 11772.6 11818.5 11893.9 11895.9 11941.0 4707.2 4759.1 4768.9 4885.3 4900.9 10160.6 10193.9 10224.3 10235.3 10239.7 5341.9 5382.4 5419.0 5422.9 5454.0 4403.6 4683.3 4897.3 4910.3 4997.6 3982.0 4015.3 4071.2 4106.0 4152.8 1311.1 1317.1 1322.6 1324.5 1334.3 896.0 910.0 918.5 932.7 941.2 5868.0 6059.8 6092.0 6126.1 6250.7 938.3 945.3 985.6 1003.3 1011.6 3924.6 3927.6 4096.7 4115.5 4165.9 10536.8 10892.9 10910.8 10924.2 10949.2 10050.9 10676.8 10714.0 10769.9 10813.7 7906.8 8137.7 8253.0 8256.2 8290.2 5911.9 5939.3 5993.8 6044.9 6117.4 9568.1 9785.5 10009.3 10095.5 10142.7 10234.7 10239.2 10256.3 10277.1 10289.6 6147.5 6834.6 7063.9 8298.3 8400.3 7229.3 8405.0 8459.5 8502.6 8614.6 7452.9 7498.4 7593.4 7611.8 7711.6 7324.1 7362.5 7385.2 7454.9 7498.9 6997.4 7130.7 7132.9 7140.7 7156.2 5075.4 5075.9 5093.7 5108.5 5153.4 5170.2 5188.2 5213.1 5238.8 5292.5 02:11:12 INFO - PROCESS | 6747 | 02:11:12 INFO - PROCESS | 6747 | [#4] prototype.html Cycles:180 Average:4684.34 Median:5228.56 stddev:1493.27 (28.6%) stddev-sans-first:1460.61 02:11:12 INFO - PROCESS | 6747 | Values: 291.6 298.6 302.3 311.0 316.8 5398.5 5482.9 5583.8 5659.4 5682.3 4262.5 5472.5 5480.6 5481.6 5507.5 3615.5 4101.8 4190.0 4201.9 4210.1 3307.8 3468.6 3996.4 4114.4 4250.7 3261.6 3829.9 3925.0 3937.8 4167.2 4168.0 4174.7 4175.6 4215.6 4216.6 3658.5 3667.5 3674.4 3683.9 3697.4 4506.0 4944.4 5119.5 5466.8 5467.9 4821.6 4823.4 4829.0 4834.0 4841.3 5852.2 5896.8 5899.8 5910.3 5940.7 3703.9 3909.9 3920.5 3931.0 3942.6 4845.9 6131.1 6141.0 6210.0 6221.4 3571.3 4028.3 4030.3 4036.3 4046.7 3745.0 3812.5 3922.4 4036.7 4085.7 4411.8 4775.3 4815.0 4826.8 4848.2 4852.9 5235.5 5673.7 5893.8 5931.6 1287.3 1298.1 1346.3 1362.6 1377.7 791.8 866.5 906.0 930.1 935.5 5457.6 5464.4 5470.0 5495.7 5507.4 5065.4 5532.7 5979.6 6038.4 6040.2 4770.6 5249.3 5440.5 5468.0 5479.9 2314.5 2582.6 2601.5 2623.2 2673.6 4392.6 5123.4 5164.3 5199.9 5205.7 4389.2 5147.2 5375.4 6042.0 6044.5 6357.7 6372.4 6377.9 6385.4 6418.8 5129.4 5912.6 6209.1 6230.2 6267.7 5322.8 5993.4 6079.3 6080.2 6133.3 5014.4 5293.7 5797.0 6341.6 6398.1 3914.9 3984.9 4021.4 4038.3 4055.3 5351.7 6114.6 6164.4 6176.4 6181.7 5782.3 5894.8 6004.0 6006.9 6065.4 4607.6 5548.4 5638.4 5853.2 6030.2 4792.7 4962.0 5836.3 5862.3 5875.4 5221.6 5522.3 5967.9 6006.4 6048.8 5491.0 5821.3 5870.8 5887.1 5891.6 02:11:12 INFO - PROCESS | 6747 | 02:11:12 INFO - PROCESS | 6747 | [#5] yui.html Cycles:180 Average:23473.60 Median:4315.09 stddev:37555.78 (870.3%) stddev-sans-first:37622.40 02:11:12 INFO - PROCESS | 6747 | Values: 757.6 759.0 789.6 792.8 827.8 15034.4 15072.8 15552.9 15588.8 15593.9 14108.7 14190.0 14214.4 14214.6 14228.7 826.7 863.5 890.0 892.6 898.0 853.9 869.2 870.1 871.1 872.7 926.6 933.7 934.7 935.9 936.7 874.2 883.6 916.6 927.4 927.7 671.6 687.3 689.0 689.2 689.2 12467.6 15448.2 15477.0 15493.4 15503.9 10302.5 12124.2 13405.5 14012.5 14410.6 11598.5 11650.0 11984.9 12082.6 12387.8 3784.5 3796.4 3817.1 3826.5 3875.1 87667.0 112153.4 115391.0 116310.0 117127.0 9243.7 10613.4 10995.8 11022.8 11324.9 20713.2 20833.1 20904.6 20967.5 20989.4 7806.9 7928.4 7969.8 8118.7 8175.5 4471.4 4519.7 4543.4 4568.0 4668.9 3479.8 3557.6 3600.0 3617.7 3632.6 645.6 657.5 659.9 674.4 674.8 582.0 602.6 633.4 634.1 667.2 8531.2 8635.6 8806.8 8934.9 9308.0 502.6 598.8 609.2 616.1 622.5 3628.9 4021.7 4158.8 4483.1 4561.0 94364.0 96876.0 97358.0 153477.5 168463.0 105667.5 110349.8 115168.1 119054.4 135358.0 73800.6 101317.0 109929.5 117045.2 118777.4 7137.5 7788.1 8265.4 8475.5 8605.8 66243.3 66818.7 67033.0 67967.3 68615.8 90308.0 100727.0 102767.0 103931.0 104646.5 10816.5 11197.4 11315.0 11338.3 11585.9 12090.8 12108.5 12207.6 12295.4 12375.2 11658.7 11666.8 11684.4 11786.9 11797.1 11296.5 11423.4 11562.4 11781.9 11931.9 10694.3 11258.2 11340.5 11530.4 11768.2 8942.9 9021.2 9101.4 9304.9 9360.5 7916.1 8107.6 8140.0 8241.4 8391.5 02:11:12 INFO - PROCESS | 6747 | -------- Summary: end -------- 02:11:12 INFO - PROCESS | 6747 | 02:11:12 INFO - TEST-INFO | 6747: exit 0 02:11:12 INFO - TEST-OK | dromaeo_css | took 1113188ms 02:11:12 INFO - TEST-START | kraken 02:11:12 INFO - operating with platform_type : mac_ 02:11:12 INFO - Initialising browser for kraken test... 02:11:12 INFO - TEST-INFO | started process 6751 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/tmpaVjD9a/profile http://localhost:57658/getInfo.html) 02:11:15 INFO - PROCESS | 6751 | __metrics Screen width/height:1600/1200 02:11:15 INFO - PROCESS | 6751 | colorDepth:24 02:11:15 INFO - PROCESS | 6751 | Browser inner width/height: 1024/689 02:11:15 INFO - PROCESS | 6751 | __metrics 02:11:15 ERROR - PROCESS | 6751 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 02:11:16 INFO - TEST-INFO | 6751: exit 0 02:11:16 INFO - Browser initialized. 02:11:16 INFO - Running cycle 1/1 for kraken test... 02:11:16 INFO - TEST-INFO | started process 6754 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/tmpaVjD9a/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:11:28 INFO - PROCESS | 6754 | RSS: Main: 225198080 02:11:28 INFO - PROCESS | 6754 | 02:11:31 INFO - PROCESS | 6754 | Cycle 1(1): loaded http://localhost:57658/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57658/tests/kraken/driver.html?testName=audio-beat-detection) 02:11:32 INFO - PROCESS | 6754 | RSS: Main: 237502464 02:11:32 INFO - PROCESS | 6754 | 02:11:35 INFO - PROCESS | 6754 | Cycle 1(1): loaded http://localhost:57658/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57658/tests/kraken/driver.html?testName=audio-dft) 02:11:35 INFO - PROCESS | 6754 | RSS: Main: 246259712 02:11:35 INFO - PROCESS | 6754 | 02:11:39 INFO - PROCESS | 6754 | Cycle 1(1): loaded http://localhost:57658/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57658/tests/kraken/driver.html?testName=audio-fft) 02:11:39 INFO - PROCESS | 6754 | RSS: Main: 249147392 02:11:39 INFO - PROCESS | 6754 | 02:11:41 INFO - PROCESS | 6754 | Cycle 1(1): loaded http://localhost:57658/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57658/tests/kraken/driver.html?testName=audio-oscillator) 02:11:42 INFO - PROCESS | 6754 | RSS: Main: 249028608 02:11:42 INFO - PROCESS | 6754 | 02:11:44 INFO - PROCESS | 6754 | Cycle 1(1): loaded http://localhost:57658/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57658/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:11:44 INFO - PROCESS | 6754 | RSS: Main: 250474496 02:11:44 INFO - PROCESS | 6754 | 02:11:47 INFO - PROCESS | 6754 | Cycle 1(1): loaded http://localhost:57658/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57658/tests/kraken/driver.html?testName=imaging-darkroom) 02:11:48 INFO - PROCESS | 6754 | RSS: Main: 250859520 02:11:48 INFO - PROCESS | 6754 | 02:11:51 INFO - PROCESS | 6754 | Cycle 1(1): loaded http://localhost:57658/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57658/tests/kraken/driver.html?testName=imaging-desaturate) 02:11:51 INFO - PROCESS | 6754 | RSS: Main: 251002880 02:11:51 INFO - PROCESS | 6754 | 02:11:54 INFO - PROCESS | 6754 | Cycle 1(1): loaded http://localhost:57658/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57658/tests/kraken/driver.html?testName=json-parse-financial) 02:11:55 INFO - PROCESS | 6754 | RSS: Main: 251490304 02:11:55 INFO - PROCESS | 6754 | 02:11:57 INFO - PROCESS | 6754 | Cycle 1(1): loaded http://localhost:57658/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57658/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:11:57 INFO - PROCESS | 6754 | RSS: Main: 250982400 02:11:57 INFO - PROCESS | 6754 | 02:11:59 INFO - PROCESS | 6754 | Cycle 1(1): loaded http://localhost:57658/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57658/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:12:00 INFO - PROCESS | 6754 | RSS: Main: 250933248 02:12:00 INFO - PROCESS | 6754 | 02:12:02 INFO - PROCESS | 6754 | Cycle 1(1): loaded http://localhost:57658/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57658/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:12:03 INFO - PROCESS | 6754 | RSS: Main: 250970112 02:12:03 INFO - PROCESS | 6754 | 02:12:06 INFO - PROCESS | 6754 | Cycle 1(1): loaded http://localhost:57658/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57658/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:12:06 INFO - PROCESS | 6754 | RSS: Main: 251547648 02:12:06 INFO - PROCESS | 6754 | 02:12:09 INFO - PROCESS | 6754 | Cycle 1(1): loaded http://localhost:57658/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57658/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:12:10 INFO - PROCESS | 6754 | RSS: Main: 251416576 02:12:10 INFO - PROCESS | 6754 | 02:12:12 INFO - PROCESS | 6754 | Cycle 1(1): loaded http://localhost:57658/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57658/tests/kraken/driver.html?testName=ai-astar) 02:12:12 INFO - PROCESS | 6754 | RSS: Main: 253177856 02:12:12 INFO - PROCESS | 6754 | 02:12:12 INFO - PROCESS | 6754 | __start_tp_report 02:12:12 INFO - PROCESS | 6754 | _x_x_mozilla_page_load 02:12:12 INFO - PROCESS | 6754 | _x_x_mozilla_page_load_details 02:12:12 INFO - PROCESS | 6754 | |i|pagename|runs| 02:12:12 INFO - PROCESS | 6754 | |0;ai-astar;106;116;118;117;117;117;117;117;118;122 02:12:12 INFO - PROCESS | 6754 | |1;audio-beat-detection;174;141;141;153;144;132;142;139;136;108 02:12:12 INFO - PROCESS | 6754 | |2;audio-dft;211;197;197;199;197;197;200;207;251;199 02:12:12 INFO - PROCESS | 6754 | |3;audio-fft;84;59;59;88;60;62;57;60;76;58 02:12:12 INFO - PROCESS | 6754 | |4;audio-oscillator;89;58;100;104;56;91;125;101;84;85 02:12:12 INFO - PROCESS | 6754 | |5;imaging-gaussian-blur;90;88;91;87;91;93;91;88;90;89 02:12:12 INFO - PROCESS | 6754 | |6;imaging-darkroom;152;122;95;98;95;95;96;97;96;97 02:12:12 INFO - PROCESS | 6754 | |7;imaging-desaturate;91;96;105;126;92;128;84;140;149;126 02:12:12 INFO - PROCESS | 6754 | |8;json-parse-financial;55;54;55;54;56;59;90;88;87;53 02:12:12 INFO - PROCESS | 6754 | |9;json-stringify-tinderbox;69;64;79;84;79;75;70;69;70;71 02:12:12 INFO - PROCESS | 6754 | |10;stanford-crypto-aes;90;76;90;71;95;103;107;103;84;88 02:12:12 INFO - PROCESS | 6754 | |11;stanford-crypto-ccm;142;133;142;148;154;150;176;147;176;140 02:12:12 INFO - PROCESS | 6754 | |12;stanford-crypto-pbkdf2;166;163;150;213;222;166;165;165;170;163 02:12:12 INFO - PROCESS | 6754 | |13;stanford-crypto-sha256-iterative;65;72;71;82;88;67;79;87;84;90 02:12:12 INFO - PROCESS | 6754 | __end_tp_report 02:12:12 INFO - PROCESS | 6754 | __start_cc_report 02:12:12 INFO - PROCESS | 6754 | _x_x_mozilla_cycle_collect,928 02:12:12 INFO - PROCESS | 6754 | __end_cc_report 02:12:12 INFO - PROCESS | 6754 | __startTimestamp1474362732540__endTimestamp 02:12:12 INFO - PROCESS | 6754 | 02:12:12 INFO - PROCESS | 6754 | ------- Summary: start ------- 02:12:12 INFO - PROCESS | 6754 | Number of tests: 14 02:12:12 INFO - PROCESS | 6754 | 02:12:12 INFO - PROCESS | 6754 | [#0] ai-astar Cycles:10 Average:116.50 Median:117.00 stddev:4.03 (3.4%) stddev-sans-first:1.73 02:12:12 INFO - PROCESS | 6754 | Values: 106.0 116.0 118.0 117.0 117.0 117.0 117.0 117.0 118.0 122.0 02:12:12 INFO - PROCESS | 6754 | 02:12:12 INFO - PROCESS | 6754 | [#1] audio-beat-detection Cycles:10 Average:141.00 Median:141.50 stddev:16.47 (11.6%) stddev-sans-first:12.41 02:12:12 INFO - PROCESS | 6754 | Values: 174.0 141.0 141.0 153.0 144.0 132.0 142.0 139.0 136.0 108.0 02:12:12 INFO - PROCESS | 6754 | 02:12:12 INFO - PROCESS | 6754 | [#2] audio-dft Cycles:10 Average:205.50 Median:199.50 stddev:16.69 (8.4%) stddev-sans-first:17.58 02:12:12 INFO - PROCESS | 6754 | Values: 211.0 197.0 197.0 199.0 197.0 197.0 200.0 207.0 251.0 199.0 02:12:12 INFO - PROCESS | 6754 | 02:12:12 INFO - PROCESS | 6754 | [#3] audio-fft Cycles:10 Average:66.30 Median:61.00 stddev:11.73 (19.2%) stddev-sans-first:10.55 02:12:12 INFO - PROCESS | 6754 | Values: 84.0 59.0 59.0 88.0 60.0 62.0 57.0 60.0 76.0 58.0 02:12:12 INFO - PROCESS | 6754 | 02:12:12 INFO - PROCESS | 6754 | [#4] audio-oscillator Cycles:10 Average:89.30 Median:71.00 stddev:20.76 (29.2%) stddev-sans-first:22.02 02:12:12 INFO - PROCESS | 6754 | Values: 89.0 58.0 100.0 104.0 56.0 91.0 125.0 101.0 84.0 85.0 02:12:12 INFO - PROCESS | 6754 | 02:12:12 INFO - PROCESS | 6754 | [#5] imaging-gaussian-blur Cycles:10 Average:89.80 Median:90.50 stddev:1.81 (2.0%) stddev-sans-first:1.92 02:12:12 INFO - PROCESS | 6754 | Values: 90.0 88.0 91.0 87.0 91.0 93.0 91.0 88.0 90.0 89.0 02:12:12 INFO - PROCESS | 6754 | 02:12:12 INFO - PROCESS | 6754 | [#6] imaging-darkroom Cycles:10 Average:104.30 Median:96.00 stddev:18.66 (19.4%) stddev-sans-first:8.69 02:12:12 INFO - PROCESS | 6754 | Values: 152.0 122.0 95.0 98.0 95.0 95.0 96.0 97.0 96.0 97.0 02:12:12 INFO - PROCESS | 6754 | 02:12:12 INFO - PROCESS | 6754 | [#7] imaging-desaturate Cycles:10 Average:113.70 Median:116.50 stddev:22.86 (19.6%) stddev-sans-first:22.72 02:12:12 INFO - PROCESS | 6754 | Values: 91.0 96.0 105.0 126.0 92.0 128.0 84.0 140.0 149.0 126.0 02:12:12 INFO - PROCESS | 6754 | 02:12:12 INFO - PROCESS | 6754 | [#8] json-parse-financial Cycles:10 Average:65.10 Median:57.50 stddev:16.13 (28.0%) stddev-sans-first:16.69 02:12:12 INFO - PROCESS | 6754 | Values: 55.0 54.0 55.0 54.0 56.0 59.0 90.0 88.0 87.0 53.0 02:12:12 INFO - PROCESS | 6754 | 02:12:12 INFO - PROCESS | 6754 | [#9] json-stringify-tinderbox Cycles:10 Average:73.00 Median:73.00 stddev:6.07 (8.3%) stddev-sans-first:6.27 02:12:12 INFO - PROCESS | 6754 | Values: 69.0 64.0 79.0 84.0 79.0 75.0 70.0 69.0 70.0 71.0 02:12:12 INFO - PROCESS | 6754 | 02:12:12 INFO - PROCESS | 6754 | [#10] stanford-crypto-aes Cycles:10 Average:90.70 Median:86.00 stddev:11.76 (13.7%) stddev-sans-first:12.47 02:12:12 INFO - PROCESS | 6754 | Values: 90.0 76.0 90.0 71.0 95.0 103.0 107.0 103.0 84.0 88.0 02:12:12 INFO - PROCESS | 6754 | 02:12:12 INFO - PROCESS | 6754 | [#11] stanford-crypto-ccm Cycles:10 Average:150.80 Median:149.00 stddev:14.50 (9.7%) stddev-sans-first:15.02 02:12:12 INFO - PROCESS | 6754 | Values: 142.0 133.0 142.0 148.0 154.0 150.0 176.0 147.0 176.0 140.0 02:12:12 INFO - PROCESS | 6754 | 02:12:12 INFO - PROCESS | 6754 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.30 Median:166.00 stddev:23.45 (14.1%) stddev-sans-first:24.68 02:12:12 INFO - PROCESS | 6754 | Values: 166.0 163.0 150.0 213.0 222.0 166.0 165.0 165.0 170.0 163.0 02:12:12 INFO - PROCESS | 6754 | 02:12:12 INFO - PROCESS | 6754 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.50 Median:83.00 stddev:9.13 (11.0%) stddev-sans-first:8.28 02:12:12 INFO - PROCESS | 6754 | Values: 65.0 72.0 71.0 82.0 88.0 67.0 79.0 87.0 84.0 90.0 02:12:12 INFO - PROCESS | 6754 | -------- Summary: end -------- 02:12:12 INFO - PROCESS | 6754 | 02:12:13 INFO - TEST-INFO | 6754: exit 0 02:12:13 INFO - TEST-OK | kraken | took 60669ms 02:12:13 INFO - SUITE-END | took 1173s 02:12:13 INFO - Completed test suite (00:19:34) 02:12:13 INFO - javascript benchmark 02:12:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7275.244859713504, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3331.583552055993, 3344.732421406288, 3360.823711700905, 3370.4438767603347, 3408.182036311285, 5738.081906894898, 5739.081746920494, 5821.446962538552, 5866.88266234675, 5890.911636325459, 5773.56698247631, 5849.795257166, 5898.557608179393, 5913.438223368784, 5920.082387229975, 5220.451852555484, 5286.0, 5300.151975683892, 5341.492558206984, 5345.037893179227, 4607.516210797869, 5340.652857564246, 5345.224942383352, 5345.33183352081, 5385.0, 5204.479552044784, 5206.661566998152, 5316.707581083039, 5337.626366154371, 5378.058839703056, 5013.699178049311, 5211.478852114796, 5270.130428479335, 5318.202269659543, 5386.0, 5187.325647665779, 5258.6318957672975, 5263.4473380295285, 5274.918641678447, 5286.022085914118, 5612.831615051555, 5788.42115788422, 5789.0, 5795.362510123883, 5956.0, 6087.4521293083835, 6153.969230153821, 6159.260888693386, 6205.844853878689, 6248.250209974786, 6236.719347629368, 6259.906101408483, 6264.968675156595, 6265.906011409833, 6272.40412160844, 5882.705864706748, 5892.322382926019, 5897.705114744245, 5920.200772895647, 5953.0, 6140.933729673037, 6175.228096487939, 6183.505319574423, 6200.0699895015205, 6212.968935155295, 6151.0773383992755, 6180.505559555225, 6198.535109866688, 6207.472364848948, 6217.564770466114, 6189.535784816157, 6266.655333956676, 6275.592086514362, 6289.371062893674, 6296.905546416808, 6080.939190608037, 6130.887362651087, 6152.661603611844, 6153.784617538365, 6215.502759779207, 6252.656103914328, 6261.96869015652, 6263.279722831841, 6265.404786545271, 6274.152989346379, 4976.925346119811, 4985.177445721415, 4991.126552853309, 4994.001199760062, 5004.724740139327, 4339.4792624884585, 4348.586884245991, 4379.321205213197, 4432.3351497275025, 4471.418715566955, 5762.971185144047, 5856.355800861902, 5919.615225010447, 5921.200637913913, 5942.3166335871065, 6236.532260080512, 6240.375962403723, 6248.156498872685, 6257.874842503215, 6271.592346497463, 5668.2064510967675, 5730.08318669011, 5817.854553636193, 5842.38654941225, 5870.677112758839, 4469.865904022885, 4669.533046695304, 4804.447488538863, 5452.509274165344, 5484.067708489566, 6298.244210694655, 6317.147185130132, 6333.714982825784, 6336.20797400325, 6336.493080553637, 6110.649890384107, 6172.166757487861, 6174.475169610454, 6248.593841400476, 6251.156093927261, 6249.6562689052535, 6320.873582528416, 6323.557350985387, 6343.143675603735, 6343.302236754045, 6214.782482613087, 6246.406591373812, 6271.278802937538, 6282.963311053625, 6293.905591416041, 6113.871604717183, 6150.630962142107, 6152.384761523812, 6261.123442717932, 6270.0, 6035.758569657164, 6081.057436097412, 6169.383061693795, 6190.164327815867, 6197.566170368212, 6115.3578874217565, 6120.7543792481, 6169.660668663267, 6176.320604733386, 6183.628982261079, 5804.65172089676, 5910.379410161871, 5919.141724449844, 6022.759089636541, 6055.2430946131735, 6124.869201255597, 6127.479164271087, 6131.264248290234, 6175.0, 6205.906911396423, 5997.910031349446, 6071.180390647206, 6073.848153796191, 6080.969595151996, 6095.725692343766], "value": 5730.222911900383, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [461.8660588429358, 470.7834396177758, 472.8865072382628, 520.0690763533275, 522.8901930594576, 40212.59787402125, 42217.0, 42283.154336913285, 42376.78811605941, 42410.0, 43720.78139609306, 44147.0, 44171.337429938496, 44187.116257674825, 44192.3371149433, 9671.274654400913, 9837.163841073518, 9884.0, 9887.406755594651, 9891.505424728735, 9782.510874456284, 9880.950595247014, 9882.357646752975, 9883.258755593324, 9901.801963960717, 9825.263105267099, 9859.112679858812, 9892.604295828158, 9902.356346837469, 9903.900960990406, 9839.950800245988, 9874.80250394988, 9875.851862222073, 9894.90105098947, 9897.90102098977, 9742.902570974271, 9791.461469619167, 9796.069373409515, 9819.705408837746, 9836.163926066292, 41160.1767964639, 41194.0, 41394.37908431376, 41465.792671036754, 41601.79199103985, 3352.9664703352896, 3372.392969265531, 3427.3488037272837, 3508.1405055761247, 3508.2106526031694, 28646.713532864615, 30379.544306835414, 31235.0, 31900.042998710076, 32053.83973080143, 3121.82829944353, 3279.672032796725, 3300.240944582735, 3300.5544251525976, 3306.123877172551, 491098.0, 492313.0, 495233.0, 495903.9999999964, 497495.0, 63628.36371636224, 63913.0, 64321.67839160774, 64373.71252574922, 64425.67787161128, 34914.127146821025, 35315.646843531234, 35409.64590354115, 36846.63153368486, 67105.66447167733, 16856.662866742598, 16913.0, 17012.91493542549, 17034.48896533106, 17072.317107315816, 12962.0, 13085.934570327088, 13089.214647121204, 13098.934505327412, 13116.885064769602, 19688.310909118398, 19925.501862453264, 19961.500962475762, 19995.400137995883, 20031.198752050048, 6622.86754264912, 7694.384449244047, 7787.260210280015, 7799.713047347238, 7881.408894332948, 830.754927296449, 851.7359618518155, 941.4398432932394, 1007.3082153905852, 1044.8432735089646, 29747.85126074356, 30739.8463007688, 30812.0, 30982.380352393277, 31302.843485782425, 950.8240975419432, 1009.5103874620803, 1045.6563316138725, 1092.6667366453307, 1133.4729350851894, 15583.84416155824, 16076.839231607768, 16102.677946441005, 16107.838921610868, 16368.345266189219, 588997.0, 664152.0, 677287.0, 679353.2064679388, 680450.597747018, 47164.292535611996, 50681.0, 56848.0, 58288.0, 58394.41605583975, 1338.8125662407272, 1354.2686949047404, 1373.8420081690533, 1379.1035826712516, 1382.1223523062927, 24904.62643060319, 29912.551311729905, 30098.946536871103, 30350.54474182845, 30372.84813575918, 52231.477685222664, 52394.0, 52575.47424525706, 52590.73704631453, 52695.94608107893, 614336.0, 620348.0, 620765.0, 622130.0, 625540.0, 27119.1864244073, 27448.451030979668, 27496.450070998868, 27517.31206719848, 27579.172624821287, 47735.761321193175, 48255.75872120617, 48281.03437931152, 49529.752351238014, 49763.75118124386, 32971.0, 38394.23211535809, 39702.00744981399, 40521.594784051784, 40795.59204407918, 33482.66517334893, 36040.0, 39421.60578394294, 39730.60269397269, 40593.797031014656, 38930.416043759935, 40330.79834600926, 40537.98655033648, 40871.59128408797, 41293.793531032155, 32200.033998980067, 35672.28655426825, 35822.0, 35833.82083089568, 35926.461103083995, 26341.73658263393, 26421.867890660425, 26519.469610608066, 26603.866980664974, 27133.72866271312], "value": 20135.60083271005, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.82680313449544, 368.3075817463167, 375.7332294071209, 379.66779068315225, 391.2527073290017, 18770.343037993654, 19982.900085499572, 20685.0, 20755.584888302226, 20937.581248375023, 11622.883771162285, 11694.824577631322, 17967.73048404275, 19825.107870145843, 20500.17999280027, 5238.05714971305, 5355.839324820242, 5465.562754979592, 5560.165975103747, 5727.026405511073, 5597.272354593897, 6148.754049838001, 6220.191375121228, 6222.813315600517, 6229.6573688447115, 5942.732577034022, 6159.722812473449, 6165.660888651122, 6178.783742569011, 6179.69101544921, 6097.756089756404, 6140.171076904606, 6206.255249370082, 6214.440700336969, 6218.253809542839, 5234.319538460014, 5412.512873841373, 5427.104527752956, 5446.863828404282, 5485.314335708036, 20877.0, 24242.66665333406, 25516.979320827144, 25594.48811023769, 25778.09776657808, 2216.3240211735415, 2382.559226543095, 2399.8440101393353, 2564.5896656534865, 3024.9546256806166, 8174.959125204396, 9880.209583233323, 10377.636782712645, 10387.84418233727, 10415.94792026035, 1875.8311751942254, 1946.698261769428, 1948.2499237793552, 1951.4145756273203, 1997.530580313625, 104681.42977855339, 114693.0, 130093.34953325173, 132325.33837330848, 135349.3232533841, 9176.49529275883, 9423.34036617444, 9564.0, 11567.537298507965, 11672.70818229551, 14576.19830909289, 14597.92701036488, 14648.340824662915, 14650.63373415673, 14660.340284687214, 7133.322334378226, 8348.499090054616, 8693.391462597683, 8740.169683880022, 8808.20726134651, 7465.0, 8435.746927592181, 8614.396992210484, 8617.827643447095, 8720.43317184381, 4069.877903662895, 4261.190373828963, 4501.257292546693, 4542.9772851136195, 4562.361269422284, 1647.3163637090472, 1902.581432084939, 1940.8544359173118, 1959.549303660166, 1992.3923203422805, 835.9540225287546, 875.9605817738217, 916.1434059154711, 975.6390135649855, 1024.687470321559, 20363.287284944956, 20713.482162945744, 21627.78372216289, 21951.341459756233, 22346.66480002801, 414.1179288116293, 419.83626385709596, 442.18833653903556, 442.7255101836882, 898.3873946266336, 5611.0741727615305, 5883.764649413975, 6151.6001459904965, 6154.5384096192965, 6236.594621349598, 616610.0, 637869.0, 647685.0, 658950.0, 662016.0, 79159.0, 81115.0, 118736.40631796786, 132119.3394033043, 135989.32005340108, 430.5307215135517, 434.4092034832625, 449.1981812464735, 450.794888325811, 454.51140024473824, 10752.83870741955, 10996.725081873017, 11077.335359878432, 11215.990560849563, 11221.541199643994, 38033.43774315216, 42485.78757106195, 54498.727506362215, 56413.05054160733, 58247.70876145592, 69865.0, 75913.0, 80127.0, 82582.58708706658, 83326.0, 8108.3513318933165, 8110.918890811016, 8281.337493000425, 8291.543965081979, 8376.246137847624, 12033.0, 13019.674508137372, 13048.739025219253, 13058.412371443497, 13183.209007459584, 10945.890541094486, 10959.397233152253, 11270.985611295022, 11366.602168924048, 11493.080553555863, 10920.2901811382, 11031.669049928514, 11179.60871369498, 11430.485628146587, 11482.368469734245, 10110.545025474019, 10994.185959316623, 11289.322640641587, 11297.039751621205, 11648.708782280171, 7993.8401231976195, 8179.550124743197, 8288.419810613199, 8291.875621865556, 8339.708110216114, 9223.538823058687, 11070.778584428106, 11095.11239100886, 11251.268667536584, 11281.548738050715], "value": 8840.020558671513, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1526.0462211118047, 1545.443640289496, 1756.903370314633, 1886.9150888210029, 1889.5370634194624, 8042.91957080429, 8320.0, 8547.615357308921, 9101.544922753868, 9117.726468205949, 8553.0, 8894.0, 8894.510801905893, 8949.507777072258, 8999.865002024959, 1929.8131649035881, 2022.423609271358, 2262.3665373695308, 2385.415573184568, 2418.22616762636, 1861.8231268029583, 2379.7382287948312, 2396.400899775056, 2421.2010036687852, 2428.3564855313357, 2402.903883844644, 2407.205622144688, 2421.055788242587, 2435.695538057743, 2437.549053425113, 2056.352249041562, 2164.7011792924277, 2388.7252965908883, 2389.414593424605, 2402.699662542182, 2000.469875482998, 2361.114582031738, 2402.3633737059695, 2402.5675378431874, 2408.9156879509133, 8039.31665808407, 8638.568071596457, 8918.955405222932, 9021.503817290046, 9026.774330641787, 4646.581807637329, 5272.499112584298, 5411.269478620415, 5432.511074003359, 5441.83674489766, 3557.3596752584526, 3609.458581212839, 3735.383661695817, 3739.1026153723183, 3744.4383342498572, 1070.1331921143899, 1092.5247517329988, 1105.5301496863801, 1123.0061395664814, 1123.1464087293716, 11772.587959421464, 11818.468168932419, 11893.881061189364, 11895.88104118965, 11941.0, 4707.152712511781, 4759.113820185202, 4768.856934291907, 4885.316055752198, 4900.901981960341, 10160.593576256866, 10193.898061019443, 10224.28430009907, 10235.334703244265, 10239.692809215736, 5341.946580534222, 5382.407935127133, 5418.997485465202, 5422.91865622016, 5453.972730136324, 4403.647708183337, 4683.344331793552, 4897.289892965571, 4910.263460480956, 4997.625178111656, 3982.0, 4015.3374693175883, 4071.246819338432, 4105.97947010263, 4152.792360381969, 1311.0560396514495, 1317.1306937421448, 1322.6098301001227, 1324.543032653733, 1334.3061607963805, 896.0188593490118, 909.963106930557, 918.5131880103556, 932.664240873285, 941.1670671455811, 5868.031774757117, 6059.757609695563, 6092.025275955826, 6126.142340072393, 6250.74520090615, 938.3197182042965, 945.3146468810195, 985.5515740338129, 1003.3177439341318, 1011.6155860773007, 3924.5682974872743, 3927.626875446828, 4096.713230073866, 4115.538983660757, 4165.854195103157, 10536.841947370796, 10892.910708929043, 10910.836337454944, 10924.235303528836, 10949.233553651167, 10050.899491004997, 10676.839847402296, 10713.982171693677, 10769.892301077045, 10813.729656758644, 7906.802329941683, 8137.674493020331, 8253.009638843258, 8256.215659512336, 8290.212429819157, 5911.852203694942, 5939.346671866005, 5993.820185394445, 6044.939550604614, 6117.449429551361, 9568.138867501959, 9785.461799601091, 10009.349392289478, 10095.54570044335, 10142.695719128438, 10234.744131396774, 10239.180865530889, 10256.282060255711, 10277.126444252022, 10289.588416463557, 6147.508199343953, 6834.624095674587, 7063.858722825412, 8298.253157215879, 8400.285975692135, 7229.313215244543, 8404.957975210085, 8459.534725589905, 8502.617382217692, 8614.569271536524, 7452.850942981218, 7498.362639175732, 7593.392528597588, 7611.847763044819, 7711.575863327571, 7324.08448943882, 7362.5214361066355, 7385.224551422023, 7454.850902982019, 7498.887516687363, 6997.405220556309, 7130.714771409085, 7132.85734285301, 7140.7143714252925, 7156.212816590067, 5075.365579302587, 5075.949240507548, 5093.719845408538, 5108.489151084862, 5153.40735815371, 5170.1727723564045, 5188.22176673502, 5213.061648903082, 5238.816641417532, 5292.52367286946], "value": 4647.01058504181, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.5975953184605, 298.5894395206591, 302.2670025188918, 310.96890310968905, 316.7545152506807, 5398.514133727964, 5482.890342193154, 5583.83248502545, 5659.415363698161, 5682.289713785772, 4262.509811371693, 5472.452754724525, 5480.575050486872, 5481.616286859921, 5507.504324610784, 3615.511905892697, 4101.753894766323, 4189.999999999993, 4201.873943781691, 4210.115875666113, 3307.834608269577, 3468.618451970281, 3996.42051902474, 4114.436514124628, 4250.744955302676, 3261.5596894419305, 3829.8893320936895, 3924.95988563031, 3937.803109844511, 4167.249895018896, 4167.979160104211, 4174.686898482611, 4175.582441755831, 4215.641670458015, 4216.62050415461, 3658.487811706363, 3667.523221981152, 3674.393725035366, 3683.852645894161, 3697.3899306614376, 4505.977470112629, 4944.431390390115, 5119.462456442057, 5466.829239041386, 5467.906418716273, 4821.590164835993, 4823.421189457253, 4828.95171048292, 4834.0, 4841.2722203902795, 5852.209951656514, 5896.764129434818, 5899.764009439617, 5910.261217347832, 5940.702964851784, 3703.8518459261595, 3909.9218015639813, 3920.4511368408444, 3931.017245688578, 3942.6254505821903, 4845.854624361275, 6131.14164017038, 6141.0, 6210.0, 6221.44463884029, 3571.3035957988463, 4028.2749105160765, 4030.3475575014104, 4036.273470775289, 4046.6964977626794, 3745.045013521589, 3812.5424949006297, 3922.431247469101, 4036.6972477064337, 4085.7140000200293, 4411.823527058882, 4775.331453596499, 4814.975925120352, 4826.806927722922, 4848.224284114595, 4852.902941941212, 5235.502627250406, 5673.716314184357, 5893.823185304448, 5931.614445061144, 1287.3434548380394, 1298.0848501806204, 1346.299924039494, 1362.6457121148574, 1377.6831328794433, 791.8337149198618, 866.5017614871474, 905.9954700226457, 930.0559931669361, 935.5228833294932, 5457.645253058538, 5464.398916119224, 5469.960707465569, 5495.670259784426, 5507.394186639466, 5065.366829146356, 5532.6680399176175, 5979.5814292999075, 6038.365971573009, 6040.244969378828, 4770.570648641639, 5249.349078715224, 5440.510354068153, 5467.976848566056, 5479.890402192013, 2314.537092581457, 2582.5609646360163, 2601.5187190369843, 2623.1737002844043, 2673.639058727047, 4392.626626736763, 5123.410807757081, 5164.32863727713, 5199.870003249949, 5205.661631993984, 4389.200427824577, 5147.1507201312115, 5375.381831089475, 6041.969790151021, 6044.486218671462, 6357.650329231844, 6372.355472478869, 6377.904331435032, 6385.361463853577, 6418.807435776934, 5129.384473863011, 5912.629801013381, 6209.0996805462055, 6230.193243959382, 6267.749290028348, 5322.787088516416, 5993.3706960768495, 6079.270487541523, 6080.169493219243, 6133.26400831903, 5014.398272207359, 5293.708846013506, 5797.0, 6341.619502829845, 6398.104265402754, 3914.9021274468364, 3984.900377490586, 4021.3967904814513, 4038.2529232092156, 4055.3308704063497, 5351.678899266057, 6114.57197996136, 6164.445199932027, 6176.3514830943905, 6181.660008699385, 5782.335031471266, 5894.793682221101, 6004.028006136816, 6006.909896351645, 6065.363136870565, 4607.6313894889, 5548.361938377138, 5638.379778224474, 5853.248972982691, 6030.185924900258, 4792.7363994980615, 4961.950380496149, 5836.299644042742, 5862.325832529314, 5875.383084776208, 5221.608379371486, 5522.337319521683, 5967.850803729942, 6006.369331220334, 6048.758049678139, 5490.972545137249, 5821.27234095738, 5870.8258348329655, 5887.143920731927, 5891.558133139946], "value": 4202.212627287659, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [757.5909009135067, 758.9962050189745, 789.5736302396705, 792.7502836606465, 827.8492894876122, 15034.398624055038, 15072.849271507283, 15552.922235388807, 15588.844111558881, 15593.922030389833, 14108.717825643482, 14190.0, 14214.431422743104, 14214.644633884158, 14228.71542569148, 826.7395770332356, 863.4905405810571, 890.0165317324361, 892.6340200517789, 898.0, 853.8889944307232, 869.1569177897429, 870.1037930931151, 871.1114663043692, 872.7469033980138, 926.6061923682441, 933.6778811310121, 934.6915517879117, 935.9064093590621, 936.6534382278567, 874.1520724896872, 883.6421249394006, 916.5875356089787, 927.3601215161517, 927.6984979881565, 671.6171782084214, 687.3298533929429, 688.9758858439981, 689.152342618582, 689.1557841643996, 12467.625971220878, 15448.227588620524, 15477.0, 15493.380264789395, 15503.922480387639, 10302.536385862653, 12124.211926224856, 13405.46378144873, 14012.509562165376, 14410.567682969528, 11598.478068486855, 11650.0, 11984.940075299655, 12082.577109801203, 12387.75224495505, 3784.5080139581955, 3796.3925771876366, 3817.1220619257724, 3826.4834247376525, 3875.1280961783655, 87667.0, 112153.43923280331, 115391.0, 116310.0, 117127.0, 9243.676471323472, 10613.416262105504, 10995.780084398268, 11022.834657480144, 11324.886751132548, 20713.171473141207, 20833.06251218699, 20904.581908361746, 20967.47581310449, 20989.37031889046, 7806.92193078062, 7928.405369597303, 7969.800754981055, 8118.675252989814, 8175.468594541336, 4471.35165401015, 4519.728816270968, 4543.363929049936, 4568.017876156642, 4668.883277918079, 3479.8434070466888, 3557.5553055868018, 3599.9820000899826, 3617.656322649344, 3632.636736326346, 645.6481217736344, 657.4575974820792, 659.8779225843234, 674.4132604634, 674.7604600366898, 581.982540523785, 602.6083046020123, 633.3595986395259, 634.1122428599905, 667.1660424469413, 8531.189536993976, 8635.611397487128, 8806.823863522694, 8934.910650893538, 9308.0, 502.59038883309984, 598.7904233518234, 609.2445367743966, 616.1035693066577, 622.5455417545218, 3628.927421451609, 4021.678265738734, 4158.8336466541605, 4483.103379324149, 4560.95439045612, 94364.0, 96876.0, 97358.0, 153477.46522534854, 168463.0, 105667.4716626412, 110349.79300414107, 115168.12079698074, 119054.40472797581, 135358.0, 73800.63099684467, 101316.97366052784, 109929.45035274772, 117045.24432133525, 118777.40611296888, 7137.52352127117, 7788.065432148179, 8265.380096492667, 8475.533845638549, 8605.784855378666, 66243.33756662371, 66818.66590667015, 67033.0, 67967.32032679609, 68615.76420577016, 90308.0, 100727.0, 102767.0, 103931.0, 104646.47676761568, 10816.513256903616, 11197.432359469518, 11315.0, 11338.263012904135, 11585.942070289595, 12090.818637720266, 12108.515659373526, 12207.572734954234, 12295.385230738606, 12375.195612285173, 11658.70853228676, 11666.76666466649, 11684.357360344922, 11786.882131178578, 11797.115216358636, 11296.548138074386, 11423.371714555778, 11562.421878906189, 11781.941090294493, 11931.940340298243, 10694.304870183412, 11258.155638326994, 11340.489677964346, 11530.365829879438, 11768.235064720766, 8942.910570894208, 9021.188093071392, 9101.40840845343, 9304.860427093463, 9360.531973401166, 7916.129225785044, 8107.554084525408, 8139.959300203461, 8241.423100383156, 8391.496510209407], "value": 7443.910863222415, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1558.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 116.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 122.0], "value": 116.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 141.0, 141.0, 153.0, 144.0, 132.0, 142.0, 139.0, 136.0, 108.0], "value": 141.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [211.0, 197.0, 197.0, 199.0, 197.0, 197.0, 200.0, 207.0, 251.0, 199.0], "value": 205.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 59.0, 59.0, 88.0, 60.0, 62.0, 57.0, 60.0, 76.0, 58.0], "value": 66.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 58.0, 100.0, 104.0, 56.0, 91.0, 125.0, 101.0, 84.0, 85.0], "value": 89.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 88.0, 91.0, 87.0, 91.0, 93.0, 91.0, 88.0, 90.0, 89.0], "value": 89.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 122.0, 95.0, 98.0, 95.0, 95.0, 96.0, 97.0, 96.0, 97.0], "value": 104.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 96.0, 105.0, 126.0, 92.0, 128.0, 84.0, 140.0, 149.0, 126.0], "value": 113.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 55.0, 54.0, 56.0, 59.0, 90.0, 88.0, 87.0, 53.0], "value": 65.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 64.0, 79.0, 84.0, 79.0, 75.0, 70.0, 69.0, 70.0, 71.0], "value": 73.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 76.0, 90.0, 71.0, 95.0, 103.0, 107.0, 103.0, 84.0, 88.0], "value": 90.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 133.0, 142.0, 148.0, 154.0, 150.0, 176.0, 147.0, 176.0, 140.0], "value": 150.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 163.0, 150.0, 213.0, 222.0, 166.0, 165.0, 165.0, 170.0, 163.0], "value": 174.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 72.0, 71.0, 82.0, 88.0, 67.0, 79.0, 87.0, 84.0, 90.0], "value": 78.5, "unit": "score"}]}]} 02:12:13 INFO - Return code: 0 02:12:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:12:13 ERROR - # TBPL SUCCESS # 02:12:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:12:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:12:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:12:13 INFO - 2016-09-20 02:12:13.867 screenresolution[6759:116466] starting screenresolution argv=screenresolution get 02:12:13 INFO - 2016-09-20 02:12:13.869 screenresolution[6759:116466] Display 0: 1600x1200x32@60 02:12:13 INFO - 2016-09-20 02:12:13.876 screenresolution[6760:116469] starting screenresolution argv=screenresolution list 02:12:13 INFO - Available Modes on Display 0 02:12:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:12:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:12:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:12:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:12:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:12:14 INFO - Intel Iris: 02:12:14 INFO - Chipset Model: Intel Iris 02:12:14 INFO - Type: GPU 02:12:14 INFO - Bus: Built-In 02:12:14 INFO - VRAM (Dynamic, Max): 1536 MB 02:12:14 INFO - Vendor: Intel (0x8086) 02:12:14 INFO - Device ID: 0x0a2e 02:12:14 INFO - Revision ID: 0x0009 02:12:14 INFO - Displays: 02:12:14 INFO - Display: 02:12:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:12:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:12:14 INFO - Display Serial Number: 1600x1200 60 02:12:14 INFO - Main Display: Yes 02:12:14 INFO - Mirror: Off 02:12:14 INFO - Online: Yes 02:12:14 INFO - Rotation: Supported 02:12:14 INFO - Return code: 0 02:12:14 INFO - Running post-action listener: _resource_record_post_action 02:12:14 INFO - [mozharness: 2016-09-20 09:12:14.114591Z] Finished run-tests step (success) 02:12:14 INFO - Running post-run listener: _resource_record_post_run 02:12:14 INFO - Total resource usage - Wall time: 1207s; CPU: 54.0%; Read bytes: 324096; Write bytes: 668686848; Read time: 5; Write time: 1939 02:12:14 INFO - TinderboxPrint: CPU usage
54.5% 02:12:14 INFO - TinderboxPrint: I/O read bytes / time
324,096 / 5 02:12:14 INFO - TinderboxPrint: I/O write bytes / time
668,686,848 / 1,939 02:12:14 INFO - TinderboxPrint: CPU idle
2,197.7 (45.5%) 02:12:14 INFO - TinderboxPrint: CPU system
983.2 (20.4%) 02:12:14 INFO - TinderboxPrint: CPU user
1,648.9 (34.1%) 02:12:14 INFO - TinderboxPrint: Swap in / out
362,332,160 / 0 02:12:14 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 354509312; Write bytes: 354666496; Read time: 27776; Write time: 650 02:12:14 INFO - run-tests - Wall time: 1175s; CPU: 55.0%; Read bytes: 323584; Write bytes: 299072000; Read time: 5; Write time: 1144 02:12:14 INFO - Running post-run listener: _upload_blobber_files 02:12:14 INFO - Blob upload gear active. 02:12:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:12:14 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:12:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:12:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:12:14 INFO - (blobuploader) - INFO - Open directory for files ... 02:12:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:12:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:12:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:12:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:12:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:12:16 INFO - (blobuploader) - INFO - Done attempting. 02:12:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:12:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:12:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:12:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:12:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:12:17 INFO - (blobuploader) - INFO - Done attempting. 02:12:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:12:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:12:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:12:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:12:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:12:20 INFO - (blobuploader) - INFO - Done attempting. 02:12:20 INFO - (blobuploader) - INFO - Iteration through files over. 02:12:20 INFO - Return code: 0 02:12:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:12:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:12:20 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2ed2274b62024e9492f3ec0f95462a139b28875f66f7473ce8416b84b317acd1dae777e55457f79e1b48b139fa6775c36ab648ee9df74124661ce090b8cfc30d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3039ebf2a6943b615316162908456785b88a9abdcdc82e802efb907395428a4de86a40585015ecef0088800bc8a43786bc2cfd22fd46bfa50d9fa1bf9595673e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e9d238dcb4ce314f1004d754470856936e928ee6ef394db499564cbd08f71817ecd0a9d1a4c09e51df3cc36ab66f09334b5e9a1863a042c8af83ea8a5ea482bb"} 02:12:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:12:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:12:20 INFO - Contents: 02:12:20 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2ed2274b62024e9492f3ec0f95462a139b28875f66f7473ce8416b84b317acd1dae777e55457f79e1b48b139fa6775c36ab648ee9df74124661ce090b8cfc30d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3039ebf2a6943b615316162908456785b88a9abdcdc82e802efb907395428a4de86a40585015ecef0088800bc8a43786bc2cfd22fd46bfa50d9fa1bf9595673e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e9d238dcb4ce314f1004d754470856936e928ee6ef394db499564cbd08f71817ecd0a9d1a4c09e51df3cc36ab66f09334b5e9a1863a042c8af83ea8a5ea482bb"} 02:12:20 INFO - Running post-run listener: copy_logs_to_upload_dir 02:12:20 INFO - Copying logs to upload dir... 02:12:20 INFO - mkdir: /builds/slave/test/build/upload/logs 02:12:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.795548 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-09-20 02:12:20.383273) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-20 02:12:20.387386) ========= 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.JBo4VhXiJe/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.tZ77qm38mH/Listeners TMPDIR=/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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/2ed2274b62024e9492f3ec0f95462a139b28875f66f7473ce8416b84b317acd1dae777e55457f79e1b48b139fa6775c36ab648ee9df74124661ce090b8cfc30d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3039ebf2a6943b615316162908456785b88a9abdcdc82e802efb907395428a4de86a40585015ecef0088800bc8a43786bc2cfd22fd46bfa50d9fa1bf9595673e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e9d238dcb4ce314f1004d754470856936e928ee6ef394db499564cbd08f71817ecd0a9d1a4c09e51df3cc36ab66f09334b5e9a1863a042c8af83ea8a5ea482bb"} build_url:https://queue.taskcluster.net/v1/task/DIusKtKnRQi-LImv4L1tiQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011581 build_url: 'https://queue.taskcluster.net/v1/task/DIusKtKnRQi-LImv4L1tiQ/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/2ed2274b62024e9492f3ec0f95462a139b28875f66f7473ce8416b84b317acd1dae777e55457f79e1b48b139fa6775c36ab648ee9df74124661ce090b8cfc30d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3039ebf2a6943b615316162908456785b88a9abdcdc82e802efb907395428a4de86a40585015ecef0088800bc8a43786bc2cfd22fd46bfa50d9fa1bf9595673e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e9d238dcb4ce314f1004d754470856936e928ee6ef394db499564cbd08f71817ecd0a9d1a4c09e51df3cc36ab66f09334b5e9a1863a042c8af83ea8a5ea482bb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-20 02:12:20.423011) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 02:12:20.423439) ========= 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.JBo4VhXiJe/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.tZ77qm38mH/Listeners TMPDIR=/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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.004785 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 02:12:20.474054) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-20 02:12:20.474640) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-20 02:12:20.475274) ========= ========= Total master_lag: 0.19 =========