builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0385 starttime: 1483614919.31 results: success (0) buildid: 20170105012540 builduid: 8d06091bdfe641d38dc19589f60324f2 revision: 9a604441509654bd2bddc031545f4c7ae1787bd7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-05 03:15:19.305999) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-05 03:15:19.306420) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-05 03:15:19.306700) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-05 03:15:19.336190) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 03:15:19.336533) ========= 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.x7NwlGubV6/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.BbkNeL0Gmj/Listeners TMPDIR=/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-05 03:15:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 13.2M=0.001s 2017-01-05 03:15:19 (13.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.103496 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 03:15:19.463160) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 03:15:19.463468) ========= 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.x7NwlGubV6/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.BbkNeL0Gmj/Listeners TMPDIR=/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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.020031 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 03:15:19.511618) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-05 03:15:19.511980) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 9a604441509654bd2bddc031545f4c7ae1787bd7 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 9a604441509654bd2bddc031545f4c7ae1787bd7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.x7NwlGubV6/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.BbkNeL0Gmj/Listeners TMPDIR=/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-05 03:15:19,593 truncating revision to first 12 chars 2017-01-05 03:15:19,593 Setting DEBUG logging. 2017-01-05 03:15:19,593 attempt 1/10 2017-01-05 03:15:19,593 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/9a6044415096?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-05 03:15:20,896 unpacking tar archive at: mozilla-beta-9a6044415096/testing/mozharness/ program finished with exit code 0 elapsedTime=1.569619 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-05 03:15:21.138419) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-05 03:15:21.138742) ========= script_repo_revision: 9a604441509654bd2bddc031545f4c7ae1787bd7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-05 03:15:21.139152) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-05 03:15:21.139418) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-05 03:15:21.161379) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-01-05 03:15:21.161665) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.x7NwlGubV6/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.BbkNeL0Gmj/Listeners TMPDIR=/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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 03:15:21 INFO - MultiFileLogger online at 20170105 03:15:21 in /builds/slave/test 03:15:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 03:15:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:15:21 INFO - {'append_to_log': False, 03:15:21 INFO - 'base_work_dir': '/builds/slave/test', 03:15:21 INFO - 'blob_upload_branch': 'Mozilla-Beta', 03:15:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:15:21 INFO - 'branch': 'Mozilla-Beta', 03:15:21 INFO - 'buildbot_json_path': 'buildprops.json', 03:15:21 INFO - 'config_files': ('talos/mac_config.py',), 03:15:21 INFO - 'default_actions': ('clobber', 03:15:21 INFO - 'read-buildbot-config', 03:15:21 INFO - 'download-and-extract', 03:15:21 INFO - 'populate-webroot', 03:15:21 INFO - 'create-virtualenv', 03:15:21 INFO - 'install', 03:15:21 INFO - 'run-tests'), 03:15:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:15:21 INFO - 'download_minidump_stackwalk': True, 03:15:21 INFO - 'download_symbols': 'ondemand', 03:15:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:15:21 INFO - 'tooltool.py': '/tools/tooltool.py', 03:15:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:15:21 INFO - '/tools/misc-python/virtualenv.py')}, 03:15:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:15:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:15:21 INFO - 'installer_path': 'installer.exe', 03:15:21 INFO - 'log_level': 'info', 03:15:21 INFO - 'log_name': 'talos', 03:15:21 INFO - 'log_to_console': True, 03:15:21 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:15:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:15:21 INFO - 'opt_config_files': (), 03:15:21 INFO - 'pip_index': False, 03:15:21 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:15:21 INFO - 'cmd': ('bash', 03:15:21 INFO - '-c', 03:15:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:15:21 INFO - 'enabled': True, 03:15:21 INFO - 'halt_on_failure': False, 03:15:21 INFO - 'name': 'check_screen_resolution'},), 03:15:21 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:15:21 INFO - 'cmd': ('bash', 03:15:21 INFO - '-c', 03:15:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:15:21 INFO - 'enabled': True, 03:15:21 INFO - 'halt_on_failure': False, 03:15:21 INFO - 'name': 'check_screen_resolution'},), 03:15:21 INFO - 'run_cmd_checks_enabled': True, 03:15:21 INFO - 'sps_profile': False, 03:15:21 INFO - 'sps_profile_interval': 0, 03:15:21 INFO - 'suite': 'dromaeojs', 03:15:21 INFO - 'system_bits': '32', 03:15:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:15:21 INFO - 'title': 't-yosemite-r7-0385', 03:15:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:15:21 INFO - 'use_talos_json': True, 03:15:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:15:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:15:21 INFO - 'work_dir': 'build'} 03:15:21 INFO - [mozharness: 2017-01-05 11:15:21.369627Z] Running clobber step. 03:15:21 INFO - Running pre-action listener: _resource_record_pre_action 03:15:21 INFO - Running main action method: clobber 03:15:21 INFO - rmtree: /builds/slave/test/build 03:15:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:15:22 INFO - Running post-action listener: _resource_record_post_action 03:15:22 INFO - [mozharness: 2017-01-05 11:15:22.604788Z] Finished clobber step (success) 03:15:22 INFO - [mozharness: 2017-01-05 11:15:22.604907Z] Running read-buildbot-config step. 03:15:22 INFO - Running pre-action listener: _resource_record_pre_action 03:15:22 INFO - Running main action method: read_buildbot_config 03:15:22 INFO - Using buildbot properties: 03:15:22 INFO - { 03:15:22 INFO - "project": "", 03:15:22 INFO - "product": "firefox", 03:15:22 INFO - "script_repo_revision": "production", 03:15:22 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 03:15:22 INFO - "repository": "", 03:15:22 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 03:15:22 INFO - "buildid": "20170105012540", 03:15:22 INFO - "pgo_build": "False", 03:15:22 INFO - "basedir": "/builds/slave/test", 03:15:22 INFO - "buildnumber": 6, 03:15:22 INFO - "slavename": "t-yosemite-r7-0385", 03:15:22 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 03:15:22 INFO - "platform": "yosemite_r7", 03:15:22 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 03:15:22 INFO - "branch": "mozilla-beta", 03:15:22 INFO - "repo_path": "releases/mozilla-beta", 03:15:22 INFO - "revision": "9a604441509654bd2bddc031545f4c7ae1787bd7", 03:15:22 INFO - "stage_platform": "macosx64", 03:15:22 INFO - "builduid": "8d06091bdfe641d38dc19589f60324f2", 03:15:22 INFO - "slavebuilddir": "test" 03:15:22 INFO - } 03:15:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/DzXT7OL7RYGcpZi_ydcPUQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 03:15:22 INFO - Running post-action listener: _resource_record_post_action 03:15:22 INFO - [mozharness: 2017-01-05 11:15:22.608115Z] Finished read-buildbot-config step (success) 03:15:22 INFO - [mozharness: 2017-01-05 11:15:22.608223Z] Running download-and-extract step. 03:15:22 INFO - Running pre-action listener: _resource_record_pre_action 03:15:22 INFO - Running main action method: download_and_extract 03:15:22 INFO - mkdir: /builds/slave/test/build/tests 03:15:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:22 INFO - trying https://queue.taskcluster.net/v1/task/DzXT7OL7RYGcpZi_ydcPUQ/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 03:15:22 INFO - Downloading https://queue.taskcluster.net/v1/task/DzXT7OL7RYGcpZi_ydcPUQ/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 03:15:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DzXT7OL7RYGcpZi_ydcPUQ/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json'}, attempt #1 03:15:23 INFO - Downloaded 1165 bytes. 03:15:23 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 03:15:23 INFO - Using the following test package requirements: 03:15:23 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 03:15:23 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 03:15:23 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 03:15:23 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 03:15:23 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 03:15:23 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 03:15:23 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 03:15:23 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 03:15:23 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 03:15:23 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 03:15:23 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 03:15:23 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 03:15:23 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 03:15:23 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 03:15:23 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 03:15:23 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 03:15:23 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 03:15:23 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 03:15:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DzXT7OL7RYGcpZi_ydcPUQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 03:15:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DzXT7OL7RYGcpZi_ydcPUQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 03:15:23 INFO - Fetch https://queue.taskcluster.net/v1/task/DzXT7OL7RYGcpZi_ydcPUQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 03:15:24 INFO - Expected file size: 16234516 03:15:31 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip', u'firefox-51.0.en-US.mac.talos.tests.zip'] for test suite category: talos 03:15:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DzXT7OL7RYGcpZi_ydcPUQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 03:15:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DzXT7OL7RYGcpZi_ydcPUQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 03:15:31 INFO - Fetch https://queue.taskcluster.net/v1/task/DzXT7OL7RYGcpZi_ydcPUQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 03:15:31 INFO - Expected file size: 16234516 03:15:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DzXT7OL7RYGcpZi_ydcPUQ/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 03:15:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DzXT7OL7RYGcpZi_ydcPUQ/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 03:15:38 INFO - Fetch https://queue.taskcluster.net/v1/task/DzXT7OL7RYGcpZi_ydcPUQ/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 03:15:38 INFO - Expected file size: 14414089 03:15: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')]} 03:15:39 INFO - trying https://queue.taskcluster.net/v1/task/DzXT7OL7RYGcpZi_ydcPUQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg 03:15:39 INFO - Downloading https://queue.taskcluster.net/v1/task/DzXT7OL7RYGcpZi_ydcPUQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 03:15:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DzXT7OL7RYGcpZi_ydcPUQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg'}, attempt #1 03:15:41 INFO - Downloaded 86102134 bytes. 03:15:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DzXT7OL7RYGcpZi_ydcPUQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg 03:15:41 INFO - mkdir: /builds/slave/test/properties 03:15:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:15:41 INFO - Writing to file /builds/slave/test/properties/build_url 03:15:41 INFO - Contents: 03:15:41 INFO - build_url:https://queue.taskcluster.net/v1/task/DzXT7OL7RYGcpZi_ydcPUQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg 03:15:42 INFO - Running post-action listener: _resource_record_post_action 03:15:42 INFO - Running post-action listener: set_extra_try_arguments 03:15:42 INFO - [mozharness: 2017-01-05 11:15:42.574472Z] Finished download-and-extract step (success) 03:15:42 INFO - [mozharness: 2017-01-05 11:15:42.574611Z] Running populate-webroot step. 03:15:42 INFO - Running pre-action listener: _resource_record_pre_action 03:15:42 INFO - Running main action method: populate_webroot 03:15:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:15:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:15:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:15:42 INFO - '--tppagecycles', 03:15:42 INFO - '7'], 03:15:42 INFO - 'tests': ['tsvgm']}}, 03:15:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:15:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:15:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:15:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:15:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:15:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:15:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:42 INFO - 'talos_options': ['--disable-e10s'], 03:15:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:15:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:15:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:42 INFO - 'talos_options': ['--disable-e10s'], 03:15:42 INFO - 'tests': ['damp', 'tps']}, 03:15:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:42 INFO - 'tests': ['damp', 'tps']}, 03:15:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:15:42 INFO - 'tests': ['dromaeo_dom']}, 03:15:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:15:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:15:42 INFO - 'tests': ['basic_compositor_video']}, 03:15:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:15:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:15:42 INFO - 'tests': ['a11yr', 03:15:42 INFO - 'ts_paint', 03:15:42 INFO - 'tpaint', 03:15:42 INFO - 'sessionrestore', 03:15:42 INFO - 'sessionrestore_no_auto_restore', 03:15:42 INFO - 'tabpaint']}, 03:15:42 INFO - 'other-e10s': {'tests': ['a11yr', 03:15:42 INFO - 'ts_paint', 03:15:42 INFO - 'tpaint', 03:15:42 INFO - 'sessionrestore', 03:15:42 INFO - 'sessionrestore_no_auto_restore', 03:15:42 INFO - 'tabpaint']}, 03:15:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:15:42 INFO - 'ts_paint', 03:15:42 INFO - 'tpaint', 03:15:42 INFO - 'sessionrestore', 03:15:42 INFO - 'sessionrestore_no_auto_restore', 03:15:42 INFO - 'tabpaint']}, 03:15:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:15:42 INFO - 'ts_paint', 03:15:42 INFO - 'tpaint', 03:15:42 INFO - 'sessionrestore', 03:15:42 INFO - 'sessionrestore_no_auto_restore', 03:15:42 INFO - 'tabpaint']}, 03:15:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:15:42 INFO - 'tests': ['a11yr', 03:15:42 INFO - 'ts_paint', 03:15:42 INFO - 'tpaint', 03:15:42 INFO - 'sessionrestore', 03:15:42 INFO - 'sessionrestore_no_auto_restore', 03:15:42 INFO - 'tabpaint']}, 03:15:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:15:42 INFO - 'tests': ['a11yr', 03:15:42 INFO - 'ts_paint', 03:15:42 INFO - 'tpaint', 03:15:42 INFO - 'sessionrestore', 03:15:42 INFO - 'sessionrestore_no_auto_restore', 03:15:42 INFO - 'tabpaint']}, 03:15:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:15:42 INFO - 'tests': ['tsvgx', 03:15:42 INFO - 'tsvgr_opacity', 03:15:42 INFO - 'tart', 03:15:42 INFO - 'tscrollx', 03:15:42 INFO - 'cart']}, 03:15:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:15:42 INFO - 'tsvgr_opacity', 03:15:42 INFO - 'tart', 03:15:42 INFO - 'tscrollx', 03:15:42 INFO - 'cart']}, 03:15:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:42 INFO - 'talos_options': ['--disable-e10s'], 03:15:42 INFO - 'tests': ['tp5o']}, 03:15:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:42 INFO - 'tests': ['tp5o']}, 03:15:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:42 INFO - 'talos_options': ['--disable-e10s', 03:15:42 INFO - '--xperf_path', 03:15:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:15:42 INFO - 'tests': ['tp5n']}, 03:15:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:42 INFO - 'talos_options': ['--xperf_path', 03:15:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:15:42 INFO - 'tests': ['tp5n']}}, 03:15:42 INFO - 'talos.zip': {'path': '', 03:15:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:15:42 INFO - Running post-action listener: _resource_record_post_action 03:15:42 INFO - [mozharness: 2017-01-05 11:15:42.593325Z] Finished populate-webroot step (success) 03:15:42 INFO - [mozharness: 2017-01-05 11:15:42.593458Z] Running create-virtualenv step. 03:15:42 INFO - Running pre-action listener: _resource_record_pre_action 03:15:42 INFO - Running main action method: create_virtualenv 03:15:42 INFO - Creating virtualenv /builds/slave/test/build/venv 03:15:42 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 03:15:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:15:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:15:42 INFO - Using real prefix '/tools/python27' 03:15:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:15:43 INFO - Installing distribute.............................................................................................................................................................................................done. 03:15:46 INFO - Installing pip.................done. 03:15:46 INFO - Return code: 0 03:15:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:15:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:46 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 0x107268490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda825a22c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10707cd30>, '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 0x106ee2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107074b20>, '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.x7NwlGubV6/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.BbkNeL0Gmj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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 03:15:46 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 03:15:46 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 03:15:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.x7NwlGubV6/Render', 03:15:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:15:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:15:46 INFO - 'HOME': '/Users/cltbld', 03:15:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:15:46 INFO - 'LOGNAME': 'cltbld', 03:15:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:46 INFO - 'MOZ_NO_REMOTE': '1', 03:15:46 INFO - 'NO_EM_RESTART': '1', 03:15:46 INFO - 'PAGER': '/bin/cat', 03:15:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:15:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:46 INFO - 'PWD': '/builds/slave/test', 03:15:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:15:46 INFO - 'SHELL': '/bin/bash', 03:15:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BbkNeL0Gmj/Listeners', 03:15:46 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 03:15:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:15:46 INFO - 'USER': 'cltbld', 03:15:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:15:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:15:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:46 INFO - 'XPC_FLAGS': '0x0', 03:15:46 INFO - 'XPC_SERVICE_NAME': '0', 03:15:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:15:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:46 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 03:15:46 INFO - Cleaning up... 03:15:46 INFO - Return code: 0 03:15:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:15:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:46 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 0x107268490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda825a22c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10707cd30>, '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 0x106ee2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107074b20>, '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.x7NwlGubV6/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.BbkNeL0Gmj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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 03:15:46 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 03:15:46 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 03:15:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.x7NwlGubV6/Render', 03:15:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:15:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:15:46 INFO - 'HOME': '/Users/cltbld', 03:15:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:15:46 INFO - 'LOGNAME': 'cltbld', 03:15:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:46 INFO - 'MOZ_NO_REMOTE': '1', 03:15:46 INFO - 'NO_EM_RESTART': '1', 03:15:46 INFO - 'PAGER': '/bin/cat', 03:15:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:15:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:46 INFO - 'PWD': '/builds/slave/test', 03:15:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:15:46 INFO - 'SHELL': '/bin/bash', 03:15:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BbkNeL0Gmj/Listeners', 03:15:46 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 03:15:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:15:46 INFO - 'USER': 'cltbld', 03:15:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:15:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:15:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:46 INFO - 'XPC_FLAGS': '0x0', 03:15:46 INFO - 'XPC_SERVICE_NAME': '0', 03:15:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:15:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:46 INFO - Downloading/unpacking psutil>=3.1.1 03:15:46 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 03:15:46 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 03:15:46 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 03:15:46 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 03:15:46 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 03:15:46 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 03:15:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:15:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:15:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:15:50 INFO - Installing collected packages: psutil 03:15:50 INFO - Running setup.py install for psutil 03:15:50 INFO - building 'psutil._psutil_osx' extension 03:15:50 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 03:15:50 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 03:15:50 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 03:15:50 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 03:15:50 INFO - building 'psutil._psutil_posix' extension 03:15:50 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 03:15:50 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:15:50 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:15:50 INFO - ^ 03:15:50 INFO - 1 warning generated. 03:15:50 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 03:15:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:15:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:15:50 INFO - Successfully installed psutil 03:15:50 INFO - Cleaning up... 03:15:50 INFO - Return code: 0 03:15:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:15: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')]} 03:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15: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')]} 03:15:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107268490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda825a22c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10707cd30>, '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 0x106ee2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107074b20>, '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.x7NwlGubV6/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.BbkNeL0Gmj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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 03:15: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:15: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 mozsystemmonitor==0.3 03:15:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.x7NwlGubV6/Render', 03:15:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:15:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:15:50 INFO - 'HOME': '/Users/cltbld', 03:15:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:15:50 INFO - 'LOGNAME': 'cltbld', 03:15:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:50 INFO - 'MOZ_NO_REMOTE': '1', 03:15:50 INFO - 'NO_EM_RESTART': '1', 03:15:50 INFO - 'PAGER': '/bin/cat', 03:15:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:15:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:50 INFO - 'PWD': '/builds/slave/test', 03:15:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:15:50 INFO - 'SHELL': '/bin/bash', 03:15:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BbkNeL0Gmj/Listeners', 03:15:50 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 03:15:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:15:50 INFO - 'USER': 'cltbld', 03:15:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:15:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:15:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:50 INFO - 'XPC_FLAGS': '0x0', 03:15:50 INFO - 'XPC_SERVICE_NAME': '0', 03:15:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:15:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:15: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 03:15: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 03:15: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 03:15: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 03:15: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 03:15: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 03:15:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:15:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:15:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:15:53 INFO - Installing collected packages: mozsystemmonitor 03:15:53 INFO - Running setup.py install for mozsystemmonitor 03:15:54 INFO - Successfully installed mozsystemmonitor 03:15:54 INFO - Cleaning up... 03:15:54 INFO - Return code: 0 03:15:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:15:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:54 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 0x107268490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda825a22c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10707cd30>, '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 0x106ee2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107074b20>, '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.x7NwlGubV6/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.BbkNeL0Gmj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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 03:15:54 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 03:15:54 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 03:15:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.x7NwlGubV6/Render', 03:15:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:15:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:15:54 INFO - 'HOME': '/Users/cltbld', 03:15:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:15:54 INFO - 'LOGNAME': 'cltbld', 03:15:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:54 INFO - 'MOZ_NO_REMOTE': '1', 03:15:54 INFO - 'NO_EM_RESTART': '1', 03:15:54 INFO - 'PAGER': '/bin/cat', 03:15:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:15:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:54 INFO - 'PWD': '/builds/slave/test', 03:15:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:15:54 INFO - 'SHELL': '/bin/bash', 03:15:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BbkNeL0Gmj/Listeners', 03:15:54 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 03:15:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:15:54 INFO - 'USER': 'cltbld', 03:15:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:15:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:15:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:54 INFO - 'XPC_FLAGS': '0x0', 03:15:54 INFO - 'XPC_SERVICE_NAME': '0', 03:15:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:15:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:54 INFO - Downloading/unpacking jsonschema==2.5.1 03:15: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 03:15: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 03:15: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 03:15: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 03:15: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 03:15: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 03:15:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:15:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:15:56 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 03:15:56 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 03:15:56 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 03:15:56 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 03:15:56 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 03:15:56 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 03:15:57 INFO - Downloading functools32-3.2.3-2.tar.gz 03:15:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:15:57 INFO - warning: no files found matching '*.txt' 03:15:57 INFO - no previously-included directories found matching 'build' 03:15:57 INFO - no previously-included directories found matching 'dist' 03:15:57 INFO - no previously-included directories found matching '.git*' 03:15:57 INFO - Installing collected packages: jsonschema, functools32 03:15:57 INFO - Running setup.py install for functools32 03:15:57 INFO - warning: no files found matching '*.txt' 03:15:57 INFO - no previously-included directories found matching 'build' 03:15:57 INFO - no previously-included directories found matching 'dist' 03:15:57 INFO - no previously-included directories found matching '.git*' 03:15:57 INFO - Successfully installed jsonschema functools32 03:15:57 INFO - Cleaning up... 03:15:57 INFO - Return code: 0 03:15:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:15:57 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')]} 03:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:57 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')]} 03:15:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:57 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 0x107268490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda825a22c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10707cd30>, '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 0x106ee2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107074b20>, '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.x7NwlGubV6/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.BbkNeL0Gmj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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 03:15:57 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 03:15:57 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 03:15:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.x7NwlGubV6/Render', 03:15:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:15:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:15:57 INFO - 'HOME': '/Users/cltbld', 03:15:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:15:57 INFO - 'LOGNAME': 'cltbld', 03:15:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:57 INFO - 'MOZ_NO_REMOTE': '1', 03:15:57 INFO - 'NO_EM_RESTART': '1', 03:15:57 INFO - 'PAGER': '/bin/cat', 03:15:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:15:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:57 INFO - 'PWD': '/builds/slave/test', 03:15:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:15:57 INFO - 'SHELL': '/bin/bash', 03:15:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BbkNeL0Gmj/Listeners', 03:15:57 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 03:15:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:15:57 INFO - 'USER': 'cltbld', 03:15:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:15:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:15:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:57 INFO - 'XPC_FLAGS': '0x0', 03:15:57 INFO - 'XPC_SERVICE_NAME': '0', 03:15:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:15:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:15:58 INFO - Cleaning up... 03:15:58 INFO - Return code: 0 03:15:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:15:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:58 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 0x107268490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda825a22c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10707cd30>, '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 0x106ee2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107074b20>, '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.x7NwlGubV6/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.BbkNeL0Gmj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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 03:15:58 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 03:15:58 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 03:15:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.x7NwlGubV6/Render', 03:15:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:15:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:15:58 INFO - 'HOME': '/Users/cltbld', 03:15:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:15:58 INFO - 'LOGNAME': 'cltbld', 03:15:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:58 INFO - 'MOZ_NO_REMOTE': '1', 03:15:58 INFO - 'NO_EM_RESTART': '1', 03:15:58 INFO - 'PAGER': '/bin/cat', 03:15:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:15:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:58 INFO - 'PWD': '/builds/slave/test', 03:15:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:15:58 INFO - 'SHELL': '/bin/bash', 03:15:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BbkNeL0Gmj/Listeners', 03:15:58 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 03:15:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:15:58 INFO - 'USER': 'cltbld', 03:15:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:15:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:15:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:58 INFO - 'XPC_FLAGS': '0x0', 03:15:58 INFO - 'XPC_SERVICE_NAME': '0', 03:15:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:15:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:58 INFO - Downloading/unpacking blobuploader==1.2.4 03:15:58 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 03:15:58 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 03:15:58 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 03:15:58 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 03:15:58 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 03:15:58 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 03:16:00 INFO - Downloading blobuploader-1.2.4.tar.gz 03:16:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:16:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:16:01 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 03:16:01 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 03:16:01 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 03:16:01 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 03:16:01 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 03:16:01 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 03:16:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:16:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:16:01 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 03:16:01 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 03:16:01 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 03:16:01 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 03:16:01 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 03:16:01 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 03:16:02 INFO - Downloading docopt-0.6.1.tar.gz 03:16:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:16:02 INFO - Installing collected packages: blobuploader, requests, docopt 03:16:02 INFO - Running setup.py install for blobuploader 03:16:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:16:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:16:02 INFO - Running setup.py install for requests 03:16:02 INFO - Running setup.py install for docopt 03:16:02 INFO - Successfully installed blobuploader requests docopt 03:16:02 INFO - Cleaning up... 03:16:03 INFO - Return code: 0 03:16:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:16:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:03 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 0x107268490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda825a22c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10707cd30>, '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 0x106ee2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107074b20>, '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.x7NwlGubV6/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.BbkNeL0Gmj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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 03:16:03 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 03:16:03 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 03:16:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.x7NwlGubV6/Render', 03:16:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:16:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:16:03 INFO - 'HOME': '/Users/cltbld', 03:16:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:16:03 INFO - 'LOGNAME': 'cltbld', 03:16:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:03 INFO - 'MOZ_NO_REMOTE': '1', 03:16:03 INFO - 'NO_EM_RESTART': '1', 03:16:03 INFO - 'PAGER': '/bin/cat', 03:16:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:16:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:03 INFO - 'PWD': '/builds/slave/test', 03:16:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:16:03 INFO - 'SHELL': '/bin/bash', 03:16:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BbkNeL0Gmj/Listeners', 03:16:03 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 03:16:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:16:03 INFO - 'USER': 'cltbld', 03:16:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:16:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:16:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:03 INFO - 'XPC_FLAGS': '0x0', 03:16:03 INFO - 'XPC_SERVICE_NAME': '0', 03:16:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:16:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:16:03 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-mYZWUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:16:03 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-6fqp6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:16:03 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-rJkn7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:16:03 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-xds_Ei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:16:03 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-hs47Ov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:16:03 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-9XQ6_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:16:03 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-PADaeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:16:04 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-5RNZqp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:16:04 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-qaufyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:16:04 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-Oww3iL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:16:04 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-R6_CZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:16:04 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-IMT5P4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:16:04 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-As9XEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:16:04 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-06eiqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:16:04 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-tYe50J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:16:04 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-t8EgVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:16:05 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-HJ0lmR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:16:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:16:05 INFO - Running setup.py install for manifestparser 03:16:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:16:05 INFO - Running setup.py install for mozcrash 03:16:05 INFO - Running setup.py install for mozdebug 03:16:05 INFO - Running setup.py install for mozdevice 03:16:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:16:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:16:05 INFO - Running setup.py install for mozfile 03:16:05 INFO - Running setup.py install for mozhttpd 03:16:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:16:06 INFO - Running setup.py install for mozinfo 03:16:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:16:06 INFO - Running setup.py install for mozInstall 03:16:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:16:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:16:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:16:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:16:06 INFO - Running setup.py install for mozleak 03:16:06 INFO - Running setup.py install for mozlog 03:16:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:16:06 INFO - Running setup.py install for moznetwork 03:16:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:16:06 INFO - Running setup.py install for mozprocess 03:16:06 INFO - Running setup.py install for mozprofile 03:16:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:16:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:16:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:16:07 INFO - Running setup.py install for mozrunner 03:16:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:16:07 INFO - Running setup.py install for mozscreenshot 03:16:07 INFO - Running setup.py install for moztest 03:16:07 INFO - Running setup.py install for mozversion 03:16:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:16:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:16:07 INFO - Cleaning up... 03:16:07 INFO - Return code: 0 03:16:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:16:07 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')]} 03:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:07 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')]} 03:16:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:07 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 0x107268490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda825a22c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10707cd30>, '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 0x106ee2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107074b20>, '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.x7NwlGubV6/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.BbkNeL0Gmj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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 03:16:07 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 03:16:07 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 03:16:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.x7NwlGubV6/Render', 03:16:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:16:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:16:07 INFO - 'HOME': '/Users/cltbld', 03:16:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:16:07 INFO - 'LOGNAME': 'cltbld', 03:16:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:07 INFO - 'MOZ_NO_REMOTE': '1', 03:16:07 INFO - 'NO_EM_RESTART': '1', 03:16:07 INFO - 'PAGER': '/bin/cat', 03:16:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:16:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:07 INFO - 'PWD': '/builds/slave/test', 03:16:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:16:07 INFO - 'SHELL': '/bin/bash', 03:16:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BbkNeL0Gmj/Listeners', 03:16:07 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 03:16:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:16:07 INFO - 'USER': 'cltbld', 03:16:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:16:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:16:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:07 INFO - 'XPC_FLAGS': '0x0', 03:16:07 INFO - 'XPC_SERVICE_NAME': '0', 03:16:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:16:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:16:07 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-D4g_KE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:16:08 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)) 03:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:16:08 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-9HHh9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:16:08 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)) 03:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:16:08 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-2YebpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:16:08 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)) 03:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:16:08 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-eDxs6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:16:08 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)) 03:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:16:08 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-v6HF5_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:16:08 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)) 03:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:16:08 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-9vkNCP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:16:08 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)) 03:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:16:08 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-C2FOzx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:16:08 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)) 03:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:16:08 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-i0zRw4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:16:08 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)) 03:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:16:08 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-7rlZSU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:16:08 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)) 03:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:16:08 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-NYXDnS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:16:09 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)) 03:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:16:09 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-1KTHj7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:16:09 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)) 03:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:16:09 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-xad71W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:16:09 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)) 03:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:16:09 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-P3CBjM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:16:09 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)) 03:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:16:09 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-6xXJaB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:16:09 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)) 03:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:16:09 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-YPPkJ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:16:09 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)) 03:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:16:09 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-WMpyqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:16:09 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)) 03:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:16:09 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-brLElS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:16:09 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)) 03:16:09 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)) 03:16:09 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)) 03:16:09 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)) 03:16:09 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)) 03:16:09 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)) 03:16:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:16:09 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 03:16:09 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 03:16:09 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 03:16:09 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 03:16:09 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 03:16:09 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 03:16:12 INFO - Downloading blessings-1.6.tar.gz 03:16:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:16:12 INFO - Installing collected packages: blessings 03:16:12 INFO - Running setup.py install for blessings 03:16:12 INFO - Successfully installed blessings 03:16:12 INFO - Cleaning up... 03:16:12 INFO - Return code: 0 03:16:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:16:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:16:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:16:13 INFO - Reading from file tmpfile_stdout 03:16:13 INFO - Current package versions: 03:16:13 INFO - blessings == 1.6 03:16:13 INFO - blobuploader == 1.2.4 03:16:13 INFO - docopt == 0.6.1 03:16:13 INFO - functools32 == 3.2.3-2 03:16:13 INFO - jsonschema == 2.5.1 03:16:13 INFO - manifestparser == 1.1 03:16:13 INFO - mozInstall == 1.12 03:16:13 INFO - mozcrash == 0.17 03:16:13 INFO - mozdebug == 0.1 03:16:13 INFO - mozdevice == 0.48 03:16:13 INFO - mozfile == 1.2 03:16:13 INFO - mozhttpd == 0.7 03:16:13 INFO - mozinfo == 0.9 03:16:13 INFO - mozleak == 0.1 03:16:13 INFO - mozlog == 3.4 03:16:13 INFO - moznetwork == 0.27 03:16:13 INFO - mozprocess == 0.23 03:16:13 INFO - mozprofile == 0.28 03:16:13 INFO - mozrunner == 6.12 03:16:13 INFO - mozscreenshot == 0.1 03:16:13 INFO - mozsystemmonitor == 0.3 03:16:13 INFO - moztest == 0.7 03:16:13 INFO - mozversion == 1.4 03:16:13 INFO - psutil == 3.1.1 03:16:13 INFO - requests == 1.2.3 03:16:13 INFO - wsgiref == 0.1.2 03:16:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:16:13 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')]} 03:16:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:13 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')]} 03:16:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:13 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 0x107268490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda825a22c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10707cd30>, '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 0x106ee2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107074b20>, '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.x7NwlGubV6/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.BbkNeL0Gmj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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 03:16:13 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 03:16:13 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 03:16:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.x7NwlGubV6/Render', 03:16:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:16:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:16:13 INFO - 'HOME': '/Users/cltbld', 03:16:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:16:13 INFO - 'LOGNAME': 'cltbld', 03:16:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:13 INFO - 'MOZ_NO_REMOTE': '1', 03:16:13 INFO - 'NO_EM_RESTART': '1', 03:16:13 INFO - 'PAGER': '/bin/cat', 03:16:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:16:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:13 INFO - 'PWD': '/builds/slave/test', 03:16:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:16:13 INFO - 'SHELL': '/bin/bash', 03:16:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BbkNeL0Gmj/Listeners', 03:16:13 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 03:16:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:16:13 INFO - 'USER': 'cltbld', 03:16:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:16:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:16:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:13 INFO - 'XPC_FLAGS': '0x0', 03:16:13 INFO - 'XPC_SERVICE_NAME': '0', 03:16:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:16:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:13 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)) 03:16:13 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)) 03:16:13 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)) 03:16:13 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)) 03:16:13 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)) 03:16:13 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)) 03:16:13 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)) 03:16:13 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)) 03:16:13 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)) 03:16:13 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)) 03:16:13 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)) 03:16:13 INFO - Cleaning up... 03:16:13 INFO - Return code: 0 03:16:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:16:13 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')]} 03:16:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:13 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')]} 03:16:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:13 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 0x107268490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda825a22c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10707cd30>, '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 0x106ee2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107074b20>, '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.x7NwlGubV6/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.BbkNeL0Gmj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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 03:16:13 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 03:16:13 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 03:16:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.x7NwlGubV6/Render', 03:16:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:16:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:16:13 INFO - 'HOME': '/Users/cltbld', 03:16:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:16:13 INFO - 'LOGNAME': 'cltbld', 03:16:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:13 INFO - 'MOZ_NO_REMOTE': '1', 03:16:13 INFO - 'NO_EM_RESTART': '1', 03:16:13 INFO - 'PAGER': '/bin/cat', 03:16:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:16:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:13 INFO - 'PWD': '/builds/slave/test', 03:16:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:16:13 INFO - 'SHELL': '/bin/bash', 03:16:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BbkNeL0Gmj/Listeners', 03:16:13 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 03:16:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:16:13 INFO - 'USER': 'cltbld', 03:16:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:16:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:16:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:13 INFO - 'XPC_FLAGS': '0x0', 03:16:13 INFO - 'XPC_SERVICE_NAME': '0', 03:16:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:16:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:16:13 INFO - Cleaning up... 03:16:13 INFO - Return code: 0 03:16:13 INFO - Running post-action listener: _resource_record_post_action 03:16:13 INFO - Running post-action listener: _start_resource_monitoring 03:16:13 INFO - Starting resource monitoring. 03:16:13 INFO - [mozharness: 2017-01-05 11:16:13.639389Z] Finished create-virtualenv step (success) 03:16:13 INFO - [mozharness: 2017-01-05 11:16:13.640398Z] Running install step. 03:16:13 INFO - Running pre-action listener: _resource_record_pre_action 03:16:13 INFO - Running main action method: install 03:16:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:16:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:16:13 INFO - Reading from file tmpfile_stdout 03:16:13 INFO - Detecting whether we're running mozinstall >=1.0... 03:16:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:16:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:16:13 INFO - Reading from file tmpfile_stdout 03:16:13 INFO - Output received: 03:16:13 INFO - Usage: mozinstall [options] installer 03:16:13 INFO - Options: 03:16:13 INFO - -h, --help show this help message and exit 03:16:13 INFO - -d DEST, --destination=DEST 03:16:13 INFO - Directory to install application into. [default: 03:16:13 INFO - "/builds/slave/test"] 03:16:13 INFO - --app=APP Application being installed. [default: firefox] 03:16:14 INFO - mkdir: /builds/slave/test/build/application 03:16:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:16:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.mac.dmg --destination /builds/slave/test/build/application 03:16:36 INFO - Reading from file tmpfile_stdout 03:16:36 INFO - Output received: 03:16:36 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 03:16:36 INFO - Running post-action listener: _resource_record_post_action 03:16:36 INFO - [mozharness: 2017-01-05 11:16:36.104542Z] Finished install step (success) 03:16:36 INFO - [mozharness: 2017-01-05 11:16:36.104676Z] Running run-tests step. 03:16:36 INFO - Running pre-action listener: _resource_record_pre_action 03:16:36 INFO - Running main action method: run_tests 03:16:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:16:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:16:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:16:36 INFO - 2017-01-05 03:16:36.119 screenresolution[1897:11235] starting screenresolution argv=screenresolution get 03:16:36 INFO - 2017-01-05 03:16:36.122 screenresolution[1897:11235] Display 0: 1600x1200x32@60 03:16:36 INFO - 2017-01-05 03:16:36.127 screenresolution[1898:11238] starting screenresolution argv=screenresolution list 03:16:36 INFO - Available Modes on Display 0 03:16:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:16:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:16:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:16:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:16:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:16:36 INFO - Intel Iris: 03:16:36 INFO - Chipset Model: Intel Iris 03:16:36 INFO - Type: GPU 03:16:36 INFO - Bus: Built-In 03:16:36 INFO - VRAM (Dynamic, Max): 1536 MB 03:16:36 INFO - Vendor: Intel (0x8086) 03:16:36 INFO - Device ID: 0x0a2e 03:16:36 INFO - Revision ID: 0x0009 03:16:36 INFO - Displays: 03:16:36 INFO - Display: 03:16:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:16:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:16:36 INFO - Display Serial Number: 1600x1200 60 03:16:36 INFO - Main Display: Yes 03:16:36 INFO - Mirror: Off 03:16:36 INFO - Online: Yes 03:16:36 INFO - Rotation: Supported 03:16:36 INFO - Return code: 0 03:16:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:16:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:16:36 INFO - Python 2.7.3 03:16:36 INFO - Return code: 0 03:16:36 INFO - grabbing minidump binary from tooltool 03:16:36 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')]} 03:16:36 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 0x10707cd30>, '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 0x106ee2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107074b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:16:36 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 03:16:36 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 03:16:36 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 03:16:36 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:16:36 INFO - Return code: 0 03:16:36 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:16:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:16:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:16:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:16:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:16:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DzXT7OL7RYGcpZi_ydcPUQ/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0385', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:16:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DzXT7OL7RYGcpZi_ydcPUQ/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0385 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:16:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.x7NwlGubV6/Render', 03:16:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:16:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:16:36 INFO - 'HOME': '/Users/cltbld', 03:16:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:16:36 INFO - 'LOGNAME': 'cltbld', 03:16:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:16:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:16:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:36 INFO - 'MOZ_NO_REMOTE': '1', 03:16:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:16:36 INFO - 'NO_EM_RESTART': '1', 03:16:36 INFO - 'PAGER': '/bin/cat', 03:16:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:16:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:36 INFO - 'PWD': '/builds/slave/test', 03:16:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:16:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:16:36 INFO - 'SHELL': '/bin/bash', 03:16:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BbkNeL0Gmj/Listeners', 03:16:36 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 03:16:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:16:36 INFO - 'USER': 'cltbld', 03:16:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:16:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:16:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:36 INFO - 'XPC_FLAGS': '0x0', 03:16:36 INFO - 'XPC_SERVICE_NAME': '0', 03:16:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:16:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DzXT7OL7RYGcpZi_ydcPUQ/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0385', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:16:36 INFO - mozversion application_buildid: 20170105012540 03:16:36 INFO - mozversion application_changeset: 9a604441509654bd2bddc031545f4c7ae1787bd7 03:16:36 INFO - mozversion application_display_name: Firefox 03:16:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:16:36 INFO - mozversion application_name: Firefox 03:16:36 INFO - mozversion application_remotingname: firefox 03:16:36 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 03:16:36 INFO - mozversion application_vendor: Mozilla 03:16:36 INFO - mozversion application_version: 51.0 03:16:36 INFO - mozversion platform_buildid: 20170105012540 03:16:36 INFO - mozversion platform_changeset: 9a604441509654bd2bddc031545f4c7ae1787bd7 03:16:36 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 03:16:36 INFO - mozversion platform_version: 51.0 03:16:36 INFO - using testdate: 1483614996 03:16:36 INFO - actual date: 1483614996 03:16:36 INFO - starting webserver on 'localhost:49472' 03:16:36 INFO - SUITE-START | Running 2 tests 03:16:36 INFO - TEST-START | dromaeo_css 03:16:36 INFO - operating with platform_type : mac_ 03:16:36 INFO - Initialising browser for dromaeo_css test... 03:16:36 INFO - TEST-INFO | started process 1908 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/tmpb_kx02/profile http://localhost:49472/getInfo.html) 03:16:39 INFO - PROCESS | 1908 | __metrics Screen width/height:1600/1200 03:16:39 INFO - PROCESS | 1908 | colorDepth:24 03:16:39 INFO - PROCESS | 1908 | Browser inner width/height: 1024/689 03:16:39 INFO - PROCESS | 1908 | __metrics 03:16:39 INFO - PROCESS | 1908 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:16:39 INFO - PROCESS | 1908 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:16:39 INFO - TEST-INFO | 1908: exit 0 03:16:39 INFO - Browser initialized. 03:16:39 INFO - Running cycle 1/1 for dromaeo_css test... 03:16:39 INFO - TEST-INFO | started process 1911 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/tmpb_kx02/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:16:51 INFO - PROCESS | 1911 | RSS: Main: 168312832 03:16:51 INFO - PROCESS | 1911 | 03:17:43 INFO - PROCESS | 1911 | 1483615063174 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] 03:19:53 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:49472/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49472/tests/dromaeo/cssquery-ext.html) 03:19:54 INFO - PROCESS | 1911 | RSS: Main: 317976576 03:19:54 INFO - PROCESS | 1911 | 03:22:57 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:49472/tests/dromaeo/cssquery-ext.html (next: http://localhost:49472/tests/dromaeo/cssquery-jquery.html) 03:22:58 INFO - PROCESS | 1911 | RSS: Main: 302493696 03:22:58 INFO - PROCESS | 1911 | 03:26:00 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:49472/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49472/tests/dromaeo/cssquery-mootools.html) 03:26:01 INFO - PROCESS | 1911 | RSS: Main: 281456640 03:26:01 INFO - PROCESS | 1911 | 03:29:03 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:49472/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49472/tests/dromaeo/cssquery-prototype.html) 03:29:04 INFO - PROCESS | 1911 | RSS: Main: 269234176 03:29:04 INFO - PROCESS | 1911 | 03:32:07 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:49472/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49472/tests/dromaeo/cssquery-yui.html) 03:32:08 INFO - PROCESS | 1911 | RSS: Main: 260796416 03:32:08 INFO - PROCESS | 1911 | 03:35:11 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:49472/tests/dromaeo/cssquery-yui.html (next: http://localhost:49472/tests/dromaeo/cssquery-dojo.html) 03:35:11 INFO - PROCESS | 1911 | RSS: Main: 355946496 03:35:11 INFO - PROCESS | 1911 | 03:35:11 INFO - PROCESS | 1911 | __start_tp_report 03:35:11 INFO - PROCESS | 1911 | _x_x_mozilla_page_load 03:35:11 INFO - PROCESS | 1911 | _x_x_mozilla_page_load_details 03:35:11 INFO - PROCESS | 1911 | |i|pagename|runs| 03:35:11 INFO - PROCESS | 1911 | |0;dojo.html;3381.0026042317513;3407.25040491092;3434.8454319555617;3439.346524160411;3482.7910325380462;5637.154426835971;5665.745041473133;5686.886262274762;5690.630109042914;5712.285964254468;5642.915356269659;5731.14032895066;5732.828015159552;5735.741891614877;5740.225069615601;5201.947980520203;5209.817656382027;5211.895762084747;5243.187305967581;5253.369595648527;5145.228215767627;5168.586513078944;5170.327857378555;5287.841364759063;5292.232626269189;5127.102757017526;5170.896582068356;5180.2488639147305;5194.63637545372;5206.297149884755;5208.791648334081;5225.790968361261;5289.021531016736;5291.3385826771655;5325.840224793263;5155.845324640267;5181.611379146579;5204.4014938281825;5221.608379371524;5224.294720212761;5545.1682247663175;5565.332160140809;5616.63491873031;5616.887662246773;5647.124695672177;6104.298005729309;6127.080937859312;6141.631502109843;6152;6153.692315384257;6274.341194174592;6285.340039295899;6307.4954003679595;6323.74705011799;6326.304106548276;5629.4652008059575;5684.175794509855;5685.943140568624;5733.799317023884;5766.135079738031;6304.621722696653;6307.432331090224;6311.431971122621;6322.747090116344;6324.747010119636;6133.570650054543;6139;6145.569810113249;6150.384961503813;6167.568270221132;5087.8982420351385;6092.573519853657;6120.751898419022;6141.433934346803;6262.5616206866;6135.937063216329;6209.96895015522;6226;6226.1905952225925;6229.56393052482;5241.528262456397;6185.938140618626;6197.81406557804;6249.062640603855;6279.905801412982;4864.148773964542;4901.852944411602;4988.850334489971;4995.300657907896;5004.824831130893;4387.714798538085;4462.263726485158;4466.642668586505;4467.01725620363;4468.218061839165;5821.214136091573;5831.125331200269;5840.211571437886;5844.795432159854;5862.384449632812;6263.185785847811;6287.874242515124;6292.370762923671;6305.243370795442;6307.24313082433;5609.4390560943575;5651.943480565224;5658.91511627326;5683.886322273532;5709.000924838137;5379.54273886724;5415.323084614423;5416.431274716098;5421.078416669176;5461.617686761968;6284.811455656338;6293.465055470153;6299.0866324382705;6299.0866324382705;6306.432421082125;6105.725242364193;6132.5084813409785;6207.286162091417;6263.467605253422;6275.403836635513;6223.284322302993;6272.8118156455375;6293.150424692608;6293.874122517615;6314.494840412848;6171.722272497658;6181.907271391023;6193.4425901669065;6206.627602343874;6207.906881396692;6206.751729930752;6255.906161407492;6261.655608941552;6285.59143655661;6286.937130628635;5938.584299099194;5966.284045914518;6014.48876845473;6045.304789949212;6102.694865256808;5191.377034755854;6063.909041364295;6108.281362586102;6140.872371569611;6145.907811382744;5981.401859813984;5998.190244317136;6001.06983417571;6001.789937352171;6006.909896351471;5808.767649293981;5812.622179558315;5936.673482958478;5979.252593425822;6045.063015232646;5729.942700572941;5761.884762304814;5772.365039845529;5773.97113014449;5806.709664516842 03:35:11 INFO - PROCESS | 1911 | |1;ext.html;473.68263263613386;474.6748477293053;536.6619030011095;558.5392051557466;565.3780841074819;32087.358252834958;32780.01659950199;34130.829345853235;34168.82915585425;34206.65793342066;33876.66123338766;35071.29857402851;36263.63736362635;42807;44305.8923526912;9831;9990.45052522111;9992.650257240997;9998.45008524531;10022.899771002307;9716.125548700651;9823.50882455878;9825;9827.459489728062;9847.950760246189;9256.537173141349;9456.952715236448;9465.432074075577;9821.901780982205;9856.457894815781;9406.200472959807;9488.905110948906;12084.154109212359;12397.566085186974;12428.502859885593;12155.270683758914;12257.387130643432;12258.938705306506;12259.570915017932;12265.570705025371;41611.79194104041;41982;42043;42099.579004209874;42139.367909481385;3622.6739593436455;3774.5093137892172;3947.388154836005;4109.034376921421;4117.958820411787;29908.55137172944;30998.690013099807;31344.21639459009;33002.17494562631;33246.50130248024;3422.9315413691834;3447.9310413791836;3459.3254315408503;3560.305740380627;3567.839447224855;502492;508250;509489;509696;509738.4513077448;34719.479207811906;35387.469187962204;35543.466847997304;61402;61613.69193154005;36400.45399319012;36481.81759091187;36481.817590912404;36528.26943461116;36605.08487287786;15755.684886302439;15897.205139742966;15924.92037539828;15926.442574509836;15931.12378819153;13427.060105792501;13530.932345338408;13531.45874165042;13533.255670938193;13538.864611353958;8012;8030.357571394275;8044.155363686846;8087.676492940334;8119.350451963947;3147.7009684080435;3227.9193020174685;3345.8494367753024;3358.026172410023;3363.5963684358035;916.2120576304372;960.4525420510382;1031.9742006449899;1049.0872940541624;1071.239420011785;27860.442791144065;29773.702262977095;29964.550531742043;31082.689173107978;31737.682623173936;907.1336873285996;936.3726303376754;1106.0598491282346;1155.058627218814;1174.9236299640668;15125.621859453602;15550.76673849893;15570.532884013497;15593.986390884556;15845.841541584437;721820;726743;726919;728177;728344;58193.836123277295;58444.415555844746;58584.41415585875;58601.41398586045;58674.70662646659;1293.1723696834033;1306.6667999660026;1329.268902103839;1347.632153364336;1382.6405134664858;30164.396712066075;31358.05925822229;31484.37031259316;31583.89456369108;32060.877869274464;50549.74725126351;51173.744131279105;51330.97338053143;51333.63664088594;51342;609943;615548;616090;879446;898409;26716.599251010863;26865.731342687104;27114.45771084528;27343.86328068347;27627.447451050466;47037;47135.29297060478;47341.526584733714;47581.762091189325;48057.519424806706;35256.82371588228;38593.47427251659;38828.22343553056;39026.82919512306;40199.59800401959;39078;39300.410493843185;39596;40175.397369040074;41263;37682.62317376791;39180.804095979336;39320.60679393169;39583.40624890687;39683;33309.83345083259;34034.31931361408;34244.14389640279;35216;35257.82371088128;25958;25993;26092.956281749277;26591.20226393211;26620 03:35:11 INFO - PROCESS | 1911 | |2;jquery.html;315.78684388038073;390.1747803395817;391.37380191693296;398.44615983782563;416.5272415808057;15422;15849.524514264562;19656.11547480363;21482;21750.564988700236;17518.562035949075;20860.791392086074;20887.895560522174;21090.261840835574;21481.67777483339;5315.654482458647;5944.524438044968;5948.256467941507;6178.104174894637;6198;4469.508354081048;6179.104029915659;6282.842928926791;6288.182536270278;6293.590916590407;4136.75897230831;6555.737770489175;7007.334303241184;7048.647567621624;7122.180949190858;5991.940080599182;6308.905366419507;6336.841578960563;7083.468739844507;7107.502474826764;6136.969908503893;6188.628682279078;6207.162033125561;6211.87576248477;6212.223472065992;13798.379072941741;13987.230702311368;22764.861756912087;26061.869690651616;26660.46679066408;2257.4694946687514;2266.909323627053;2350.2126787526026;2361.53949979754;2925.107842108156;9840.311178217527;10211.132053775438;10370.970079511431;10756.031957123818;10888.074513666268;1855.5268406556243;1951.375559820858;1996.0718266006377;2014.6977953306975;2022.3225219551468;115344.84655153508;119787.40106299413;124780.74526766856;127805;130056;10808.891911080946;11138.888611113947;11385.772284554429;11701.414929253504;11702.70743231409;14840.480583179537;14847.925760371128;14869.553913382615;14871.182084985214;14892.851071489147;8841.42530735513;8948.73153805387;8957.372983891195;8992.775180620536;9076.727698169065;9075.591598378089;9077.954610227038;9079.319051071196;9229.215516681023;9235.12266334697;4557.1797076526545;4566.1552612766745;4575.794089265991;4585.587297143273;4663.370444989951;1895.924163033491;1936.912838922252;1941.8543609229364;1943.9902800485906;1953.082051435823;624.5721680648679;653.4576301669603;692.342274838905;704.7775882687417;840.5587066789861;18565.907170464332;19412.961639027697;20044.098015589334;21802.89098554497;22745;922.8938672052666;957.262907561174;997.5610731278215;999.8000399920045;1018.3889666200221;11209;11898.762024759457;12038.699032524257;12087.516499340103;12094.818577721342;652008;655152;658612;666639;666891;62998;80118.99999999884;135263.32368338096;145059;151394.24302878635;1012.3369193178627;1015.669907280137;1045.5399624165343;1066.679996001212;1067.4609322292347;15562.688746225238;19771;20857.374278771662;20940.895295523424;21065.894670526548;45294.77352613216;57017;58784.82430351454;59194.40805591889;59657.40342596518;78665;81564.59217703874;85097;85962.57018715117;87592;7543.8491230173995;8185.631646575799;8492.320614350714;8528.019277782887;8542.487450752975;9465.006174351869;12355;13122.803157952447;13501.729965400833;13618.38717257706;11308.83036754433;11455.484503197209;11530.538778448768;11769.705757356134;11975.28148311104;11246.606368777053;11314.20800543987;11336.829947550628;11570.363630000094;11673.241239319417;11616.128790340927;11729.35488548138;11830.231034982698;11972.401379931143;12148.635540933787;8281.503109813431;8339.499630022217;8475.74572762818;8523.147685231675;8584.785380365542;8874.955625221832;11258.943705281421;11453.656390308304;11493.080553555528;11926.165168438127 03:35:11 INFO - PROCESS | 1911 | |3;mootools.html;1541.7841502189692;1581.644130070734;1822.307523141206;1939.476341387826;1985.0744777565756;8922.553872306384;9544.188743956773;9546.713598592045;9549.09283618056;9561.99599042101;8143.307818835391;8357.28963038141;8376.204260595248;8489.278411335044;9303.116203960613;2144.517483566197;2204.581129585382;2312.7802858728396;2386.2960426674085;2396.101461951768;2365.929022129339;2380.5119950410126;2382.4996750682376;2385.3798012516786;2385.7017872765905;2363.8699871507147;2413.6017557103055;2422.7456117107627;2425.527022230666;2426.3327584914114;2352.0709319818748;2367.9052837886466;2368.6328619064075;2369.7748713872156;2369.8104151667826;2131.818795402393;2285.994162568481;2349.5300939811937;2366.3137690069857;2370.881455927197;9301.53492325381;9381.953090234574;9402.576884040234;9422.575984080733;9428.717138485856;5457.290552228224;5563.499285064323;5641.266635337421;5645.15322701594;5645.830625081254;3282.573265475473;3442.7245820334315;3629.6007439181667;3679.4480827875764;3735.7384983051197;1061.6178175856685;1094.1137678480377;1104.6465131158034;1123.8988491035846;1124.7919134959977;12372.566960156351;12380.195287306386;12406.441710122976;12409.689757756038;12409.813852792215;4819.759012049383;4916.950830491649;4947.876303092451;5038.773255203525;5063.1645778446145;10538.947305263424;10546.57813687444;10550.947245263724;10572.418516981486;10594.841077383846;5656.208130861683;5657.20799088128;5661.377248502661;5664.660120392789;5670.092785154356;4966.528179822911;5080.466551012164;5161.870953226199;5177.482251774868;5188.45521220274;3567.5362202913457;3822.8470861165797;3968.4840970673627;4116.958830411658;4236.5128010278595;1297.941592628334;1315.355475816862;1317.3149962019695;1325.2181213084327;1334.2728213123871;774.7908064822466;879.5514287713185;907.3421769217265;910.9478552272136;922.2667978956612;5961.482725192158;5996.340402555716;5999.340072592011;6168;6237.844053898598;797.4656979823532;916.6608354908726;993.6224234790877;994.7165057958592;1022.9897701023043;3885.825137868803;3962.366021436614;4046.9797651012145;4091.4428482198628;4099.631033207026;11073.833892491619;11252.26860254081;11369.97670209685;11397.259178153394;11451.713707157222;10979.670609881716;11345.716357090974;11467.426628668532;11487.310761354345;11698.35659038744;8567;8793.988691300454;8802.427842190236;8804.559772011375;8812.325658124935;6030.427109424598;6071.332153463204;6111.633302001716;6125.724342404514;6339.207599050119;10558.524866380878;10717.678469645924;10826;10832.025117739442;10838.078763305208;10237.9488102559;11026.0076593107;11041.06150977176;11054;11072.667819965414;7905.090914544901;7953.761387158394;8045.919540804517;8064;8072.152423995396;7982.441229113906;8251.752447426587;8265.46274492156;8814.735557933273;8937.955310223408;7921.009106669561;8011.919880801117;8023.83952320962;8067.435279530377;8161.755147345589;7719.382449404146;7766.611669416394;7804.882926756217;7923.84152316962;7947.125816160334;7295.124585049828;7442.367398770949;7452.701891924262;7453.366463850417;7453.739119130804;5045.6720313180995;5059.519345662156;5069.670471419494;5191.636585438983;5355.919661205007;5105.744712764273;5119.974400127976;5157.355330583677;5232.3459567554055;5234.345706786652 03:35:11 INFO - PROCESS | 1911 | |4;prototype.html;304.4307145637658;310.92382366320254;313.943490171769;317.8109025130047;323.06633828236414;4847.994243568988;5086.542211200996;5428.701421421821;5458.61789674723;5468.6171967962255;5294.4176140624595;5325.520703136726;5374.543163831079;5399.541039011679;5435.239066530688;3897.9610203898023;3899.883003509899;4013.2575473537345;4142.2958097123565;4170.958290417103;3691.741578089535;4102.548719640837;4110.198511290299;4139.406328563509;4175.979120104395;3480.3387356402327;3558.861164427384;3581.2658405026905;3947.6577963492405;4067.698336532311;3398.4902264660377;3491.877784277538;3913.571546385577;3924.567532850503;4094.222097801438;3551.3074950384685;3551.662592053751;3562.412201986669;3573.1960308930543;3575.4636804479537;4783.497732738082;4787.779116325315;4873.488283730228;5059.86153115546;5187.247849061865;4128.422020917074;4399.956000439986;4538.682292239545;4718.41019872516;4744.122337367598;4700.788464519105;5592.105263157875;5609;5631.60578759487;5786.508146807527;3341.128967778052;3505.439129739255;3931.3120203964477;3958.6833053355663;4021.155557332964;5582.637128586629;5884.6465312977825;5896.882062358729;5901.790133022763;5954.642721436728;3965.048388386824;3991.5850910199492;3997.4403583498333;3998.980260033673;4025.5974402560096;4052.675785937118;4062.614051665087;4065.5324637667045;4065.6137666921595;4093.7953102344763;4680.9297860532115;4706.482286948433;4707.599854012447;4714.292856071616;4730.006698593265;4956.851294461172;5256.842294731164;5682.801101961411;5685.607026278588;5735.541156707453;1332.3138583629438;1352.7091675289664;1360.6122255157431;1361.4213959067356;1365.3105181883086;779.6062988190927;781.4881252779438;814.3322475570094;821.757581513455;827.5283088639418;4488.506264310923;5193.454687257859;5306.355029940653;5344.144936810092;5490.6431081979545;5317.973410133002;5359.196120581944;5383.353997520244;5831.717022255097;5867.239828051567;4689.695169813951;5208.447860548304;5358.419266316446;5402;5435.554000699701;2499.6500489931423;2984.343444442219;3042.9501821871418;3057.9541306880415;3059.128148477673;4844.878878028007;5352.207010651476;6027.517798576104;6032.426919442646;6044.486218671374;5445.27736131934;5488.313960754906;5671.461211184931;5974.253218347707;6003.699815009232;4845.466998630078;5084.6440749147205;5326.334208223894;6049.758009679564;6087.726052327655;5397.1919406999095;5758.1362795579325;5775.364709881826;5835.649861008353;5844.253200995526;4980.452150263541;5320.829417528138;5712.314522257356;5715.371309156073;5732.197492350991;5976.073708575178;6025.728842202199;6079.726412311368;6191.380861913773;6273.811785646438;3574.731895107929;3678.724095692887;3871.7483363582405;3878.3820920878857;3937.7202409217693;4641.791119399702;4860.878478038077;4904.558589726942;5696.572757043155;5829.504492118217;5672.914906276326;5722.2561067061015;5758.884822303614;5787.594868359174;5797.971010144923;5512.724363781715;5625.240592519957;5636.154576813511;5669.546436285004;5687.232223649919;4759.309900064541;5030.522100400456;5262.052830490548;5501.9174712380145;5618.410066942912;5413.864653383697;5525.0883604204855;5587.552995760248;5631.577631677558;5644.8306550803545;5603.170398948505;5612.691301978267;5615.606907516435;5635.380108188014;5689.943100568941 03:35:11 INFO - PROCESS | 1911 | |5;yui.html;710.8827043537814;754.9358304544114;787.8109253779091;831.0858056138248;853.7993571510698;15447.536573902787;16618.25217865196;16620.66758664826;16622.584435389123;16639.417620383305;14844.480443184491;14956.7008659827;14959.401623935057;14963.850361496381;14977;699.7585832887646;711.2389742974993;714.610537257196;826.3802148388723;847.4279861093768;851.940364174508;852.8933883264592;864.9437786543886;868.9522076285801;868.9782755431133;903.8237543678986;904.0146240597747;904.5748498205833;905.2893478619285;907.8411278026352;893.9240164586018;895.3419236860902;896.8565029595266;897.2194191053792;897.6185121323476;670.2125003121362;671.9227288861795;672.1161672400777;672.5426709837309;674.0125715826289;15791.131487768169;15829.525114246477;15982.680346393006;15998.600034999217;16091.275892584861;14240;14770.926145369205;14827.184504852228;14871.405143794234;15046.398144074225;13205.669858253525;13355.131916425498;13380.732385352336;13611.387487563083;13698.863011369858;4270.487541495009;4701.106789709944;4750.881227969294;4758.547937945889;4786.282057691375;125392;125824;126718;129018.3549082258;129274.70725292721;11557.30656160633;11619;11708.414579271002;11743.88256117445;11933.164678472423;23122.190723324602;23406.414839629146;23731;23783.52432951331;23961.880190599284;8200.576127167345;8228.62971166299;8237.876431853527;8283.62723677436;8335.249827515552;4413.536578659258;4478.820847166142;4584.701994370355;4663.533646635309;4725.692829966041;3474.652534746505;3545.5922568904907;3581.068922080278;3592.856285748593;3595.640435956436;640.0559175216518;642.7429028388589;644.0757512968904;647.5531883000715;662.7547807311325;510.706343852279;576.711644177911;632.788016014631;635.596396288351;637.1939496536885;8112.513249204949;8982.685606003759;9040.954795225982;9049.547522623843;9097.49963752;606.532969613404;637.0539748473514;645.5481163185789;654.5679851298121;660.3165723476275;4040.9189267527245;4326.82692692295;4361.869143925624;4378.693491455568;4488.416505854283;129741;131727;135619;141210;144492;120691.39654301673;120845.39577302233;123099;123316;124112;92722;96130.51934740282;98874.5056274714;99402;106601;9620.470874101991;9626.9037309626;9843.753906152404;9858.704238872846;9861.408315501092;55186.724066379415;59469;60736.69631651814;60965.475863102;62539.749205014734;89853;91912.08087919035;94809;96043.51978240344;98471;12687.429065691882;13185.208887466782;13500.122492037986;13642.727145457235;13700.52048178349;14725.116493010453;15532.922335388703;15550;16151.596210094842;16383.935044222088;13915.791263130859;14149.36327865228;14628.195449250394;14869.925650372112;14950.401983920521;13629.591112266648;14175.29123543798;14248.216348100954;14688.55934321972;14943.626409339418;12886.742265154831;13728.45086196541;14100.717985640435;14488.34802433914;14691.926540367229;11130.777384452427;11675;11688.649340519798;11800.409979501163;12268.87731122713;11611;11724.472398741906;11935;11943.462544185359;12012.459439325427 03:35:11 INFO - PROCESS | 1911 | __end_tp_report 03:35:11 INFO - PROCESS | 1911 | __start_cc_report 03:35:11 INFO - PROCESS | 1911 | _x_x_mozilla_cycle_collect,1427 03:35:11 INFO - PROCESS | 1911 | __end_cc_report 03:35:11 INFO - PROCESS | 1911 | __startTimestamp1483616111405__endTimestamp 03:35:11 INFO - PROCESS | 1911 | 03:35:11 INFO - PROCESS | 1911 | ------- Summary: start ------- 03:35:11 INFO - PROCESS | 1911 | Number of tests: 6 03:35:11 INFO - PROCESS | 1911 | 03:35:11 INFO - PROCESS | 1911 | [#0] dojo.html Cycles:165 Average:5719.52 Median:5840.21 stddev:623.90 (10.7%) stddev-sans-first:598.23 03:35:11 INFO - PROCESS | 1911 | Values: 3381.0 3407.3 3434.8 3439.3 3482.8 5637.2 5665.7 5686.9 5690.6 5712.3 5642.9 5731.1 5732.8 5735.7 5740.2 5201.9 5209.8 5211.9 5243.2 5253.4 5145.2 5168.6 5170.3 5287.8 5292.2 5127.1 5170.9 5180.2 5194.6 5206.3 5208.8 5225.8 5289.0 5291.3 5325.8 5155.8 5181.6 5204.4 5221.6 5224.3 5545.2 5565.3 5616.6 5616.9 5647.1 6104.3 6127.1 6141.6 6152.0 6153.7 6274.3 6285.3 6307.5 6323.7 6326.3 5629.5 5684.2 5685.9 5733.8 5766.1 6304.6 6307.4 6311.4 6322.7 6324.7 6133.6 6139.0 6145.6 6150.4 6167.6 5087.9 6092.6 6120.8 6141.4 6262.6 6135.9 6210.0 6226.0 6226.2 6229.6 5241.5 6185.9 6197.8 6249.1 6279.9 4864.1 4901.9 4988.9 4995.3 5004.8 4387.7 4462.3 4466.6 4467.0 4468.2 5821.2 5831.1 5840.2 5844.8 5862.4 6263.2 6287.9 6292.4 6305.2 6307.2 5609.4 5651.9 5658.9 5683.9 5709.0 5379.5 5415.3 5416.4 5421.1 5461.6 6284.8 6293.5 6299.1 6299.1 6306.4 6105.7 6132.5 6207.3 6263.5 6275.4 6223.3 6272.8 6293.2 6293.9 6314.5 6171.7 6181.9 6193.4 6206.6 6207.9 6206.8 6255.9 6261.7 6285.6 6286.9 5938.6 5966.3 6014.5 6045.3 6102.7 5191.4 6063.9 6108.3 6140.9 6145.9 5981.4 5998.2 6001.1 6001.8 6006.9 5808.8 5812.6 5936.7 5979.3 6045.1 5729.9 5761.9 5772.4 5774.0 5806.7 03:35:11 INFO - PROCESS | 1911 | 03:35:11 INFO - PROCESS | 1911 | [#1] ext.html Cycles:180 Average:75835.06 Median:36505.04 stddev:179115.79 (490.7%) stddev-sans-first:179528.89 03:35:11 INFO - PROCESS | 1911 | Values: 473.7 474.7 536.7 558.5 565.4 32087.4 32780.0 34130.8 34168.8 34206.7 33876.7 35071.3 36263.6 42807.0 44305.9 9831.0 9990.5 9992.7 9998.5 10022.9 9716.1 9823.5 9825.0 9827.5 9848.0 9256.5 9457.0 9465.4 9821.9 9856.5 9406.2 9488.9 12084.2 12397.6 12428.5 12155.3 12257.4 12258.9 12259.6 12265.6 41611.8 41982.0 42043.0 42099.6 42139.4 3622.7 3774.5 3947.4 4109.0 4118.0 29908.6 30998.7 31344.2 33002.2 33246.5 3422.9 3447.9 3459.3 3560.3 3567.8 502492.0 508250.0 509489.0 509696.0 509738.5 34719.5 35387.5 35543.5 61402.0 61613.7 36400.5 36481.8 36481.8 36528.3 36605.1 15755.7 15897.2 15924.9 15926.4 15931.1 13427.1 13530.9 13531.5 13533.3 13538.9 8012.0 8030.4 8044.2 8087.7 8119.4 3147.7 3227.9 3345.8 3358.0 3363.6 916.2 960.5 1032.0 1049.1 1071.2 27860.4 29773.7 29964.6 31082.7 31737.7 907.1 936.4 1106.1 1155.1 1174.9 15125.6 15550.8 15570.5 15594.0 15845.8 721820.0 726743.0 726919.0 728177.0 728344.0 58193.8 58444.4 58584.4 58601.4 58674.7 1293.2 1306.7 1329.3 1347.6 1382.6 30164.4 31358.1 31484.4 31583.9 32060.9 50549.7 51173.7 51331.0 51333.6 51342.0 609943.0 615548.0 616090.0 879446.0 898409.0 26716.6 26865.7 27114.5 27343.9 27627.4 47037.0 47135.3 47341.5 47581.8 48057.5 35256.8 38593.5 38828.2 39026.8 40199.6 39078.0 39300.4 39596.0 40175.4 41263.0 37682.6 39180.8 39320.6 39583.4 39683.0 33309.8 34034.3 34244.1 35216.0 35257.8 25958.0 25993.0 26093.0 26591.2 26620.0 03:35:11 INFO - PROCESS | 1911 | 03:35:11 INFO - PROCESS | 1911 | [#2] jquery.html Cycles:180 Average:36798.34 Median:12557.54 stddev:109670.73 (873.3%) stddev-sans-first:109944.17 03:35:11 INFO - PROCESS | 1911 | Values: 315.8 390.2 391.4 398.4 416.5 15422.0 15849.5 19656.1 21482.0 21750.6 17518.6 20860.8 20887.9 21090.3 21481.7 5315.7 5944.5 5948.3 6178.1 6198.0 4469.5 6179.1 6282.8 6288.2 6293.6 4136.8 6555.7 7007.3 7048.6 7122.2 5991.9 6308.9 6336.8 7083.5 7107.5 6137.0 6188.6 6207.2 6211.9 6212.2 13798.4 13987.2 22764.9 26061.9 26660.5 2257.5 2266.9 2350.2 2361.5 2925.1 9840.3 10211.1 10371.0 10756.0 10888.1 1855.5 1951.4 1996.1 2014.7 2022.3 115344.8 119787.4 124780.7 127805.0 130056.0 10808.9 11138.9 11385.8 11701.4 11702.7 14840.5 14847.9 14869.6 14871.2 14892.9 8841.4 8948.7 8957.4 8992.8 9076.7 9075.6 9078.0 9079.3 9229.2 9235.1 4557.2 4566.2 4575.8 4585.6 4663.4 1895.9 1936.9 1941.9 1944.0 1953.1 624.6 653.5 692.3 704.8 840.6 18565.9 19413.0 20044.1 21802.9 22745.0 922.9 957.3 997.6 999.8 1018.4 11209.0 11898.8 12038.7 12087.5 12094.8 652008.0 655152.0 658612.0 666639.0 666891.0 62998.0 80119.0 135263.3 145059.0 151394.2 1012.3 1015.7 1045.5 1066.7 1067.5 15562.7 19771.0 20857.4 20940.9 21065.9 45294.8 57017.0 58784.8 59194.4 59657.4 78665.0 81564.6 85097.0 85962.6 87592.0 7543.8 8185.6 8492.3 8528.0 8542.5 9465.0 12355.0 13122.8 13501.7 13618.4 11308.8 11455.5 11530.5 11769.7 11975.3 11246.6 11314.2 11336.8 11570.4 11673.2 11616.1 11729.4 11830.2 11972.4 12148.6 8281.5 8339.5 8475.7 8523.1 8584.8 8875.0 11258.9 11453.7 11493.1 11926.2 03:35:11 INFO - PROCESS | 1911 | 03:35:11 INFO - PROCESS | 1911 | [#3] mootools.html Cycles:180 Average:6007.69 Median:5042.22 stddev:3437.41 (68.2%) stddev-sans-first:3430.67 03:35:11 INFO - PROCESS | 1911 | Values: 1541.8 1581.6 1822.3 1939.5 1985.1 8922.6 9544.2 9546.7 9549.1 9562.0 8143.3 8357.3 8376.2 8489.3 9303.1 2144.5 2204.6 2312.8 2386.3 2396.1 2365.9 2380.5 2382.5 2385.4 2385.7 2363.9 2413.6 2422.7 2425.5 2426.3 2352.1 2367.9 2368.6 2369.8 2369.8 2131.8 2286.0 2349.5 2366.3 2370.9 9301.5 9382.0 9402.6 9422.6 9428.7 5457.3 5563.5 5641.3 5645.2 5645.8 3282.6 3442.7 3629.6 3679.4 3735.7 1061.6 1094.1 1104.6 1123.9 1124.8 12372.6 12380.2 12406.4 12409.7 12409.8 4819.8 4917.0 4947.9 5038.8 5063.2 10538.9 10546.6 10550.9 10572.4 10594.8 5656.2 5657.2 5661.4 5664.7 5670.1 4966.5 5080.5 5161.9 5177.5 5188.5 3567.5 3822.8 3968.5 4117.0 4236.5 1297.9 1315.4 1317.3 1325.2 1334.3 774.8 879.6 907.3 910.9 922.3 5961.5 5996.3 5999.3 6168.0 6237.8 797.5 916.7 993.6 994.7 1023.0 3885.8 3962.4 4047.0 4091.4 4099.6 11073.8 11252.3 11370.0 11397.3 11451.7 10979.7 11345.7 11467.4 11487.3 11698.4 8567.0 8794.0 8802.4 8804.6 8812.3 6030.4 6071.3 6111.6 6125.7 6339.2 10558.5 10717.7 10826.0 10832.0 10838.1 10237.9 11026.0 11041.1 11054.0 11072.7 7905.1 7953.8 8045.9 8064.0 8072.2 7982.4 8251.8 8265.5 8814.7 8938.0 7921.0 8011.9 8023.8 8067.4 8161.8 7719.4 7766.6 7804.9 7923.8 7947.1 7295.1 7442.4 7452.7 7453.4 7453.7 5045.7 5059.5 5069.7 5191.6 5355.9 5105.7 5120.0 5157.4 5232.3 5234.3 03:35:11 INFO - PROCESS | 1911 | 03:35:11 INFO - PROCESS | 1911 | [#4] prototype.html Cycles:180 Average:4577.19 Median:5200.95 stddev:1414.82 (27.2%) stddev-sans-first:1381.97 03:35:11 INFO - PROCESS | 1911 | Values: 304.4 310.9 313.9 317.8 323.1 4848.0 5086.5 5428.7 5458.6 5468.6 5294.4 5325.5 5374.5 5399.5 5435.2 3898.0 3899.9 4013.3 4142.3 4171.0 3691.7 4102.5 4110.2 4139.4 4176.0 3480.3 3558.9 3581.3 3947.7 4067.7 3398.5 3491.9 3913.6 3924.6 4094.2 3551.3 3551.7 3562.4 3573.2 3575.5 4783.5 4787.8 4873.5 5059.9 5187.2 4128.4 4400.0 4538.7 4718.4 4744.1 4700.8 5592.1 5609.0 5631.6 5786.5 3341.1 3505.4 3931.3 3958.7 4021.2 5582.6 5884.6 5896.9 5901.8 5954.6 3965.0 3991.6 3997.4 3999.0 4025.6 4052.7 4062.6 4065.5 4065.6 4093.8 4680.9 4706.5 4707.6 4714.3 4730.0 4956.9 5256.8 5682.8 5685.6 5735.5 1332.3 1352.7 1360.6 1361.4 1365.3 779.6 781.5 814.3 821.8 827.5 4488.5 5193.5 5306.4 5344.1 5490.6 5318.0 5359.2 5383.4 5831.7 5867.2 4689.7 5208.4 5358.4 5402.0 5435.6 2499.7 2984.3 3043.0 3058.0 3059.1 4844.9 5352.2 6027.5 6032.4 6044.5 5445.3 5488.3 5671.5 5974.3 6003.7 4845.5 5084.6 5326.3 6049.8 6087.7 5397.2 5758.1 5775.4 5835.6 5844.3 4980.5 5320.8 5712.3 5715.4 5732.2 5976.1 6025.7 6079.7 6191.4 6273.8 3574.7 3678.7 3871.7 3878.4 3937.7 4641.8 4860.9 4904.6 5696.6 5829.5 5672.9 5722.3 5758.9 5787.6 5798.0 5512.7 5625.2 5636.2 5669.5 5687.2 4759.3 5030.5 5262.1 5501.9 5618.4 5413.9 5525.1 5587.6 5631.6 5644.8 5603.2 5612.7 5615.6 5635.4 5689.9 03:35:11 INFO - PROCESS | 1911 | 03:35:11 INFO - PROCESS | 1911 | [#5] yui.html Cycles:180 Average:24885.59 Median:3818.28 stddev:38577.08 (1010.3%) stddev-sans-first:38642.59 03:35:11 INFO - PROCESS | 1911 | Values: 710.9 754.9 787.8 831.1 853.8 15447.5 16618.3 16620.7 16622.6 16639.4 14844.5 14956.7 14959.4 14963.9 14977.0 699.8 711.2 714.6 826.4 847.4 851.9 852.9 864.9 869.0 869.0 903.8 904.0 904.6 905.3 907.8 893.9 895.3 896.9 897.2 897.6 670.2 671.9 672.1 672.5 674.0 15791.1 15829.5 15982.7 15998.6 16091.3 14240.0 14770.9 14827.2 14871.4 15046.4 13205.7 13355.1 13380.7 13611.4 13698.9 4270.5 4701.1 4750.9 4758.5 4786.3 125392.0 125824.0 126718.0 129018.4 129274.7 11557.3 11619.0 11708.4 11743.9 11933.2 23122.2 23406.4 23731.0 23783.5 23961.9 8200.6 8228.6 8237.9 8283.6 8335.2 4413.5 4478.8 4584.7 4663.5 4725.7 3474.7 3545.6 3581.1 3592.9 3595.6 640.1 642.7 644.1 647.6 662.8 510.7 576.7 632.8 635.6 637.2 8112.5 8982.7 9041.0 9049.5 9097.5 606.5 637.1 645.5 654.6 660.3 4040.9 4326.8 4361.9 4378.7 4488.4 129741.0 131727.0 135619.0 141210.0 144492.0 120691.4 120845.4 123099.0 123316.0 124112.0 92722.0 96130.5 98874.5 99402.0 106601.0 9620.5 9626.9 9843.8 9858.7 9861.4 55186.7 59469.0 60736.7 60965.5 62539.7 89853.0 91912.1 94809.0 96043.5 98471.0 12687.4 13185.2 13500.1 13642.7 13700.5 14725.1 15532.9 15550.0 16151.6 16383.9 13915.8 14149.4 14628.2 14869.9 14950.4 13629.6 14175.3 14248.2 14688.6 14943.6 12886.7 13728.5 14100.7 14488.3 14691.9 11130.8 11675.0 11688.6 11800.4 12268.9 11611.0 11724.5 11935.0 11943.5 12012.5 03:35:11 INFO - PROCESS | 1911 | -------- Summary: end -------- 03:35:11 INFO - PROCESS | 1911 | 03:35:11 INFO - TEST-INFO | 1911: exit 0 03:35:11 INFO - TEST-OK | dromaeo_css | took 1115281ms 03:35:11 INFO - TEST-START | kraken 03:35:11 INFO - operating with platform_type : mac_ 03:35:11 INFO - Initialising browser for kraken test... 03:35:12 INFO - TEST-INFO | started process 1938 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/tmpiKlBNB/profile http://localhost:49472/getInfo.html) 03:35:14 INFO - PROCESS | 1938 | __metrics Screen width/height:1600/1200 03:35:14 INFO - PROCESS | 1938 | colorDepth:24 03:35:14 INFO - PROCESS | 1938 | Browser inner width/height: 1024/689 03:35:14 INFO - PROCESS | 1938 | __metrics 03:35:14 INFO - PROCESS | 1938 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:35:14 INFO - PROCESS | 1938 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:35:14 INFO - TEST-INFO | 1938: exit 0 03:35:14 INFO - Browser initialized. 03:35:14 INFO - Running cycle 1/1 for kraken test... 03:35:14 INFO - TEST-INFO | started process 1940 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/tmpiKlBNB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:35:26 INFO - PROCESS | 1940 | RSS: Main: 168718336 03:35:26 INFO - PROCESS | 1940 | 03:35:29 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49472/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49472/tests/kraken/driver.html?testName=audio-beat-detection) 03:35:30 INFO - PROCESS | 1940 | RSS: Main: 218775552 03:35:30 INFO - PROCESS | 1940 | 03:35:33 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49472/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49472/tests/kraken/driver.html?testName=audio-dft) 03:35:33 INFO - PROCESS | 1940 | RSS: Main: 232857600 03:35:33 INFO - PROCESS | 1940 | 03:35:36 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49472/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49472/tests/kraken/driver.html?testName=audio-fft) 03:35:37 INFO - PROCESS | 1940 | RSS: Main: 328929280 03:35:37 INFO - PROCESS | 1940 | 03:35:39 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49472/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49472/tests/kraken/driver.html?testName=audio-oscillator) 03:35:40 INFO - PROCESS | 1940 | RSS: Main: 229773312 03:35:40 INFO - PROCESS | 1940 | 03:35:42 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49472/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49472/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:35:42 INFO - PROCESS | 1940 | RSS: Main: 230498304 03:35:42 INFO - PROCESS | 1940 | 03:35:45 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49472/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49472/tests/kraken/driver.html?testName=imaging-darkroom) 03:35:46 INFO - PROCESS | 1940 | RSS: Main: 266895360 03:35:46 INFO - PROCESS | 1940 | 03:35:49 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49472/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49472/tests/kraken/driver.html?testName=imaging-desaturate) 03:35:49 INFO - PROCESS | 1940 | RSS: Main: 268566528 03:35:49 INFO - PROCESS | 1940 | 03:35:52 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49472/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49472/tests/kraken/driver.html?testName=json-parse-financial) 03:35:53 INFO - PROCESS | 1940 | RSS: Main: 268206080 03:35:53 INFO - PROCESS | 1940 | 03:35:54 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49472/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49472/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:35:55 INFO - PROCESS | 1940 | RSS: Main: 244539392 03:35:55 INFO - PROCESS | 1940 | 03:35:57 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49472/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49472/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:35:57 INFO - PROCESS | 1940 | RSS: Main: 248188928 03:35:57 INFO - PROCESS | 1940 | 03:35:59 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49472/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49472/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:36:00 INFO - PROCESS | 1940 | RSS: Main: 253906944 03:36:00 INFO - PROCESS | 1940 | 03:36:03 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49472/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49472/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:36:04 INFO - PROCESS | 1940 | RSS: Main: 261210112 03:36:04 INFO - PROCESS | 1940 | 03:36:07 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49472/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49472/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:36:07 INFO - PROCESS | 1940 | RSS: Main: 262160384 03:36:07 INFO - PROCESS | 1940 | 03:36:09 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49472/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49472/tests/kraken/driver.html?testName=ai-astar) 03:36:09 INFO - PROCESS | 1940 | RSS: Main: 305217536 03:36:09 INFO - PROCESS | 1940 | 03:36:09 INFO - PROCESS | 1940 | __start_tp_report 03:36:09 INFO - PROCESS | 1940 | _x_x_mozilla_page_load 03:36:09 INFO - PROCESS | 1940 | _x_x_mozilla_page_load_details 03:36:09 INFO - PROCESS | 1940 | |i|pagename|runs| 03:36:09 INFO - PROCESS | 1940 | |0;ai-astar;115;113;116;163;170;113;113;113;114;114 03:36:09 INFO - PROCESS | 1940 | |1;audio-beat-detection;145;113;108;142;110;110;108;109;137;103 03:36:09 INFO - PROCESS | 1940 | |2;audio-dft;182;183;183;182;182;184;184;182;184;183 03:36:09 INFO - PROCESS | 1940 | |3;audio-fft;81;58;58;91;79;83;84;73;83;57 03:36:09 INFO - PROCESS | 1940 | |4;audio-oscillator;85;72;94;70;68;68;93;69;68;89 03:36:09 INFO - PROCESS | 1940 | |5;imaging-gaussian-blur;88;91;94;86;89;90;92;131;135;86 03:36:09 INFO - PROCESS | 1940 | |6;imaging-darkroom;96;95;97;95;94;101;149;132;94;94 03:36:09 INFO - PROCESS | 1940 | |7;imaging-desaturate;83;84;85;85;85;83;83;83;84;85 03:36:09 INFO - PROCESS | 1940 | |8;json-parse-financial;55;53;51;53;56;56;56;56;57;57 03:36:09 INFO - PROCESS | 1940 | |9;json-stringify-tinderbox;64;73;68;81;74;72;68;68;69;69 03:36:09 INFO - PROCESS | 1940 | |10;stanford-crypto-aes;92;99;96;82;80;84;85;85;87;88 03:36:09 INFO - PROCESS | 1940 | |11;stanford-crypto-ccm;137;145;147;133;141;148;149;149;167;147 03:36:09 INFO - PROCESS | 1940 | |12;stanford-crypto-pbkdf2;163;160;161;160;164;163;158;162;162;160 03:36:09 INFO - PROCESS | 1940 | |13;stanford-crypto-sha256-iterative;67;69;64;65;65;66;66;65;64;64 03:36:09 INFO - PROCESS | 1940 | __end_tp_report 03:36:09 INFO - PROCESS | 1940 | __start_cc_report 03:36:09 INFO - PROCESS | 1940 | _x_x_mozilla_cycle_collect,1969 03:36:09 INFO - PROCESS | 1940 | __end_cc_report 03:36:09 INFO - PROCESS | 1940 | __startTimestamp1483616169642__endTimestamp 03:36:09 INFO - PROCESS | 1940 | 03:36:09 INFO - PROCESS | 1940 | ------- Summary: start ------- 03:36:09 INFO - PROCESS | 1940 | Number of tests: 14 03:36:09 INFO - PROCESS | 1940 | 03:36:09 INFO - PROCESS | 1940 | [#0] ai-astar Cycles:10 Average:124.40 Median:114.50 stddev:22.27 (19.5%) stddev-sans-first:23.36 03:36:09 INFO - PROCESS | 1940 | Values: 115.0 113.0 116.0 163.0 170.0 113.0 113.0 113.0 114.0 114.0 03:36:09 INFO - PROCESS | 1940 | 03:36:09 INFO - PROCESS | 1940 | [#1] audio-beat-detection Cycles:10 Average:118.50 Median:111.50 stddev:16.06 (14.4%) stddev-sans-first:13.88 03:36:09 INFO - PROCESS | 1940 | Values: 145.0 113.0 108.0 142.0 110.0 110.0 108.0 109.0 137.0 103.0 03:36:09 INFO - PROCESS | 1940 | 03:36:09 INFO - PROCESS | 1940 | [#2] audio-dft Cycles:10 Average:182.90 Median:183.00 stddev:0.88 (0.5%) stddev-sans-first:0.87 03:36:09 INFO - PROCESS | 1940 | Values: 182.0 183.0 183.0 182.0 182.0 184.0 184.0 182.0 184.0 183.0 03:36:09 INFO - PROCESS | 1940 | 03:36:09 INFO - PROCESS | 1940 | [#3] audio-fft Cycles:10 Average:74.70 Median:82.00 stddev:12.57 (15.3%) stddev-sans-first:13.12 03:36:09 INFO - PROCESS | 1940 | Values: 81.0 58.0 58.0 91.0 79.0 83.0 84.0 73.0 83.0 57.0 03:36:09 INFO - PROCESS | 1940 | 03:36:09 INFO - PROCESS | 1940 | [#4] audio-oscillator Cycles:10 Average:77.60 Median:78.50 stddev:11.21 (14.3%) stddev-sans-first:11.56 03:36:09 INFO - PROCESS | 1940 | Values: 85.0 72.0 94.0 70.0 68.0 68.0 93.0 69.0 68.0 89.0 03:36:09 INFO - PROCESS | 1940 | 03:36:09 INFO - PROCESS | 1940 | [#5] imaging-gaussian-blur Cycles:10 Average:98.20 Median:89.50 stddev:18.53 (20.7%) stddev-sans-first:19.29 03:36:09 INFO - PROCESS | 1940 | Values: 88.0 91.0 94.0 86.0 89.0 90.0 92.0 131.0 135.0 86.0 03:36:09 INFO - PROCESS | 1940 | 03:36:09 INFO - PROCESS | 1940 | [#6] imaging-darkroom Cycles:10 Average:104.70 Median:94.50 stddev:19.40 (20.5%) stddev-sans-first:20.32 03:36:09 INFO - PROCESS | 1940 | Values: 96.0 95.0 97.0 95.0 94.0 101.0 149.0 132.0 94.0 94.0 03:36:09 INFO - PROCESS | 1940 | 03:36:09 INFO - PROCESS | 1940 | [#7] imaging-desaturate Cycles:10 Average:84.00 Median:84.50 stddev:0.94 (1.1%) stddev-sans-first:0.93 03:36:09 INFO - PROCESS | 1940 | Values: 83.0 84.0 85.0 85.0 85.0 83.0 83.0 83.0 84.0 85.0 03:36:09 INFO - PROCESS | 1940 | 03:36:09 INFO - PROCESS | 1940 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:56.00 stddev:2.00 (3.6%) stddev-sans-first:2.12 03:36:09 INFO - PROCESS | 1940 | Values: 55.0 53.0 51.0 53.0 56.0 56.0 56.0 56.0 57.0 57.0 03:36:09 INFO - PROCESS | 1940 | 03:36:09 INFO - PROCESS | 1940 | [#9] json-stringify-tinderbox Cycles:10 Average:70.60 Median:70.50 stddev:4.67 (6.6%) stddev-sans-first:4.30 03:36:09 INFO - PROCESS | 1940 | Values: 64.0 73.0 68.0 81.0 74.0 72.0 68.0 68.0 69.0 69.0 03:36:09 INFO - PROCESS | 1940 | 03:36:09 INFO - PROCESS | 1940 | [#10] stanford-crypto-aes Cycles:10 Average:87.80 Median:87.50 stddev:6.11 (7.0%) stddev-sans-first:6.28 03:36:09 INFO - PROCESS | 1940 | Values: 92.0 99.0 96.0 82.0 80.0 84.0 85.0 85.0 87.0 88.0 03:36:09 INFO - PROCESS | 1940 | 03:36:09 INFO - PROCESS | 1940 | [#11] stanford-crypto-ccm Cycles:10 Average:146.30 Median:147.50 stddev:9.07 (6.1%) stddev-sans-first:8.97 03:36:09 INFO - PROCESS | 1940 | Values: 137.0 145.0 147.0 133.0 141.0 148.0 149.0 149.0 167.0 147.0 03:36:09 INFO - PROCESS | 1940 | 03:36:09 INFO - PROCESS | 1940 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.30 Median:162.00 stddev:1.83 (1.1%) stddev-sans-first:1.83 03:36:09 INFO - PROCESS | 1940 | Values: 163.0 160.0 161.0 160.0 164.0 163.0 158.0 162.0 162.0 160.0 03:36:09 INFO - PROCESS | 1940 | 03:36:09 INFO - PROCESS | 1940 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:65.50 stddev:1.58 (2.4%) stddev-sans-first:1.58 03:36:09 INFO - PROCESS | 1940 | Values: 67.0 69.0 64.0 65.0 65.0 66.0 66.0 65.0 64.0 64.0 03:36:09 INFO - PROCESS | 1940 | -------- Summary: end -------- 03:36:09 INFO - PROCESS | 1940 | 03:36:10 INFO - TEST-INFO | 1940: exit 0 03:36:10 INFO - TEST-OK | kraken | took 58468ms 03:36:10 INFO - SUITE-END | took 1173s 03:36:10 INFO - Completed test suite (00:19:34) 03:36:10 INFO - javascript benchmark 03:36:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3381.0026042317513, 3407.25040491092, 3434.8454319555617, 3439.346524160411, 3482.7910325380462, 5637.154426835971, 5665.745041473133, 5686.886262274762, 5690.630109042914, 5712.285964254468, 5642.915356269659, 5731.14032895066, 5732.828015159552, 5735.741891614877, 5740.225069615601, 5201.947980520203, 5209.817656382027, 5211.895762084747, 5243.187305967581, 5253.369595648527, 5145.228215767627, 5168.586513078944, 5170.327857378555, 5287.841364759063, 5292.232626269189, 5127.102757017526, 5170.896582068356, 5180.2488639147305, 5194.63637545372, 5206.297149884755, 5208.791648334081, 5225.790968361261, 5289.021531016736, 5291.3385826771655, 5325.840224793263, 5155.845324640267, 5181.611379146579, 5204.4014938281825, 5221.608379371524, 5224.294720212761, 5545.1682247663175, 5565.332160140809, 5616.63491873031, 5616.887662246773, 5647.124695672177, 6104.298005729309, 6127.080937859312, 6141.631502109843, 6152.0, 6153.692315384257, 6274.341194174592, 6285.340039295899, 6307.4954003679595, 6323.74705011799, 6326.304106548276, 5629.4652008059575, 5684.175794509855, 5685.943140568624, 5733.799317023884, 5766.135079738031, 6304.621722696653, 6307.432331090224, 6311.431971122621, 6322.747090116344, 6324.747010119636, 6133.570650054543, 6139.0, 6145.569810113249, 6150.384961503813, 6167.568270221132, 5087.8982420351385, 6092.573519853657, 6120.751898419022, 6141.433934346803, 6262.5616206866, 6135.937063216329, 6209.96895015522, 6226.0, 6226.1905952225925, 6229.56393052482, 5241.528262456397, 6185.938140618626, 6197.81406557804, 6249.062640603855, 6279.905801412982, 4864.148773964542, 4901.852944411602, 4988.850334489971, 4995.300657907896, 5004.824831130893, 4387.714798538085, 4462.263726485158, 4466.642668586505, 4467.01725620363, 4468.218061839165, 5821.214136091573, 5831.125331200269, 5840.211571437886, 5844.795432159854, 5862.384449632812, 6263.185785847811, 6287.874242515124, 6292.370762923671, 6305.243370795442, 6307.24313082433, 5609.4390560943575, 5651.943480565224, 5658.91511627326, 5683.886322273532, 5709.000924838137, 5379.54273886724, 5415.323084614423, 5416.431274716098, 5421.078416669176, 5461.617686761968, 6284.811455656338, 6293.465055470153, 6299.0866324382705, 6299.0866324382705, 6306.432421082125, 6105.725242364193, 6132.5084813409785, 6207.286162091417, 6263.467605253422, 6275.403836635513, 6223.284322302993, 6272.8118156455375, 6293.150424692608, 6293.874122517615, 6314.494840412848, 6171.722272497658, 6181.907271391023, 6193.4425901669065, 6206.627602343874, 6207.906881396692, 6206.751729930752, 6255.906161407492, 6261.655608941552, 6285.59143655661, 6286.937130628635, 5938.584299099194, 5966.284045914518, 6014.48876845473, 6045.304789949212, 6102.694865256808, 5191.377034755854, 6063.909041364295, 6108.281362586102, 6140.872371569611, 6145.907811382744, 5981.401859813984, 5998.190244317136, 6001.06983417571, 6001.789937352171, 6006.909896351471, 5808.767649293981, 5812.622179558315, 5936.673482958478, 5979.252593425822, 6045.063015232646, 5729.942700572941, 5761.884762304814, 5772.365039845529, 5773.97113014449, 5806.709664516842], "value": 5681.210819456487, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [473.68263263613386, 474.6748477293053, 536.6619030011095, 558.5392051557466, 565.3780841074819, 32087.358252834958, 32780.01659950199, 34130.829345853235, 34168.82915585425, 34206.65793342066, 33876.66123338766, 35071.29857402851, 36263.63736362635, 42807.0, 44305.8923526912, 9831.0, 9990.45052522111, 9992.650257240997, 9998.45008524531, 10022.899771002307, 9716.125548700651, 9823.50882455878, 9825.0, 9827.459489728062, 9847.950760246189, 9256.537173141349, 9456.952715236448, 9465.432074075577, 9821.901780982205, 9856.457894815781, 9406.200472959807, 9488.905110948906, 12084.154109212359, 12397.566085186974, 12428.502859885593, 12155.270683758914, 12257.387130643432, 12258.938705306506, 12259.570915017932, 12265.570705025371, 41611.79194104041, 41982.0, 42043.0, 42099.579004209874, 42139.367909481385, 3622.6739593436455, 3774.5093137892172, 3947.388154836005, 4109.034376921421, 4117.958820411787, 29908.55137172944, 30998.690013099807, 31344.21639459009, 33002.17494562631, 33246.50130248024, 3422.9315413691834, 3447.9310413791836, 3459.3254315408503, 3560.305740380627, 3567.839447224855, 502492.0, 508250.0, 509489.0, 509696.0, 509738.4513077448, 34719.479207811906, 35387.469187962204, 35543.466847997304, 61402.0, 61613.69193154005, 36400.45399319012, 36481.81759091187, 36481.817590912404, 36528.26943461116, 36605.08487287786, 15755.684886302439, 15897.205139742966, 15924.92037539828, 15926.442574509836, 15931.12378819153, 13427.060105792501, 13530.932345338408, 13531.45874165042, 13533.255670938193, 13538.864611353958, 8012.0, 8030.357571394275, 8044.155363686846, 8087.676492940334, 8119.350451963947, 3147.7009684080435, 3227.9193020174685, 3345.8494367753024, 3358.026172410023, 3363.5963684358035, 916.2120576304372, 960.4525420510382, 1031.9742006449899, 1049.0872940541624, 1071.239420011785, 27860.442791144065, 29773.702262977095, 29964.550531742043, 31082.689173107978, 31737.682623173936, 907.1336873285996, 936.3726303376754, 1106.0598491282346, 1155.058627218814, 1174.9236299640668, 15125.621859453602, 15550.76673849893, 15570.532884013497, 15593.986390884556, 15845.841541584437, 721820.0, 726743.0, 726919.0, 728177.0, 728344.0, 58193.836123277295, 58444.415555844746, 58584.41415585875, 58601.41398586045, 58674.70662646659, 1293.1723696834033, 1306.6667999660026, 1329.268902103839, 1347.632153364336, 1382.6405134664858, 30164.396712066075, 31358.05925822229, 31484.37031259316, 31583.89456369108, 32060.877869274464, 50549.74725126351, 51173.744131279105, 51330.97338053143, 51333.63664088594, 51342.0, 609943.0, 615548.0, 616090.0, 879446.0, 898409.0, 26716.599251010863, 26865.731342687104, 27114.45771084528, 27343.86328068347, 27627.447451050466, 47037.0, 47135.29297060478, 47341.526584733714, 47581.762091189325, 48057.519424806706, 35256.82371588228, 38593.47427251659, 38828.22343553056, 39026.82919512306, 40199.59800401959, 39078.0, 39300.410493843185, 39596.0, 40175.397369040074, 41263.0, 37682.62317376791, 39180.804095979336, 39320.60679393169, 39583.40624890687, 39683.0, 33309.83345083259, 34034.31931361408, 34244.14389640279, 35216.0, 35257.82371088128, 25958.0, 25993.0, 26092.956281749277, 26591.20226393211, 26620.0], "value": 19243.926660280053, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.78684388038073, 390.1747803395817, 391.37380191693296, 398.44615983782563, 416.5272415808057, 15422.0, 15849.524514264562, 19656.11547480363, 21482.0, 21750.564988700236, 17518.562035949075, 20860.791392086074, 20887.895560522174, 21090.261840835574, 21481.67777483339, 5315.654482458647, 5944.524438044968, 5948.256467941507, 6178.104174894637, 6198.0, 4469.508354081048, 6179.104029915659, 6282.842928926791, 6288.182536270278, 6293.590916590407, 4136.75897230831, 6555.737770489175, 7007.334303241184, 7048.647567621624, 7122.180949190858, 5991.940080599182, 6308.905366419507, 6336.841578960563, 7083.468739844507, 7107.502474826764, 6136.969908503893, 6188.628682279078, 6207.162033125561, 6211.87576248477, 6212.223472065992, 13798.379072941741, 13987.230702311368, 22764.861756912087, 26061.869690651616, 26660.46679066408, 2257.4694946687514, 2266.909323627053, 2350.2126787526026, 2361.53949979754, 2925.107842108156, 9840.311178217527, 10211.132053775438, 10370.970079511431, 10756.031957123818, 10888.074513666268, 1855.5268406556243, 1951.375559820858, 1996.0718266006377, 2014.6977953306975, 2022.3225219551468, 115344.84655153508, 119787.40106299413, 124780.74526766856, 127805.0, 130056.0, 10808.891911080946, 11138.888611113947, 11385.772284554429, 11701.414929253504, 11702.70743231409, 14840.480583179537, 14847.925760371128, 14869.553913382615, 14871.182084985214, 14892.851071489147, 8841.42530735513, 8948.73153805387, 8957.372983891195, 8992.775180620536, 9076.727698169065, 9075.591598378089, 9077.954610227038, 9079.319051071196, 9229.215516681023, 9235.12266334697, 4557.1797076526545, 4566.1552612766745, 4575.794089265991, 4585.587297143273, 4663.370444989951, 1895.924163033491, 1936.912838922252, 1941.8543609229364, 1943.9902800485906, 1953.082051435823, 624.5721680648679, 653.4576301669603, 692.342274838905, 704.7775882687417, 840.5587066789861, 18565.907170464332, 19412.961639027697, 20044.098015589334, 21802.89098554497, 22745.0, 922.8938672052666, 957.262907561174, 997.5610731278215, 999.8000399920045, 1018.3889666200221, 11209.0, 11898.762024759457, 12038.699032524257, 12087.516499340103, 12094.818577721342, 652008.0, 655152.0, 658612.0, 666639.0, 666891.0, 62998.0, 80118.99999999884, 135263.32368338096, 145059.0, 151394.24302878635, 1012.3369193178627, 1015.669907280137, 1045.5399624165343, 1066.679996001212, 1067.4609322292347, 15562.688746225238, 19771.0, 20857.374278771662, 20940.895295523424, 21065.894670526548, 45294.77352613216, 57017.0, 58784.82430351454, 59194.40805591889, 59657.40342596518, 78665.0, 81564.59217703874, 85097.0, 85962.57018715117, 87592.0, 7543.8491230173995, 8185.631646575799, 8492.320614350714, 8528.019277782887, 8542.487450752975, 9465.006174351869, 12355.0, 13122.803157952447, 13501.729965400833, 13618.38717257706, 11308.83036754433, 11455.484503197209, 11530.538778448768, 11769.705757356134, 11975.28148311104, 11246.606368777053, 11314.20800543987, 11336.829947550628, 11570.363630000094, 11673.241239319417, 11616.128790340927, 11729.35488548138, 11830.231034982698, 11972.401379931143, 12148.635540933787, 8281.503109813431, 8339.499630022217, 8475.74572762818, 8523.147685231675, 8584.785380365542, 8874.955625221832, 11258.943705281421, 11453.656390308304, 11493.080553555528, 11926.165168438127], "value": 9735.415111003322, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1541.7841502189692, 1581.644130070734, 1822.307523141206, 1939.476341387826, 1985.0744777565756, 8922.553872306384, 9544.188743956773, 9546.713598592045, 9549.09283618056, 9561.99599042101, 8143.307818835391, 8357.28963038141, 8376.204260595248, 8489.278411335044, 9303.116203960613, 2144.517483566197, 2204.581129585382, 2312.7802858728396, 2386.2960426674085, 2396.101461951768, 2365.929022129339, 2380.5119950410126, 2382.4996750682376, 2385.3798012516786, 2385.7017872765905, 2363.8699871507147, 2413.6017557103055, 2422.7456117107627, 2425.527022230666, 2426.3327584914114, 2352.0709319818748, 2367.9052837886466, 2368.6328619064075, 2369.7748713872156, 2369.8104151667826, 2131.818795402393, 2285.994162568481, 2349.5300939811937, 2366.3137690069857, 2370.881455927197, 9301.53492325381, 9381.953090234574, 9402.576884040234, 9422.575984080733, 9428.717138485856, 5457.290552228224, 5563.499285064323, 5641.266635337421, 5645.15322701594, 5645.830625081254, 3282.573265475473, 3442.7245820334315, 3629.6007439181667, 3679.4480827875764, 3735.7384983051197, 1061.6178175856685, 1094.1137678480377, 1104.6465131158034, 1123.8988491035846, 1124.7919134959977, 12372.566960156351, 12380.195287306386, 12406.441710122976, 12409.689757756038, 12409.813852792215, 4819.759012049383, 4916.950830491649, 4947.876303092451, 5038.773255203525, 5063.1645778446145, 10538.947305263424, 10546.57813687444, 10550.947245263724, 10572.418516981486, 10594.841077383846, 5656.208130861683, 5657.20799088128, 5661.377248502661, 5664.660120392789, 5670.092785154356, 4966.528179822911, 5080.466551012164, 5161.870953226199, 5177.482251774868, 5188.45521220274, 3567.5362202913457, 3822.8470861165797, 3968.4840970673627, 4116.958830411658, 4236.5128010278595, 1297.941592628334, 1315.355475816862, 1317.3149962019695, 1325.2181213084327, 1334.2728213123871, 774.7908064822466, 879.5514287713185, 907.3421769217265, 910.9478552272136, 922.2667978956612, 5961.482725192158, 5996.340402555716, 5999.340072592011, 6168.0, 6237.844053898598, 797.4656979823532, 916.6608354908726, 993.6224234790877, 994.7165057958592, 1022.9897701023043, 3885.825137868803, 3962.366021436614, 4046.9797651012145, 4091.4428482198628, 4099.631033207026, 11073.833892491619, 11252.26860254081, 11369.97670209685, 11397.259178153394, 11451.713707157222, 10979.670609881716, 11345.716357090974, 11467.426628668532, 11487.310761354345, 11698.35659038744, 8567.0, 8793.988691300454, 8802.427842190236, 8804.559772011375, 8812.325658124935, 6030.427109424598, 6071.332153463204, 6111.633302001716, 6125.724342404514, 6339.207599050119, 10558.524866380878, 10717.678469645924, 10826.0, 10832.025117739442, 10838.078763305208, 10237.9488102559, 11026.0076593107, 11041.06150977176, 11054.0, 11072.667819965414, 7905.090914544901, 7953.761387158394, 8045.919540804517, 8064.0, 8072.152423995396, 7982.441229113906, 8251.752447426587, 8265.46274492156, 8814.735557933273, 8937.955310223408, 7921.009106669561, 8011.919880801117, 8023.83952320962, 8067.435279530377, 8161.755147345589, 7719.382449404146, 7766.611669416394, 7804.882926756217, 7923.84152316962, 7947.125816160334, 7295.124585049828, 7442.367398770949, 7452.701891924262, 7453.366463850417, 7453.739119130804, 5045.6720313180995, 5059.519345662156, 5069.670471419494, 5191.636585438983, 5355.919661205007, 5105.744712764273, 5119.974400127976, 5157.355330583677, 5232.3459567554055, 5234.345706786652], "value": 4777.888141520289, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.4307145637658, 310.92382366320254, 313.943490171769, 317.8109025130047, 323.06633828236414, 4847.994243568988, 5086.542211200996, 5428.701421421821, 5458.61789674723, 5468.6171967962255, 5294.4176140624595, 5325.520703136726, 5374.543163831079, 5399.541039011679, 5435.239066530688, 3897.9610203898023, 3899.883003509899, 4013.2575473537345, 4142.2958097123565, 4170.958290417103, 3691.741578089535, 4102.548719640837, 4110.198511290299, 4139.406328563509, 4175.979120104395, 3480.3387356402327, 3558.861164427384, 3581.2658405026905, 3947.6577963492405, 4067.698336532311, 3398.4902264660377, 3491.877784277538, 3913.571546385577, 3924.567532850503, 4094.222097801438, 3551.3074950384685, 3551.662592053751, 3562.412201986669, 3573.1960308930543, 3575.4636804479537, 4783.497732738082, 4787.779116325315, 4873.488283730228, 5059.86153115546, 5187.247849061865, 4128.422020917074, 4399.956000439986, 4538.682292239545, 4718.41019872516, 4744.122337367598, 4700.788464519105, 5592.105263157875, 5609.0, 5631.60578759487, 5786.508146807527, 3341.128967778052, 3505.439129739255, 3931.3120203964477, 3958.6833053355663, 4021.155557332964, 5582.637128586629, 5884.6465312977825, 5896.882062358729, 5901.790133022763, 5954.642721436728, 3965.048388386824, 3991.5850910199492, 3997.4403583498333, 3998.980260033673, 4025.5974402560096, 4052.675785937118, 4062.614051665087, 4065.5324637667045, 4065.6137666921595, 4093.7953102344763, 4680.9297860532115, 4706.482286948433, 4707.599854012447, 4714.292856071616, 4730.006698593265, 4956.851294461172, 5256.842294731164, 5682.801101961411, 5685.607026278588, 5735.541156707453, 1332.3138583629438, 1352.7091675289664, 1360.6122255157431, 1361.4213959067356, 1365.3105181883086, 779.6062988190927, 781.4881252779438, 814.3322475570094, 821.757581513455, 827.5283088639418, 4488.506264310923, 5193.454687257859, 5306.355029940653, 5344.144936810092, 5490.6431081979545, 5317.973410133002, 5359.196120581944, 5383.353997520244, 5831.717022255097, 5867.239828051567, 4689.695169813951, 5208.447860548304, 5358.419266316446, 5402.0, 5435.554000699701, 2499.6500489931423, 2984.343444442219, 3042.9501821871418, 3057.9541306880415, 3059.128148477673, 4844.878878028007, 5352.207010651476, 6027.517798576104, 6032.426919442646, 6044.486218671374, 5445.27736131934, 5488.313960754906, 5671.461211184931, 5974.253218347707, 6003.699815009232, 4845.466998630078, 5084.6440749147205, 5326.334208223894, 6049.758009679564, 6087.726052327655, 5397.1919406999095, 5758.1362795579325, 5775.364709881826, 5835.649861008353, 5844.253200995526, 4980.452150263541, 5320.829417528138, 5712.314522257356, 5715.371309156073, 5732.197492350991, 5976.073708575178, 6025.728842202199, 6079.726412311368, 6191.380861913773, 6273.811785646438, 3574.731895107929, 3678.724095692887, 3871.7483363582405, 3878.3820920878857, 3937.7202409217693, 4641.791119399702, 4860.878478038077, 4904.558589726942, 5696.572757043155, 5829.504492118217, 5672.914906276326, 5722.2561067061015, 5758.884822303614, 5787.594868359174, 5797.971010144923, 5512.724363781715, 5625.240592519957, 5636.154576813511, 5669.546436285004, 5687.232223649919, 4759.309900064541, 5030.522100400456, 5262.052830490548, 5501.9174712380145, 5618.410066942912, 5413.864653383697, 5525.0883604204855, 5587.552995760248, 5631.577631677558, 5644.8306550803545, 5603.170398948505, 5612.691301978267, 5615.606907516435, 5635.380108188014, 5689.943100568941], "value": 4119.74523218834, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.8827043537814, 754.9358304544114, 787.8109253779091, 831.0858056138248, 853.7993571510698, 15447.536573902787, 16618.25217865196, 16620.66758664826, 16622.584435389123, 16639.417620383305, 14844.480443184491, 14956.7008659827, 14959.401623935057, 14963.850361496381, 14977.0, 699.7585832887646, 711.2389742974993, 714.610537257196, 826.3802148388723, 847.4279861093768, 851.940364174508, 852.8933883264592, 864.9437786543886, 868.9522076285801, 868.9782755431133, 903.8237543678986, 904.0146240597747, 904.5748498205833, 905.2893478619285, 907.8411278026352, 893.9240164586018, 895.3419236860902, 896.8565029595266, 897.2194191053792, 897.6185121323476, 670.2125003121362, 671.9227288861795, 672.1161672400777, 672.5426709837309, 674.0125715826289, 15791.131487768169, 15829.525114246477, 15982.680346393006, 15998.600034999217, 16091.275892584861, 14240.0, 14770.926145369205, 14827.184504852228, 14871.405143794234, 15046.398144074225, 13205.669858253525, 13355.131916425498, 13380.732385352336, 13611.387487563083, 13698.863011369858, 4270.487541495009, 4701.106789709944, 4750.881227969294, 4758.547937945889, 4786.282057691375, 125392.0, 125824.0, 126718.0, 129018.3549082258, 129274.70725292721, 11557.30656160633, 11619.0, 11708.414579271002, 11743.88256117445, 11933.164678472423, 23122.190723324602, 23406.414839629146, 23731.0, 23783.52432951331, 23961.880190599284, 8200.576127167345, 8228.62971166299, 8237.876431853527, 8283.62723677436, 8335.249827515552, 4413.536578659258, 4478.820847166142, 4584.701994370355, 4663.533646635309, 4725.692829966041, 3474.652534746505, 3545.5922568904907, 3581.068922080278, 3592.856285748593, 3595.640435956436, 640.0559175216518, 642.7429028388589, 644.0757512968904, 647.5531883000715, 662.7547807311325, 510.706343852279, 576.711644177911, 632.788016014631, 635.596396288351, 637.1939496536885, 8112.513249204949, 8982.685606003759, 9040.954795225982, 9049.547522623843, 9097.49963752, 606.532969613404, 637.0539748473514, 645.5481163185789, 654.5679851298121, 660.3165723476275, 4040.9189267527245, 4326.82692692295, 4361.869143925624, 4378.693491455568, 4488.416505854283, 129741.0, 131727.0, 135619.0, 141210.0, 144492.0, 120691.39654301673, 120845.39577302233, 123099.0, 123316.0, 124112.0, 92722.0, 96130.51934740282, 98874.5056274714, 99402.0, 106601.0, 9620.470874101991, 9626.9037309626, 9843.753906152404, 9858.704238872846, 9861.408315501092, 55186.724066379415, 59469.0, 60736.69631651814, 60965.475863102, 62539.749205014734, 89853.0, 91912.08087919035, 94809.0, 96043.51978240344, 98471.0, 12687.429065691882, 13185.208887466782, 13500.122492037986, 13642.727145457235, 13700.52048178349, 14725.116493010453, 15532.922335388703, 15550.0, 16151.596210094842, 16383.935044222088, 13915.791263130859, 14149.36327865228, 14628.195449250394, 14869.925650372112, 14950.401983920521, 13629.591112266648, 14175.29123543798, 14248.216348100954, 14688.55934321972, 14943.626409339418, 12886.742265154831, 13728.45086196541, 14100.717985640435, 14488.34802433914, 14691.926540367229, 11130.777384452427, 11675.0, 11688.649340519798, 11800.409979501163, 12268.87731122713, 11611.0, 11724.472398741906, 11935.0, 11943.462544185359, 12012.459439325427], "value": 8017.834586356798, "unit": "score"}], "name": "dromaeo_css", "value": 7428.18366163966, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 113.0, 116.0, 163.0, 170.0, 113.0, 113.0, 113.0, 114.0, 114.0], "value": 124.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 113.0, 108.0, 142.0, 110.0, 110.0, 108.0, 109.0, 137.0, 103.0], "value": 118.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 183.0, 183.0, 182.0, 182.0, 184.0, 184.0, 182.0, 184.0, 183.0], "value": 182.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 58.0, 91.0, 79.0, 83.0, 84.0, 73.0, 83.0, 57.0], "value": 74.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 72.0, 94.0, 70.0, 68.0, 68.0, 93.0, 69.0, 68.0, 89.0], "value": 77.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 91.0, 94.0, 86.0, 89.0, 90.0, 92.0, 131.0, 135.0, 86.0], "value": 98.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 97.0, 95.0, 94.0, 101.0, 149.0, 132.0, 94.0, 94.0], "value": 104.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 85.0, 85.0, 85.0, 83.0, 83.0, 83.0, 84.0, 85.0], "value": 84.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 51.0, 53.0, 56.0, 56.0, 56.0, 56.0, 57.0, 57.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 73.0, 68.0, 81.0, 74.0, 72.0, 68.0, 68.0, 69.0, 69.0], "value": 70.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 99.0, 96.0, 82.0, 80.0, 84.0, 85.0, 85.0, 87.0, 88.0], "value": 87.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 145.0, 147.0, 133.0, 141.0, 148.0, 149.0, 149.0, 167.0, 147.0], "value": 146.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 161.0, 160.0, 164.0, 163.0, 158.0, 162.0, 162.0, 160.0], "value": 161.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 64.0, 65.0, 65.0, 66.0, 66.0, 65.0, 64.0, 64.0], "value": 65.5, "unit": "score"}], "name": "kraken", "value": 1451.5, "alertThreshold": 2.0}]} 03:36:10 INFO - Return code: 0 03:36:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:36:10 INFO - # TBPL SUCCESS # 03:36:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:36:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:36:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:36:10 INFO - 2017-01-05 03:36:10.961 screenresolution[1944:13316] starting screenresolution argv=screenresolution get 03:36:10 INFO - 2017-01-05 03:36:10.964 screenresolution[1944:13316] Display 0: 1600x1200x32@60 03:36:10 INFO - 2017-01-05 03:36:10.970 screenresolution[1945:13319] starting screenresolution argv=screenresolution list 03:36:10 INFO - Available Modes on Display 0 03:36:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:36:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:36:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:36:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:36:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:36:11 INFO - Intel Iris: 03:36:11 INFO - Chipset Model: Intel Iris 03:36:11 INFO - Type: GPU 03:36:11 INFO - Bus: Built-In 03:36:11 INFO - VRAM (Dynamic, Max): 1536 MB 03:36:11 INFO - Vendor: Intel (0x8086) 03:36:11 INFO - Device ID: 0x0a2e 03:36:11 INFO - Revision ID: 0x0009 03:36:11 INFO - Displays: 03:36:11 INFO - Display: 03:36:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:36:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:36:11 INFO - Display Serial Number: 1600x1200 60 03:36:11 INFO - Main Display: Yes 03:36:11 INFO - Mirror: Off 03:36:11 INFO - Online: Yes 03:36:11 INFO - Rotation: Supported 03:36:11 INFO - Return code: 0 03:36:11 INFO - Running post-action listener: _resource_record_post_action 03:36:11 INFO - [mozharness: 2017-01-05 11:36:11.202236Z] Finished run-tests step (success) 03:36:11 INFO - Running post-run listener: _resource_record_post_run 03:36:11 INFO - Total resource usage - Wall time: 1197s; CPU: 53.0%; Read bytes: 557056; Write bytes: 494803968; Read time: 11; Write time: 1594 03:36:11 INFO - TinderboxPrint: CPU usage
53.3% 03:36:11 INFO - TinderboxPrint: I/O read bytes / time
557,056 / 11 03:36:11 INFO - TinderboxPrint: I/O write bytes / time
494,803,968 / 1,594 03:36:11 INFO - TinderboxPrint: CPU idle
2,238.3 (46.7%) 03:36:11 INFO - TinderboxPrint: CPU system
959.3 (20.0%) 03:36:11 INFO - TinderboxPrint: CPU user
1,592.0 (33.2%) 03:36:11 INFO - TinderboxPrint: Swap in / out
196,046,848 / 0 03:36:11 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 190358016; Write bytes: 187928064; Read time: 17667; Write time: 424 03:36:11 INFO - run-tests - Wall time: 1175s; CPU: 53.0%; Read bytes: 557056; Write bytes: 295845376; Read time: 11; Write time: 1132 03:36:11 INFO - Running post-run listener: _upload_blobber_files 03:36:11 INFO - Blob upload gear active. 03:36:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:36:11 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 03:36:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:36:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:36:12 INFO - (blobuploader) - INFO - Open directory for files ... 03:36:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:36:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:36:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:36:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:36:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:36:13 INFO - (blobuploader) - INFO - Done attempting. 03:36:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:36:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:36:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:36:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:36:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:36:14 INFO - (blobuploader) - INFO - Done attempting. 03:36:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:36:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:36:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:36:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:36:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:36:16 INFO - (blobuploader) - INFO - Done attempting. 03:36:16 INFO - (blobuploader) - INFO - Iteration through files over. 03:36:16 INFO - Return code: 0 03:36:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:36:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:36:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9219c57fd345b4cf0e1232479aad75af2ac11cfb177aeb4ba60f6ec901b982a9df8cb1a57acff28f01f7f700e70b3c1d3b6b9d5bd64d4776906081036586cff5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/80fe9e3ee7b9c63d23ead5a01b2c48981d4c2b4aea4d12bc29a5ca719a5b260acf05d9a84721f2489ab8aebdd17a7d150e98b6a84f93c5f84bc774fc8df05aac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e9ce6c701d73e9f226987f38b60740318072871461d6b75f3ca0c41e8ff361f619b8c1a7afb0f6fe9dbb6d67fd9697f4467d7e72ad102018284edde89093fc0e"} 03:36:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:36:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:36:16 INFO - Contents: 03:36:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9219c57fd345b4cf0e1232479aad75af2ac11cfb177aeb4ba60f6ec901b982a9df8cb1a57acff28f01f7f700e70b3c1d3b6b9d5bd64d4776906081036586cff5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/80fe9e3ee7b9c63d23ead5a01b2c48981d4c2b4aea4d12bc29a5ca719a5b260acf05d9a84721f2489ab8aebdd17a7d150e98b6a84f93c5f84bc774fc8df05aac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e9ce6c701d73e9f226987f38b60740318072871461d6b75f3ca0c41e8ff361f619b8c1a7afb0f6fe9dbb6d67fd9697f4467d7e72ad102018284edde89093fc0e"} 03:36:16 INFO - Running post-run listener: copy_logs_to_upload_dir 03:36:16 INFO - Copying logs to upload dir... 03:36:16 INFO - mkdir: /builds/slave/test/build/upload/logs 03:36:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.313143 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-01-05 03:36:16.513805) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-05 03:36:16.517475) ========= 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.x7NwlGubV6/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.BbkNeL0Gmj/Listeners TMPDIR=/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9219c57fd345b4cf0e1232479aad75af2ac11cfb177aeb4ba60f6ec901b982a9df8cb1a57acff28f01f7f700e70b3c1d3b6b9d5bd64d4776906081036586cff5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/80fe9e3ee7b9c63d23ead5a01b2c48981d4c2b4aea4d12bc29a5ca719a5b260acf05d9a84721f2489ab8aebdd17a7d150e98b6a84f93c5f84bc774fc8df05aac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e9ce6c701d73e9f226987f38b60740318072871461d6b75f3ca0c41e8ff361f619b8c1a7afb0f6fe9dbb6d67fd9697f4467d7e72ad102018284edde89093fc0e"} build_url:https://queue.taskcluster.net/v1/task/DzXT7OL7RYGcpZi_ydcPUQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011077 build_url: 'https://queue.taskcluster.net/v1/task/DzXT7OL7RYGcpZi_ydcPUQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9219c57fd345b4cf0e1232479aad75af2ac11cfb177aeb4ba60f6ec901b982a9df8cb1a57acff28f01f7f700e70b3c1d3b6b9d5bd64d4776906081036586cff5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/80fe9e3ee7b9c63d23ead5a01b2c48981d4c2b4aea4d12bc29a5ca719a5b260acf05d9a84721f2489ab8aebdd17a7d150e98b6a84f93c5f84bc774fc8df05aac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e9ce6c701d73e9f226987f38b60740318072871461d6b75f3ca0c41e8ff361f619b8c1a7afb0f6fe9dbb6d67fd9697f4467d7e72ad102018284edde89093fc0e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-05 03:36:16.552129) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 03:36:16.552464) ========= 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.x7NwlGubV6/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.BbkNeL0Gmj/Listeners TMPDIR=/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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.005035 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 03:36:16.602695) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-05 03:36:16.603002) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-05 03:36:16.605904) ========= ========= Total master_lag: 0.22 =========