builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0303 starttime: 1480529107.48 results: success (0) buildid: 20161130073344 builduid: 84217a711ef5447a9e8dbfecc29bad26 revision: a065f231fb79a48683b37c4cdb5136d7f14fd560 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-30 10:05:07.475541) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-30 10:05:07.475961) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-30 10:05:07.476236) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-30 10:05:07.501456) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 10:05:07.501821) ========= 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.pw4tUhLOA0/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.IqylKf73XF/Listeners TMPDIR=/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-30 10:05:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.22M=0.001s 2016-11-30 10:05:07 (8.22 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.118812 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 10:05:07.647441) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 10:05:07.647805) ========= 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.pw4tUhLOA0/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.IqylKf73XF/Listeners TMPDIR=/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/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.021240 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 10:05:07.696238) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-30 10:05:07.696624) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a065f231fb79a48683b37c4cdb5136d7f14fd560 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a065f231fb79a48683b37c4cdb5136d7f14fd560 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.pw4tUhLOA0/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.IqylKf73XF/Listeners TMPDIR=/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-30 10:05:07,783 truncating revision to first 12 chars 2016-11-30 10:05:07,784 Setting DEBUG logging. 2016-11-30 10:05:07,784 attempt 1/10 2016-11-30 10:05:07,784 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a065f231fb79?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-30 10:05:09,297 unpacking tar archive at: mozilla-aurora-a065f231fb79/testing/mozharness/ program finished with exit code 0 elapsedTime=1.779215 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-30 10:05:09.505895) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-30 10:05:09.506294) ========= script_repo_revision: a065f231fb79a48683b37c4cdb5136d7f14fd560 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-30 10:05:09.506744) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-30 10:05:09.507020) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-30 10:05:09.527087) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-11-30 10:05:09.527542) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.pw4tUhLOA0/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.IqylKf73XF/Listeners TMPDIR=/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/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 10:05:09 INFO - MultiFileLogger online at 20161130 10:05:09 in /builds/slave/test 10:05:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 10:05:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:05:09 INFO - {'append_to_log': False, 10:05:09 INFO - 'base_work_dir': '/builds/slave/test', 10:05:09 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 10:05:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:05:09 INFO - 'branch': 'Mozilla-Aurora', 10:05:09 INFO - 'buildbot_json_path': 'buildprops.json', 10:05:09 INFO - 'config_files': ('talos/mac_config.py',), 10:05:09 INFO - 'default_actions': ('clobber', 10:05:09 INFO - 'read-buildbot-config', 10:05:09 INFO - 'download-and-extract', 10:05:09 INFO - 'populate-webroot', 10:05:09 INFO - 'create-virtualenv', 10:05:09 INFO - 'install', 10:05:09 INFO - 'run-tests'), 10:05:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:05:09 INFO - 'download_minidump_stackwalk': True, 10:05:09 INFO - 'download_symbols': 'ondemand', 10:05:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:05:09 INFO - 'tooltool.py': '/tools/tooltool.py', 10:05:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:05:09 INFO - '/tools/misc-python/virtualenv.py')}, 10:05:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:05:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:05:09 INFO - 'installer_path': 'installer.exe', 10:05:09 INFO - 'log_level': 'info', 10:05:09 INFO - 'log_name': 'talos', 10:05:09 INFO - 'log_to_console': True, 10:05:09 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:05:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:05:09 INFO - 'opt_config_files': (), 10:05:09 INFO - 'pip_index': False, 10:05:09 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:05:09 INFO - 'cmd': ('bash', 10:05:09 INFO - '-c', 10:05:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:05:09 INFO - 'enabled': True, 10:05:09 INFO - 'halt_on_failure': False, 10:05:09 INFO - 'name': 'check_screen_resolution'},), 10:05:09 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:05:09 INFO - 'cmd': ('bash', 10:05:09 INFO - '-c', 10:05:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:05:09 INFO - 'enabled': True, 10:05:09 INFO - 'halt_on_failure': False, 10:05:09 INFO - 'name': 'check_screen_resolution'},), 10:05:09 INFO - 'run_cmd_checks_enabled': True, 10:05:09 INFO - 'sps_profile': False, 10:05:09 INFO - 'sps_profile_interval': 0, 10:05:09 INFO - 'suite': 'dromaeojs-e10s', 10:05:09 INFO - 'system_bits': '32', 10:05:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:05:09 INFO - 'title': 't-yosemite-r7-0303', 10:05:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:05:09 INFO - 'use_talos_json': True, 10:05:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:05:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:05:09 INFO - 'work_dir': 'build'} 10:05:09 INFO - [mozharness: 2016-11-30 18:05:09.732364Z] Running clobber step. 10:05:09 INFO - Running pre-action listener: _resource_record_pre_action 10:05:09 INFO - Running main action method: clobber 10:05:09 INFO - rmtree: /builds/slave/test/build 10:05:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:05:10 INFO - Running post-action listener: _resource_record_post_action 10:05:10 INFO - [mozharness: 2016-11-30 18:05:10.207689Z] Finished clobber step (success) 10:05:10 INFO - [mozharness: 2016-11-30 18:05:10.207859Z] Running read-buildbot-config step. 10:05:10 INFO - Running pre-action listener: _resource_record_pre_action 10:05:10 INFO - Running main action method: read_buildbot_config 10:05:10 INFO - Using buildbot properties: 10:05:10 INFO - { 10:05:10 INFO - "project": "", 10:05:10 INFO - "product": "firefox", 10:05:10 INFO - "script_repo_revision": "production", 10:05:10 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 10:05:10 INFO - "repository": "", 10:05:10 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 10:05:10 INFO - "buildid": "20161130073344", 10:05:10 INFO - "pgo_build": "False", 10:05:10 INFO - "basedir": "/builds/slave/test", 10:05:10 INFO - "buildnumber": 1, 10:05:10 INFO - "slavename": "t-yosemite-r7-0303", 10:05:10 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 10:05:10 INFO - "platform": "yosemite_r7", 10:05:10 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 10:05:10 INFO - "branch": "mozilla-aurora", 10:05:10 INFO - "repo_path": "releases/mozilla-aurora", 10:05:10 INFO - "revision": "a065f231fb79a48683b37c4cdb5136d7f14fd560", 10:05:10 INFO - "stage_platform": "macosx64", 10:05:10 INFO - "builduid": "84217a711ef5447a9e8dbfecc29bad26", 10:05:10 INFO - "slavebuilddir": "test" 10:05:10 INFO - } 10:05:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/MILHvp24QGu-jPZIsXD1tA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 10:05:10 INFO - Running post-action listener: _resource_record_post_action 10:05:10 INFO - [mozharness: 2016-11-30 18:05:10.211073Z] Finished read-buildbot-config step (success) 10:05:10 INFO - [mozharness: 2016-11-30 18:05:10.211226Z] Running download-and-extract step. 10:05:10 INFO - Running pre-action listener: _resource_record_pre_action 10:05:10 INFO - Running main action method: download_and_extract 10:05:10 INFO - mkdir: /builds/slave/test/build/tests 10:05:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:10 INFO - trying https://queue.taskcluster.net/v1/task/MILHvp24QGu-jPZIsXD1tA/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 10:05:10 INFO - Downloading https://queue.taskcluster.net/v1/task/MILHvp24QGu-jPZIsXD1tA/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 10:05:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MILHvp24QGu-jPZIsXD1tA/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 10:05:11 INFO - Downloaded 1199 bytes. 10:05:11 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 10:05:11 INFO - Using the following test package requirements: 10:05:11 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 10:05:11 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:05:11 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 10:05:11 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:05:11 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 10:05:11 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:05:11 INFO - u'jsshell-mac.zip'], 10:05:11 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:05:11 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 10:05:11 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 10:05:11 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:05:11 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 10:05:11 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:05:11 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 10:05:11 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:05:11 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 10:05:11 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:05:11 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 10:05:11 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 10:05:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MILHvp24QGu-jPZIsXD1tA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 10:05:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MILHvp24QGu-jPZIsXD1tA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 10:05:11 INFO - Fetch https://queue.taskcluster.net/v1/task/MILHvp24QGu-jPZIsXD1tA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 10:05:11 INFO - Http code: 200 10:05:11 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 10:05:11 INFO - x-amz-cf-id: JHeCLuEkkWyvaxIEihefji-fSAVrWxN2QPIRkZ6zLQrSlIWd_OA7PA== 10:05:11 INFO - x-amz-version-id: 1bXHXx3jjDzeNONUYAWbJWbq.yppcq4Y 10:05:12 INFO - Expected file size: 16285161 10:05:12 INFO - Obtained file size: 16285161 10:05:18 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 10:05:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MILHvp24QGu-jPZIsXD1tA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 10:05:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MILHvp24QGu-jPZIsXD1tA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 10:05:18 INFO - Fetch https://queue.taskcluster.net/v1/task/MILHvp24QGu-jPZIsXD1tA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 10:05:19 INFO - Http code: 200 10:05:19 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 10:05:19 INFO - x-amz-cf-id: PvKN_9QWai7odW2uIYzxPVKzY2GD9qwJcDUBo-HK4CD5P3aj41WXnQ== 10:05:19 INFO - x-amz-version-id: 1bXHXx3jjDzeNONUYAWbJWbq.yppcq4Y 10:05:19 INFO - Expected file size: 16285161 10:05:19 INFO - Obtained file size: 16285161 10:05:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MILHvp24QGu-jPZIsXD1tA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 10:05:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MILHvp24QGu-jPZIsXD1tA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 10:05:25 INFO - Fetch https://queue.taskcluster.net/v1/task/MILHvp24QGu-jPZIsXD1tA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 10:05:26 INFO - Http code: 200 10:05:26 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 10:05:26 INFO - x-amz-cf-id: zoqxUpO8vYo2Wh33WqCsqqXwgI2yskN1-JW3HoKuzrfvPfRVijp5iw== 10:05:26 INFO - x-amz-version-id: 34IDlPyO7uSbKXJROei1dtRlkrFy_58I 10:05:27 INFO - Expected file size: 14409038 10:05:27 INFO - Obtained file size: 14409038 10:05:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:27 INFO - trying https://queue.taskcluster.net/v1/task/MILHvp24QGu-jPZIsXD1tA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 10:05:27 INFO - Downloading https://queue.taskcluster.net/v1/task/MILHvp24QGu-jPZIsXD1tA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 10:05:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MILHvp24QGu-jPZIsXD1tA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 10:05:30 INFO - Downloaded 109765052 bytes. 10:05:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MILHvp24QGu-jPZIsXD1tA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 10:05:30 INFO - mkdir: /builds/slave/test/properties 10:05:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:05:30 INFO - Writing to file /builds/slave/test/properties/build_url 10:05:30 INFO - Contents: 10:05:30 INFO - build_url:https://queue.taskcluster.net/v1/task/MILHvp24QGu-jPZIsXD1tA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 10:05:31 INFO - Running post-action listener: _resource_record_post_action 10:05:31 INFO - Running post-action listener: set_extra_try_arguments 10:05:31 INFO - [mozharness: 2016-11-30 18:05:31.573670Z] Finished download-and-extract step (success) 10:05:31 INFO - [mozharness: 2016-11-30 18:05:31.573830Z] Running populate-webroot step. 10:05:31 INFO - Running pre-action listener: _resource_record_pre_action 10:05:31 INFO - Running main action method: populate_webroot 10:05:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:05:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:05:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:05:31 INFO - '--tppagecycles', 10:05:31 INFO - '7'], 10:05:31 INFO - 'tests': ['tsvgm']}}, 10:05:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:05:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:05:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:05:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:05:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:05:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:05:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:31 INFO - 'talos_options': ['--disable-e10s'], 10:05:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:05:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:05:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:31 INFO - 'talos_options': ['--disable-e10s'], 10:05:31 INFO - 'tests': ['damp', 'tps']}, 10:05:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:31 INFO - 'tests': ['damp', 'tps']}, 10:05:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:05:31 INFO - 'tests': ['dromaeo_dom']}, 10:05:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:05:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:05:31 INFO - 'tests': ['basic_compositor_video']}, 10:05:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:05:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:05:31 INFO - 'tests': ['a11yr', 10:05:31 INFO - 'ts_paint', 10:05:31 INFO - 'tpaint', 10:05:31 INFO - 'sessionrestore', 10:05:31 INFO - 'sessionrestore_no_auto_restore', 10:05:31 INFO - 'tabpaint']}, 10:05:31 INFO - 'other-e10s': {'tests': ['a11yr', 10:05:31 INFO - 'ts_paint', 10:05:31 INFO - 'tpaint', 10:05:31 INFO - 'sessionrestore', 10:05:31 INFO - 'sessionrestore_no_auto_restore', 10:05:31 INFO - 'tabpaint']}, 10:05:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:05:31 INFO - 'ts_paint', 10:05:31 INFO - 'tpaint', 10:05:31 INFO - 'sessionrestore', 10:05:31 INFO - 'sessionrestore_no_auto_restore', 10:05:31 INFO - 'tabpaint']}, 10:05:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:05:31 INFO - 'ts_paint', 10:05:31 INFO - 'tpaint', 10:05:31 INFO - 'sessionrestore', 10:05:31 INFO - 'sessionrestore_no_auto_restore', 10:05:31 INFO - 'tabpaint']}, 10:05:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:05:31 INFO - 'tests': ['a11yr', 10:05:31 INFO - 'ts_paint', 10:05:31 INFO - 'tpaint', 10:05:31 INFO - 'sessionrestore', 10:05:31 INFO - 'sessionrestore_no_auto_restore', 10:05:31 INFO - 'tabpaint']}, 10:05:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:05:31 INFO - 'tests': ['a11yr', 10:05:31 INFO - 'ts_paint', 10:05:31 INFO - 'tpaint', 10:05:31 INFO - 'sessionrestore', 10:05:31 INFO - 'sessionrestore_no_auto_restore', 10:05:31 INFO - 'tabpaint']}, 10:05:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:05:31 INFO - 'tests': ['tsvgx', 10:05:31 INFO - 'tsvgr_opacity', 10:05:31 INFO - 'tart', 10:05:31 INFO - 'tscrollx', 10:05:31 INFO - 'cart']}, 10:05:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:05:31 INFO - 'tsvgr_opacity', 10:05:31 INFO - 'tart', 10:05:31 INFO - 'tscrollx', 10:05:31 INFO - 'cart']}, 10:05:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:31 INFO - 'talos_options': ['--disable-e10s'], 10:05:31 INFO - 'tests': ['tp5o']}, 10:05:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:31 INFO - 'tests': ['tp5o']}, 10:05:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:31 INFO - 'talos_options': ['--disable-e10s', 10:05:31 INFO - '--xperf_path', 10:05:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:05:31 INFO - 'tests': ['tp5n']}, 10:05:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:31 INFO - 'talos_options': ['--xperf_path', 10:05:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:05:31 INFO - 'tests': ['tp5n']}}, 10:05:31 INFO - 'talos.zip': {'path': '', 10:05:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:05:31 INFO - Running post-action listener: _resource_record_post_action 10:05:31 INFO - [mozharness: 2016-11-30 18:05:31.592613Z] Finished populate-webroot step (success) 10:05:31 INFO - [mozharness: 2016-11-30 18:05:31.592720Z] Running create-virtualenv step. 10:05:31 INFO - Running pre-action listener: _resource_record_pre_action 10:05:31 INFO - Running main action method: create_virtualenv 10:05:31 INFO - Creating virtualenv /builds/slave/test/build/venv 10:05:31 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:05:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:05:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:05:31 INFO - Using real prefix '/tools/python27' 10:05:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:05:32 INFO - Installing distribute.............................................................................................................................................................................................done. 10:05:35 INFO - Installing pip.................done. 10:05:35 INFO - Return code: 0 10:05:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:05:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:05:35 INFO - Reading from file tmpfile_stdout 10:05:35 INFO - Output received: 10:05:35 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 10:05:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:05:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b387490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2fd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff638481400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b19bd30>, '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 0x10b001db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b193b20>, '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.pw4tUhLOA0/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.IqylKf73XF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/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 10:05:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:05:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:05:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pw4tUhLOA0/Render', 10:05:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:05:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:05:35 INFO - 'HOME': '/Users/cltbld', 10:05:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:05:35 INFO - 'LOGNAME': 'cltbld', 10:05:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:35 INFO - 'MOZ_NO_REMOTE': '1', 10:05:35 INFO - 'NO_EM_RESTART': '1', 10:05:35 INFO - 'PAGER': '/bin/cat', 10:05:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:05:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:35 INFO - 'PWD': '/builds/slave/test', 10:05:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:05:35 INFO - 'SHELL': '/bin/bash', 10:05:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IqylKf73XF/Listeners', 10:05:35 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 10:05:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:05:35 INFO - 'USER': 'cltbld', 10:05:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:05:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:05:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:35 INFO - 'XPC_FLAGS': '0x0', 10:05:35 INFO - 'XPC_SERVICE_NAME': '0', 10:05:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:05:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:35 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:05:35 INFO - Cleaning up... 10:05:35 INFO - Return code: 0 10:05:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:05:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b387490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2fd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff638481400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b19bd30>, '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 0x10b001db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b193b20>, '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.pw4tUhLOA0/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.IqylKf73XF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/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 10:05:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:05:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:05:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pw4tUhLOA0/Render', 10:05:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:05:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:05:35 INFO - 'HOME': '/Users/cltbld', 10:05:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:05:35 INFO - 'LOGNAME': 'cltbld', 10:05:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:35 INFO - 'MOZ_NO_REMOTE': '1', 10:05:35 INFO - 'NO_EM_RESTART': '1', 10:05:35 INFO - 'PAGER': '/bin/cat', 10:05:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:05:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:35 INFO - 'PWD': '/builds/slave/test', 10:05:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:05:35 INFO - 'SHELL': '/bin/bash', 10:05:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IqylKf73XF/Listeners', 10:05:35 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 10:05:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:05:35 INFO - 'USER': 'cltbld', 10:05:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:05:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:05:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:35 INFO - 'XPC_FLAGS': '0x0', 10:05:35 INFO - 'XPC_SERVICE_NAME': '0', 10:05:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:05:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:36 INFO - Downloading/unpacking psutil>=3.1.1 10:05:36 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 10:05:36 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 10:05:36 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 10:05:36 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 10:05:36 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 10:05:36 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 10:05:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:05:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:05:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:05:39 INFO - Installing collected packages: psutil 10:05:39 INFO - Running setup.py install for psutil 10:05:39 INFO - building 'psutil._psutil_osx' extension 10:05:39 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 10:05:39 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 10:05:40 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 10:05:40 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 10:05:40 INFO - building 'psutil._psutil_posix' extension 10:05:40 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 10:05:40 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:05:40 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:05:40 INFO - ^ 10:05:40 INFO - 1 warning generated. 10:05:40 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 10:05:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:05:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:05:40 INFO - Successfully installed psutil 10:05:40 INFO - Cleaning up... 10:05:40 INFO - Return code: 0 10:05:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:05:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b387490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2fd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff638481400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b19bd30>, '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 0x10b001db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b193b20>, '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.pw4tUhLOA0/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.IqylKf73XF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/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 10:05:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:05:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:05:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pw4tUhLOA0/Render', 10:05:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:05:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:05:40 INFO - 'HOME': '/Users/cltbld', 10:05:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:05:40 INFO - 'LOGNAME': 'cltbld', 10:05:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:40 INFO - 'MOZ_NO_REMOTE': '1', 10:05:40 INFO - 'NO_EM_RESTART': '1', 10:05:40 INFO - 'PAGER': '/bin/cat', 10:05:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:05:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:40 INFO - 'PWD': '/builds/slave/test', 10:05:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:05:40 INFO - 'SHELL': '/bin/bash', 10:05:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IqylKf73XF/Listeners', 10:05:40 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 10:05:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:05:40 INFO - 'USER': 'cltbld', 10:05:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:05:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:05:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:40 INFO - 'XPC_FLAGS': '0x0', 10:05:40 INFO - 'XPC_SERVICE_NAME': '0', 10:05:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:05:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:05:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:05:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:05:43 INFO - Installing collected packages: mozsystemmonitor 10:05:43 INFO - Running setup.py install for mozsystemmonitor 10:05:43 INFO - Successfully installed mozsystemmonitor 10:05:43 INFO - Cleaning up... 10:05:43 INFO - Return code: 0 10:05:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:05:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:43 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 0x10b387490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2fd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff638481400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b19bd30>, '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 0x10b001db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b193b20>, '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.pw4tUhLOA0/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.IqylKf73XF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/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 10:05:43 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 10:05:43 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 10:05:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pw4tUhLOA0/Render', 10:05:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:05:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:05:43 INFO - 'HOME': '/Users/cltbld', 10:05:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:05:43 INFO - 'LOGNAME': 'cltbld', 10:05:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:43 INFO - 'MOZ_NO_REMOTE': '1', 10:05:43 INFO - 'NO_EM_RESTART': '1', 10:05:43 INFO - 'PAGER': '/bin/cat', 10:05:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:05:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:43 INFO - 'PWD': '/builds/slave/test', 10:05:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:05:43 INFO - 'SHELL': '/bin/bash', 10:05:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IqylKf73XF/Listeners', 10:05:43 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 10:05:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:05:43 INFO - 'USER': 'cltbld', 10:05:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:05:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:05:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:43 INFO - 'XPC_FLAGS': '0x0', 10:05:43 INFO - 'XPC_SERVICE_NAME': '0', 10:05:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:05:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:43 INFO - Downloading/unpacking jsonschema==2.5.1 10:05:43 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 10:05:43 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 10:05:43 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 10:05:43 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 10:05:43 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 10:05:43 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 10:05:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:05:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:05: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 10:05: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 10:05: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 10:05: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 10:05: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 10:05: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 10:05:46 INFO - Downloading functools32-3.2.3-2.tar.gz 10:05:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:05:46 INFO - warning: no files found matching '*.txt' 10:05:46 INFO - no previously-included directories found matching 'build' 10:05:46 INFO - no previously-included directories found matching 'dist' 10:05:46 INFO - no previously-included directories found matching '.git*' 10:05:46 INFO - Installing collected packages: jsonschema, functools32 10:05:46 INFO - Running setup.py install for functools32 10:05:46 INFO - warning: no files found matching '*.txt' 10:05:46 INFO - no previously-included directories found matching 'build' 10:05:46 INFO - no previously-included directories found matching 'dist' 10:05:46 INFO - no previously-included directories found matching '.git*' 10:05:47 INFO - Successfully installed jsonschema functools32 10:05:47 INFO - Cleaning up... 10:05:47 INFO - Return code: 0 10:05:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:05:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b387490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2fd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff638481400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b19bd30>, '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 0x10b001db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b193b20>, '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.pw4tUhLOA0/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.IqylKf73XF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/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 10:05:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:05:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:05:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pw4tUhLOA0/Render', 10:05:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:05:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:05:47 INFO - 'HOME': '/Users/cltbld', 10:05:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:05:47 INFO - 'LOGNAME': 'cltbld', 10:05:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:47 INFO - 'MOZ_NO_REMOTE': '1', 10:05:47 INFO - 'NO_EM_RESTART': '1', 10:05:47 INFO - 'PAGER': '/bin/cat', 10:05:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:05:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:47 INFO - 'PWD': '/builds/slave/test', 10:05:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:05:47 INFO - 'SHELL': '/bin/bash', 10:05:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IqylKf73XF/Listeners', 10:05:47 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 10:05:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:05:47 INFO - 'USER': 'cltbld', 10:05:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:05:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:05:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:47 INFO - 'XPC_FLAGS': '0x0', 10:05:47 INFO - 'XPC_SERVICE_NAME': '0', 10:05:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:05:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:05:47 INFO - Cleaning up... 10:05:47 INFO - Return code: 0 10:05:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:05:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b387490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2fd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff638481400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b19bd30>, '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 0x10b001db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b193b20>, '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.pw4tUhLOA0/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.IqylKf73XF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/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 10:05:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:05:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:05:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pw4tUhLOA0/Render', 10:05:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:05:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:05:47 INFO - 'HOME': '/Users/cltbld', 10:05:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:05:47 INFO - 'LOGNAME': 'cltbld', 10:05:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:47 INFO - 'MOZ_NO_REMOTE': '1', 10:05:47 INFO - 'NO_EM_RESTART': '1', 10:05:47 INFO - 'PAGER': '/bin/cat', 10:05:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:05:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:47 INFO - 'PWD': '/builds/slave/test', 10:05:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:05:47 INFO - 'SHELL': '/bin/bash', 10:05:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IqylKf73XF/Listeners', 10:05:47 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 10:05:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:05:47 INFO - 'USER': 'cltbld', 10:05:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:05:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:05:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:47 INFO - 'XPC_FLAGS': '0x0', 10:05:47 INFO - 'XPC_SERVICE_NAME': '0', 10:05:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:05:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:47 INFO - Downloading/unpacking blobuploader==1.2.4 10:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:50 INFO - Downloading blobuploader-1.2.4.tar.gz 10:05:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:05:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:05:50 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 10:05:50 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 10:05:50 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 10:05:50 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 10:05:50 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 10:05:50 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 10:05:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:05:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:05:50 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 10:05:50 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 10:05:50 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 10:05:50 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 10:05:50 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 10:05:50 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 10:05:51 INFO - Downloading docopt-0.6.1.tar.gz 10:05:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:05:51 INFO - Installing collected packages: blobuploader, requests, docopt 10:05:51 INFO - Running setup.py install for blobuploader 10:05:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:05:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:05:51 INFO - Running setup.py install for requests 10:05:52 INFO - Running setup.py install for docopt 10:05:52 INFO - Successfully installed blobuploader requests docopt 10:05:52 INFO - Cleaning up... 10:05:52 INFO - Return code: 0 10:05:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:05:52 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')]} 10:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:52 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')]} 10:05:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:52 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 0x10b387490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2fd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff638481400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b19bd30>, '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 0x10b001db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b193b20>, '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.pw4tUhLOA0/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.IqylKf73XF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/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 10:05:52 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 10:05:52 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 10:05:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pw4tUhLOA0/Render', 10:05:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:05:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:05:52 INFO - 'HOME': '/Users/cltbld', 10:05:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:05:52 INFO - 'LOGNAME': 'cltbld', 10:05:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:52 INFO - 'MOZ_NO_REMOTE': '1', 10:05:52 INFO - 'NO_EM_RESTART': '1', 10:05:52 INFO - 'PAGER': '/bin/cat', 10:05:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:05:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:52 INFO - 'PWD': '/builds/slave/test', 10:05:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:05:52 INFO - 'SHELL': '/bin/bash', 10:05:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IqylKf73XF/Listeners', 10:05:52 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 10:05:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:05:52 INFO - 'USER': 'cltbld', 10:05:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:05:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:05:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:52 INFO - 'XPC_FLAGS': '0x0', 10:05:52 INFO - 'XPC_SERVICE_NAME': '0', 10:05:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:05:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:05:52 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-0XwE3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:05:52 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-t36uyQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:05:52 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-nRbqeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:05:52 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-b1OBnp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:05:53 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-Jj_B2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:05:53 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-HTuWvI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:05:53 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-gOvTfq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:05:53 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-p_CCtU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:05:53 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-Okfpon-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:05:53 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-Q2TeGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:05:53 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-ayPjsu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:05:53 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-c8QqUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:05:53 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-h1AA2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:05:53 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-5jt5n0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:54 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-Y53yjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:05:54 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-ygzoXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:05:54 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-CstyX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:05:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:05:54 INFO - Running setup.py install for manifestparser 10:05:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:05:54 INFO - Running setup.py install for mozcrash 10:05:54 INFO - Running setup.py install for mozdebug 10:05:54 INFO - Running setup.py install for mozdevice 10:05:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:05:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:05:55 INFO - Running setup.py install for mozfile 10:05:55 INFO - Running setup.py install for mozhttpd 10:05:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:05:55 INFO - Running setup.py install for mozinfo 10:05:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:05:55 INFO - Running setup.py install for mozInstall 10:05:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:05:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:05:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:05:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:05:55 INFO - Running setup.py install for mozleak 10:05:55 INFO - Running setup.py install for mozlog 10:05:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:05:55 INFO - Running setup.py install for moznetwork 10:05:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:05:56 INFO - Running setup.py install for mozprocess 10:05:56 INFO - Running setup.py install for mozprofile 10:05:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:05:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:05:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:05:56 INFO - Running setup.py install for mozrunner 10:05:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:05:56 INFO - Running setup.py install for mozscreenshot 10:05:56 INFO - Running setup.py install for moztest 10:05:56 INFO - Running setup.py install for mozversion 10:05:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:05:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:05:56 INFO - Cleaning up... 10:05:57 INFO - Return code: 0 10:05:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:05: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')]} 10:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05: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')]} 10:05:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:57 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 0x10b387490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2fd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff638481400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b19bd30>, '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 0x10b001db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b193b20>, '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.pw4tUhLOA0/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.IqylKf73XF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/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 10:05:57 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 10:05:57 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 10:05:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pw4tUhLOA0/Render', 10:05:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:05:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:05:57 INFO - 'HOME': '/Users/cltbld', 10:05:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:05:57 INFO - 'LOGNAME': 'cltbld', 10:05:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:57 INFO - 'MOZ_NO_REMOTE': '1', 10:05:57 INFO - 'NO_EM_RESTART': '1', 10:05:57 INFO - 'PAGER': '/bin/cat', 10:05:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:05:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:57 INFO - 'PWD': '/builds/slave/test', 10:05:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:05:57 INFO - 'SHELL': '/bin/bash', 10:05:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IqylKf73XF/Listeners', 10:05:57 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 10:05:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:05:57 INFO - 'USER': 'cltbld', 10:05:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:05:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:05:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:57 INFO - 'XPC_FLAGS': '0x0', 10:05:57 INFO - 'XPC_SERVICE_NAME': '0', 10:05:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:05:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:05:57 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-zdsUoR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:05:57 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)) 10:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:05:57 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-rjVfXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:05:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:05:57 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-BYzA1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:05:57 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)) 10:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:05:57 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-NsRcBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:05:57 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)) 10:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:05:57 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-vnppYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:05:57 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)) 10:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:05:57 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-MOLvNq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:05:57 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)) 10:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:05:57 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-K4UGdA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:05:58 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)) 10:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:05:58 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-lpIcFo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:05:58 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)) 10:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:05:58 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-kxeaE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:05:58 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)) 10:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:05:58 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-NtTG07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:05:58 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)) 10:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:05:58 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-gAvZcO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:05:58 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)) 10:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:05:58 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-b9KkZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:05:58 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)) 10:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:05:58 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-Df0KKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:05:58 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)) 10:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:05:58 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-iVkxj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:05:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:58 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-246GkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:58 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)) 10:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:05:58 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-x1kO9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:05:58 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)) 10:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:05:58 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-OGo9fm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:05:59 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)) 10:05:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:05:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:05:59 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)) 10:05:59 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)) 10:05:59 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)) 10:05:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:05:59 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 10:05:59 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 10:05:59 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 10:05:59 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 10:05:59 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 10:05:59 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 10:06:01 INFO - Downloading blessings-1.6.tar.gz 10:06:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:06:01 INFO - Installing collected packages: blessings 10:06:01 INFO - Running setup.py install for blessings 10:06:01 INFO - Successfully installed blessings 10:06:01 INFO - Cleaning up... 10:06:02 INFO - Return code: 0 10:06:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:06:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:06:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:06:02 INFO - Reading from file tmpfile_stdout 10:06:02 INFO - Current package versions: 10:06:02 INFO - blessings == 1.6 10:06:02 INFO - blobuploader == 1.2.4 10:06:02 INFO - docopt == 0.6.1 10:06:02 INFO - functools32 == 3.2.3-2 10:06:02 INFO - jsonschema == 2.5.1 10:06:02 INFO - manifestparser == 1.1 10:06:02 INFO - mozInstall == 1.12 10:06:02 INFO - mozcrash == 1.0 10:06:02 INFO - mozdebug == 0.1 10:06:02 INFO - mozdevice == 0.48 10:06:02 INFO - mozfile == 1.2 10:06:02 INFO - mozhttpd == 0.7 10:06:02 INFO - mozinfo == 0.9 10:06:02 INFO - mozleak == 0.1 10:06:02 INFO - mozlog == 3.4 10:06:02 INFO - moznetwork == 0.27 10:06:02 INFO - mozprocess == 0.23 10:06:02 INFO - mozprofile == 0.28 10:06:02 INFO - mozrunner == 6.13 10:06:02 INFO - mozscreenshot == 0.1 10:06:02 INFO - mozsystemmonitor == 0.3 10:06:02 INFO - moztest == 0.7 10:06:02 INFO - mozversion == 1.4 10:06:02 INFO - psutil == 3.1.1 10:06:02 INFO - requests == 1.2.3 10:06:02 INFO - wsgiref == 0.1.2 10:06:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:06:02 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')]} 10:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:02 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')]} 10:06:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:02 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 0x10b387490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2fd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff638481400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b19bd30>, '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 0x10b001db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b193b20>, '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.pw4tUhLOA0/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.IqylKf73XF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/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 10:06:02 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 10:06:02 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 10:06:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pw4tUhLOA0/Render', 10:06:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:06:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:06:02 INFO - 'HOME': '/Users/cltbld', 10:06:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:06:02 INFO - 'LOGNAME': 'cltbld', 10:06:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:02 INFO - 'MOZ_NO_REMOTE': '1', 10:06:02 INFO - 'NO_EM_RESTART': '1', 10:06:02 INFO - 'PAGER': '/bin/cat', 10:06:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:06:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:02 INFO - 'PWD': '/builds/slave/test', 10:06:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:06:02 INFO - 'SHELL': '/bin/bash', 10:06:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IqylKf73XF/Listeners', 10:06:02 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 10:06:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:06:02 INFO - 'USER': 'cltbld', 10:06:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:06:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:06:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:03 INFO - 'XPC_FLAGS': '0x0', 10:06:03 INFO - 'XPC_SERVICE_NAME': '0', 10:06:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:06:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:06:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:06:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:06:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:06:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:06:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:06:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:06:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:06:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:06:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:06:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:06:03 INFO - Cleaning up... 10:06:03 INFO - Return code: 0 10:06:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:06: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')]} 10:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06: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')]} 10:06:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b387490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2fd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff638481400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b19bd30>, '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 0x10b001db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b193b20>, '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.pw4tUhLOA0/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.IqylKf73XF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/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 10:06:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:06:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:06:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pw4tUhLOA0/Render', 10:06:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:06:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:06:03 INFO - 'HOME': '/Users/cltbld', 10:06:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:06:03 INFO - 'LOGNAME': 'cltbld', 10:06:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:03 INFO - 'MOZ_NO_REMOTE': '1', 10:06:03 INFO - 'NO_EM_RESTART': '1', 10:06:03 INFO - 'PAGER': '/bin/cat', 10:06:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:06:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:03 INFO - 'PWD': '/builds/slave/test', 10:06:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:06:03 INFO - 'SHELL': '/bin/bash', 10:06:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IqylKf73XF/Listeners', 10:06:03 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 10:06:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:06:03 INFO - 'USER': 'cltbld', 10:06:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:06:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:06:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:03 INFO - 'XPC_FLAGS': '0x0', 10:06:03 INFO - 'XPC_SERVICE_NAME': '0', 10:06:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:06:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:06:04 INFO - Cleaning up... 10:06:04 INFO - Return code: 0 10:06:04 INFO - Running post-action listener: _resource_record_post_action 10:06:04 INFO - Running post-action listener: _start_resource_monitoring 10:06:04 INFO - Starting resource monitoring. 10:06:04 INFO - [mozharness: 2016-11-30 18:06:04.043290Z] Finished create-virtualenv step (success) 10:06:04 INFO - [mozharness: 2016-11-30 18:06:04.044334Z] Running install step. 10:06:04 INFO - Running pre-action listener: _resource_record_pre_action 10:06:04 INFO - Running main action method: install 10:06:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:06:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:06:04 INFO - Reading from file tmpfile_stdout 10:06:04 INFO - Detecting whether we're running mozinstall >=1.0... 10:06:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:06:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:06:04 INFO - Reading from file tmpfile_stdout 10:06:04 INFO - Output received: 10:06:04 INFO - Usage: mozinstall [options] installer 10:06:04 INFO - Options: 10:06:04 INFO - -h, --help show this help message and exit 10:06:04 INFO - -d DEST, --destination=DEST 10:06:04 INFO - Directory to install application into. [default: 10:06:04 INFO - "/builds/slave/test"] 10:06:04 INFO - --app=APP Application being installed. [default: firefox] 10:06:04 INFO - mkdir: /builds/slave/test/build/application 10:06:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:06:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 10:06:35 INFO - Reading from file tmpfile_stdout 10:06:35 INFO - Output received: 10:06:35 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 10:06:35 INFO - Running post-action listener: _resource_record_post_action 10:06:35 INFO - [mozharness: 2016-11-30 18:06:35.555203Z] Finished install step (success) 10:06:35 INFO - [mozharness: 2016-11-30 18:06:35.555313Z] Running run-tests step. 10:06:35 INFO - Running pre-action listener: _resource_record_pre_action 10:06:35 INFO - Running main action method: run_tests 10:06:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:06:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:06:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:06:35 INFO - 2016-11-30 10:06:35.568 screenresolution[6406:107621] starting screenresolution argv=screenresolution get 10:06:35 INFO - 2016-11-30 10:06:35.570 screenresolution[6406:107621] Display 0: 1600x1200x32@60 10:06:35 INFO - 2016-11-30 10:06:35.575 screenresolution[6407:107623] starting screenresolution argv=screenresolution list 10:06:35 INFO - Available Modes on Display 0 10:06:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:06:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:06:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:06:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:06:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:06:35 INFO - Intel Iris: 10:06:35 INFO - Chipset Model: Intel Iris 10:06:35 INFO - Type: GPU 10:06:35 INFO - Bus: Built-In 10:06:35 INFO - VRAM (Dynamic, Max): 1536 MB 10:06:35 INFO - Vendor: Intel (0x8086) 10:06:35 INFO - Device ID: 0x0a2e 10:06:35 INFO - Revision ID: 0x0009 10:06:35 INFO - Displays: 10:06:35 INFO - Display: 10:06:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:06:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:06:35 INFO - Display Serial Number: 1600x1200 60 10:06:35 INFO - Main Display: Yes 10:06:35 INFO - Mirror: Off 10:06:35 INFO - Online: Yes 10:06:35 INFO - Rotation: Supported 10:06:35 INFO - Return code: 0 10:06:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:06:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:06:35 INFO - Python 2.7.3 10:06:35 INFO - Return code: 0 10:06:35 INFO - grabbing minidump binary from tooltool 10:06:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:35 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 0x10b19bd30>, '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 0x10b001db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b193b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:06:35 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 10:06:35 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 10:06:35 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 10:06:35 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:06:35 INFO - Return code: 0 10:06:35 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:06:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:06:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:06:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:06:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:06:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MILHvp24QGu-jPZIsXD1tA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0303', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 10:06:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MILHvp24QGu-jPZIsXD1tA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0303 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:06:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pw4tUhLOA0/Render', 10:06:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:06:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:06:35 INFO - 'HOME': '/Users/cltbld', 10:06:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:06:35 INFO - 'LOGNAME': 'cltbld', 10:06:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:06:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:06:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:35 INFO - 'MOZ_NO_REMOTE': '1', 10:06:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:06:35 INFO - 'NO_EM_RESTART': '1', 10:06:35 INFO - 'PAGER': '/bin/cat', 10:06:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:06:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:35 INFO - 'PWD': '/builds/slave/test', 10:06:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:06:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:06:35 INFO - 'SHELL': '/bin/bash', 10:06:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IqylKf73XF/Listeners', 10:06:35 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 10:06:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:06:35 INFO - 'USER': 'cltbld', 10:06:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:06:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:06:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:35 INFO - 'XPC_FLAGS': '0x0', 10:06:35 INFO - 'XPC_SERVICE_NAME': '0', 10:06:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:06:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MILHvp24QGu-jPZIsXD1tA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0303', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:06:36 INFO - mozversion application_buildid: 20161130073344 10:06:36 INFO - mozversion application_changeset: a065f231fb79a48683b37c4cdb5136d7f14fd560 10:06:36 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:06:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:06:36 INFO - mozversion application_name: Firefox 10:06:36 INFO - mozversion application_remotingname: firefox-dev 10:06:36 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:06:36 INFO - mozversion application_vendor: Mozilla 10:06:36 INFO - mozversion application_version: 52.0a2 10:06:36 INFO - mozversion platform_buildid: 20161130073344 10:06:36 INFO - mozversion platform_changeset: a065f231fb79a48683b37c4cdb5136d7f14fd560 10:06:36 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:06:36 INFO - mozversion platform_version: 52.0a2 10:06:36 INFO - using testdate: 1480529196 10:06:36 INFO - actual date: 1480529196 10:06:36 INFO - starting webserver on 'localhost:57713' 10:06:36 INFO - SUITE-START | Running 2 tests 10:06:36 INFO - TEST-START | dromaeo_css 10:06:36 INFO - operating with platform_type : mac_ 10:06:36 INFO - Initialising browser for dromaeo_css test... 10:06:36 INFO - TEST-INFO | started process 6417 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/tmpWEKskU/profile http://localhost:57713/getInfo.html) 10:06:39 INFO - PROCESS | 6417 | 2016-11-30 10:06:39.370 plugin-container[6419:107795] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d3f, name = 'com.apple.tsm.portname' 10:06:39 INFO - PROCESS | 6417 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:06:39 INFO - PROCESS | 6417 | 2016-11-30 10:06:39.373 plugin-container[6419:107795] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x910b, name = 'com.apple.CFPasteboardClient' 10:06:39 INFO - PROCESS | 6417 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:06:39 INFO - PROCESS | 6417 | 2016-11-30 10:06:39.373 plugin-container[6419:107795] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:06:39 INFO - PROCESS | 6417 | __metrics Screen width/height:1600/1200 10:06:39 INFO - PROCESS | 6417 | colorDepth:24 10:06:39 INFO - PROCESS | 6417 | Browser inner width/height: 1024/689 10:06:39 INFO - PROCESS | 6417 | __metrics 10:06:39 ERROR - PROCESS | 6417 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 10:06:40 INFO - TEST-INFO | 6417: exit 0 10:06:40 INFO - Browser initialized. 10:06:40 INFO - Running cycle 1/1 for dromaeo_css test... 10:06:40 INFO - TEST-INFO | started process 6421 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/tmpWEKskU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:06:43 INFO - PROCESS | 6421 | 2016-11-30 10:06:43.105 plugin-container[6422:107935] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873b, name = 'com.apple.tsm.portname' 10:06:43 INFO - PROCESS | 6421 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:06:43 INFO - PROCESS | 6421 | 2016-11-30 10:06:43.106 plugin-container[6422:107935] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4707, name = 'com.apple.CFPasteboardClient' 10:06:43 INFO - PROCESS | 6421 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:06:43 INFO - PROCESS | 6421 | 2016-11-30 10:06:43.106 plugin-container[6422:107935] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:06:52 INFO - PROCESS | 6421 | RSS: Main: 229552128 10:06:52 INFO - PROCESS | 6421 | 10:07:42 INFO - PROCESS | 6421 | 1480529262419 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] 10:09:56 INFO - PROCESS | 6421 | Cycle 1(1): loaded http://localhost:57713/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57713/tests/dromaeo/cssquery-ext.html) 10:09:58 INFO - PROCESS | 6421 | RSS: Main: 233156608 10:09:58 INFO - PROCESS | 6421 | 10:13:00 INFO - PROCESS | 6421 | Cycle 1(1): loaded http://localhost:57713/tests/dromaeo/cssquery-ext.html (next: http://localhost:57713/tests/dromaeo/cssquery-jquery.html) 10:13:01 INFO - PROCESS | 6421 | RSS: Main: 243453952 10:13:01 INFO - PROCESS | 6421 | 10:16:03 INFO - PROCESS | 6421 | Cycle 1(1): loaded http://localhost:57713/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57713/tests/dromaeo/cssquery-mootools.html) 10:16:04 INFO - PROCESS | 6421 | RSS: Main: 246296576 10:16:04 INFO - PROCESS | 6421 | 10:19:06 INFO - PROCESS | 6421 | Cycle 1(1): loaded http://localhost:57713/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57713/tests/dromaeo/cssquery-prototype.html) 10:19:06 INFO - PROCESS | 6421 | RSS: Main: 245612544 10:19:06 INFO - PROCESS | 6421 | 10:22:09 INFO - PROCESS | 6421 | Cycle 1(1): loaded http://localhost:57713/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57713/tests/dromaeo/cssquery-yui.html) 10:22:10 INFO - PROCESS | 6421 | RSS: Main: 249008128 10:22:10 INFO - PROCESS | 6421 | 10:25:12 INFO - PROCESS | 6421 | Cycle 1(1): loaded http://localhost:57713/tests/dromaeo/cssquery-yui.html (next: http://localhost:57713/tests/dromaeo/cssquery-dojo.html) 10:25:13 INFO - PROCESS | 6421 | RSS: Main: 250630144 10:25:13 INFO - PROCESS | 6421 | 10:25:13 INFO - PROCESS | 6421 | __start_tp_report 10:25:13 INFO - PROCESS | 6421 | _x_x_mozilla_page_load 10:25:13 INFO - PROCESS | 6421 | _x_x_mozilla_page_load_details 10:25:13 INFO - PROCESS | 6421 | |i|pagename|runs| 10:25:13 INFO - PROCESS | 6421 | |0;dojo.html;3287.276799104198;3306.38831816114;3342.766006379553;3351.9162020949466;3354.7148492378146;5613.971930140348;5658.519025882805;5665.915011274834;5706.429357064291;5717.914231286523;5656.802011929583;5728.054870946289;5740.741666625001;5744.770209191638;5812.099124635688;5152.149895267276;5153.458886816887;5198.92201616976;5243.737813109348;5259.5529380002745;5209.505097015777;5215.504527069922;5240.052540366673;5266.368035835705;5321.680699158043;5090.54185123337;5158.277841102249;5176.5341119299255;5243.161094224944;5247.711375874325;5193.402758682762;5195.922061169085;5196.610254230948;5201.297824793643;5203.687778733288;5076.568491678212;5096.210087436416;5100.336956195708;5129.0767661820855;5156.097682905514;5129.461406552333;5571.944280557183;5584.636998595079;5654.37801841797;5745.396733342981;4547.909041819178;4764.785584648699;6204.6587437690905;6224.3464436234;6236.937630623681;5604.215409842625;6193.566450348478;6199.814005579839;6258.3428739982555;6268.65522396268;5813.7383817728305;5823.417658234142;5826.372893834855;5843.5325173985975;5852.7658893643775;6108.008189064015;6186.81439556814;6312.147860038928;6316.463100636405;6337.683115844189;5273.2617433559335;6040.486558642477;6081.209442772411;6110.285381942539;6141.2098563120835;6147.170132032118;6150.169727086875;6152.230971128609;6179.949408600459;6201;5439.456054394608;5504.899020195897;6127.264728232641;6127.693615319216;6130.264368275746;6027.246594175728;6110.589135957139;6130.000698177752;6141.792871882774;6166.198394208814;4900.117978763857;4903.092927808367;4940.333055037596;4951.232558953368;4972.701637901738;4462.3752674625575;4463.352813841975;4485.753283569435;4488;4534.251848445036;4445.5776701213335;4837.4920633333695;5430;5607.943920560824;5907.734151963172;6145.217886812774;6185.628862268189;6210.378962103753;6216.875662486725;6232.3144454110015;5687.772489100473;5862.237909071793;5865.472107510344;5874.441928016831;5898.203742494708;5311.548518375904;5356.946430535645;5368.00691872005;5373.3551973762615;5432.728363581805;6344;6347.111404403295;6355.237371515448;6365.936340636535;6380.042993550912;6144.078388241799;6155.907661385172;6174.351693072163;6184.721687524162;6209.720562574786;6131.896637733107;6165.260168779775;6228.03465462854;6332.0501924709815;6334.986402175629;6201.627902325875;6202.945499265045;6209.441150296314;6219.378062193744;6222.595531290452;6118.071005858243;6245.219347581552;6274.717637706405;6286.402791734778;6288.465480434214;5803.535717142534;6054.7275372607455;6074.757009719562;6083;6155.599886007574;6057.7879774207695;6097.979100309478;6116.457510225511;6138.263408391022;6155.569110162246;5893.557983151195;5908.9068522323505;5951.285845698544;5996.310424301261;6011.338752737108;5908.143319218603;5974.103884417372;5989.341172471112;6035.486983606443;6035.818925432244;5771.076627739541;5807.983602869565;5828.067509198508;5845.269341332333;5860.472557469848 10:25:13 INFO - PROCESS | 6421 | |1;ext.html;456.3109704346438;480.1741005470589;499.36081815276435;514.4495389932772;526.8524813052346;34815;36244.63755362445;39029;39147.82556523309;40963.59036409635;39984.60015399845;40642.78071657855;40657.7967110164;40702.7964860176;40720.38919416211;8993.550322483867;9215.631374745002;9217.723468295928;9230.215431688315;9255;9046.185843274105;9075.500847453388;9176.449413035205;9183.31125165612;9194.77013074675;7699.961500192491;8534.78663033426;8924.107589241057;9099.22656574192;9212.401193922407;7269.236730143311;8554.230119289263;9194.448333100036;9212.447253164764;9247.72256832296;9100.453972761656;9152.130547597968;9162.31282653797;9165.404248723878;9177.587008584629;35855;37883.24233515314;37895.431568526496;37933.24133517342;37965.62034379649;3242.4649932761304;3252.040648008843;3299.6040475142895;3635.2002559436883;3789.5073640426567;25590.87204563984;28624.570631440543;29091.854540727374;29291;29569.26076848096;2970.3910698306795;3067.4968077840454;3185.808851468896;3193.4730769423018;3202.6156861176573;469867;473654;476447;477011.61494192656;477406;54227.18659220115;54496.72751636217;54574;54592.45407545953;54603.72698136484;54563;56707.716461418255;57238.42761572414;57313;57342;15154.939154259097;15335.769963450557;15362.00146990442;15397.153156576273;15425.305861236271;11947.462364193632;12040.638780836589;12077.335746534025;12085.274883507018;12103.394830258452;13767.31163441824;14479.638009049648;14582.343794529272;14606.12363258208;14768.704625907421;3190.202449387653;6800.897986530107;7024.367806897404;7034.437245020488;7080.858382832417;845.9915400845913;942.641796117471;1066.6266806617778;1068.2468859454066;1071.8338657507943;28863.989760358287;28952.131436056952;29228.853855730584;29358.853205733834;29719.702802971693;875.2123089219754;1013.4426065663855;1030.3817709374466;1053.6891616973012;1118.6755840806238;12773.872261277455;14492.565223043326;15192.012519186217;15207.543773686808;15530.223488825513;659885;667844;668195;669280;670256;54708.179377309374;55202.17196742052;55338.72330638321;55355;55402;1348.6695759538975;1359.8096266522696;1383.6402535340883;1387.8265216847894;1390.2701081931864;28077.57883631788;28514.85742571274;28937.855310724153;29246.268843278238;29247.561286580294;51113;52433;53295.73352133214;56073.43926560682;56188.15717764319;587817;595742;596624;598710;599672;39630.40554391629;39991;40418;40420.79789601033;40528.3920741195;35754.64245357513;43701.34447983346;44155.11689766251;44164.55835441605;44904.77547612241;36668.379334254816;37312.69405570792;37622;38442.615573845025;38811.835644930696;36762.713305035264;36911.44632830563;37747.26067255955;37776.81111594424;37933.24133517259;23996.76003240015;26173;32487;35871;36894.262114758094;25597.87201063983;33863.645454181555;34288.31423371568;34309.313813723085;34367.82816085903;20665.89667051655;25008.999640014925;25137;25199.74800251974;25837.483250335263 10:25:13 INFO - PROCESS | 6421 | |2;jquery.html;346.18818869750436;369.1877868688885;380.7353889047113;383.3062157494933;397.9820908059137;18499.815001849976;19068.71396929047;19253.133608987595;19826.801731982676;20050.89974550125;11445.168772996321;12491.687707807308;18735;19315.4205373839;19463.221471141136;5197.740112994354;5451.100568406208;5454.91817622736;5456.781728730846;5478;5258.47415258473;5351.57187425007;5659.405762394951;5707.62900411474;5750.02249617566;5726.570507211955;5744.655320680752;5764.711764411783;5771.480566748992;5772.5670574707065;5165;6036.0945858121195;6347.555671103025;6352.301246862841;6367.267764207106;5404.756785944642;5595.972020139914;5611.13027480737;5623.634463759883;5628.761672432059;12831.973442124608;12988.415521301564;13035.696430356984;13046.608601741962;14568.635784105376;2294.9770502295096;2317.2700599311165;2324.244620498345;2351.9647205291935;2507;6883.518153729241;9935.90064099357;10149.543270552844;12519.93740031303;13831.893448524093;1769.7433872088604;1847.135345278748;1856.424508402386;1878.4176905159445;1906.771187457514;87789;123006;127988.36005820005;128523.7147628521;129900;9121.589528471235;11537.711557210969;11624.767504650028;11675.37298666356;11855.407229638484;14676.41294348214;14741.778873316909;14759.114453132846;14770.40918363275;14788;8129.309008734205;8407.495550267004;8451.66193352259;8562.48625082497;8583.828323433621;8268.462549934235;8284.171582841667;8308.12764659714;8469.957650211709;8480.872786908201;3915.882523524299;4333.631641310524;4542.364069030338;4564.7032942858605;4651.790669419885;1866.981330186708;1912.512309361104;1913.3685883658359;1922.1638587214607;1932.062949469506;711.434409644334;831.2560258568548;863.1368631368631;868.6351732272461;929.1126973740062;18681.626367472847;20045.899770501055;20403.79596204019;20481.59036819285;20541.589168216553;900.2887718702283;916.6699988004314;921.6820197032014;935.4901578639658;963.5312873654786;8973.820523589622;9921.553530091163;10271.00876866132;10430.16558675304;10457.68626941193;578438;580665.0966745139;581772;602201;606011;89424.5528772352;122374;123550.76449235572;131353.34323328512;132029;939.6241503398695;957.5260246178048;977.2572844637984;982.3467394182788;983.1986930651497;18194.727079093558;18337.63324733471;18399.724004140215;18511.72232416488;18751.15619797085;53734;54952;55834.441655584546;56934.7153264231;57009.14486282792;79358;79990;80046;80668;80851;7075.646217689198;7385.7045718170675;7973;8006.359491240571;8209.589520524069;11292.661220163409;11927.82108268394;12178.756424871275;12368.876311237133;12629.052821038274;9344.532773361441;9744.951275243578;9940.602375904882;10397.896021039693;10710.250282480152;10640.574377024832;10667.839982400425;10729.248952573245;10943.45282735876;11053.502592383524;9838.508074596384;10563.419011954416;10905.890941090805;11262;11365.488553015299;7784.3024563331965;7891.092524359772;8079.434439589172;8142;8306.293965013041;8002.5598592077995;10264.897351026693;10633.734156646145;10901.781964360827;11155.553777848796 10:25:13 INFO - PROCESS | 6421 | |3;mootools.html;1452.7675571908496;1478.4973109142893;1642.9260683269251;1753.5791410061588;1784.7947486039109;7416.480846340758;7619.238076192378;7857.607119644016;8368.121347258542;8381.497110173394;7961.243681850229;8122.350211983042;8141.91858081419;8246.546439945801;8255.793605159874;1905.7808352039485;2275.567642147995;2321.93034208974;2329.336139200328;2342.273895092527;2312.491251924574;2344.074090734159;2370.3244575296044;2371.1819422299363;2375.8812059397046;2298.494331247123;2309.4919117794143;2321.8839058047115;2324.407276144581;2330.743618202005;1908.761404824397;2285.6342985122383;2292.071710957065;2319.072371051576;2320.153144102399;2318.2233951626226;2334.1713691639393;2338.1348900906605;2340.941476463085;2354.482013956944;8237.258646721824;8280;8353.164683531659;8353.665853365857;8364.707235246737;4347.978225117095;5019.723915184663;5134.255532947702;5190.169572868361;5208.2968799212;3154.511050787132;3242.6108866935883;3544.131687736495;3548.308079924416;3549;1024.2267088348249;1043.843423486483;1065.664315740547;1080.1682704317632;1086.8804431512526;10803.891961080368;10848.620298289601;10889.509972051277;10926.781464370668;10930.726731831768;4461.643068554573;4530.524294949048;4629.4722741495225;4642.234031384851;4709.246520556694;7363.484556081023;9254.305927055364;9363.812723745486;9367.250619950388;9368.859467107999;5121.4878512149235;5154.072266991902;5159.993801208803;5171.198464238049;5176.275321454999;4168.7290326128705;4453.532379100213;4696.577308042292;4720.740359280273;4735;3321.2693207494794;3779.036345731876;3785.1104990327804;3848.9807550962064;3906.2382835347403;1261.7224210673637;1281.1928485054543;1283.4481173095471;1286.5175559165314;1296.2416986063258;826.3719573124348;893.5442924108621;903.8644203369547;905.6060613633091;930.2743859789375;5044.571211447068;5509.752061157257;5736.082226843769;5810.535157187415;5815.156802263648;968.6416026070399;981.76297864691;984.9162821160138;999.8300288950895;1031.6234574380296;3737.2338670572467;3844.3464611016193;3850.537935447708;3891.785951772623;3906.90232744178;8399.53802540854;9669.90330096704;10136.493175341204;10148.543315550818;10163;8369.748907532783;8409.285210757154;10080.69757907264;10111.03945125212;10131.898681013243;7587.810304742426;7633.274838890296;7652.961735191288;7774.183710710294;7819.100803407681;5043.773030213576;5331.040412725747;5540.307461567304;5575.8884822304135;5756.107803290497;7106.751263705745;8444.535550544779;8460.069392366711;8551.786205344915;8577.528235947082;8379.952505936757;8550.529720865163;8626.353023523136;8640.308775298086;8658.39391242607;5943.405659434022;6411.942029565256;6501.707423165874;6733.764318248838;6738.629375384401;7534.133574638987;7751.263629955145;7807.570583617956;7917.287444129825;7957.1644977276555;6905.551139175937;6940.236573976959;7107.786766396809;7109.182444019004;7146.571205727673;6952;7012.789616311519;7048.400885924754;7060.929390706027;7094.503384763017;6580.473562114924;6666.899996500153;6718.22740384862;6719.865602688016;6720.260771315249;4161.375793630858;4837.0084132752;4838.104950584153;4899.975500122477;4920.532549407943;4808.7595620219545;4818.783154757974;4860.92708609364;5001.999600080071;5076.111680455831 10:25:13 INFO - PROCESS | 6421 | |4;prototype.html;281.41606167203054;290.65412159530143;310.7669248063952;313.11544885697907;314.27089153164655;4575.565321294476;5327.627066105364;5426.077566813641;5487.984722826275;5517.889642207154;4642.930356044653;5198.220266959958;5301.655392399492;5393.892122157555;5422.322209723785;3399.5750531183603;4095.4471146395153;4116.567760385154;4158.251514727363;4161.313383291768;3830.559485659143;4058.5738497457783;4131.421600975866;4150.64719498843;4168.207301108265;4067.5560176137487;4079.551249362568;4079.8980025499304;4096.3855421686685;4111.9177616447805;3420.948685769728;3699.648533389324;4044.878653640381;4054.412110243998;4060.964454064195;2834.4472827798586;3198.8088159610743;3556.608773034964;3571.1250743567994;3579.28414317135;4726.598239149676;4983.875403114951;5277.920831187535;5306.522412982811;5353.946460535384;3705.09225239818;3902.4195200943664;3913.3563903160457;4266.978665106686;4314.762688052156;5707.458986073737;5713.714414256759;5739.626924249952;5763.193152958589;5819.301683797971;3233.7413006959387;3608.9278214435826;3817.675497582709;3910.237503686782;3910.608939106095;4965.602751779849;5978.581499295051;6025.397460253939;6029.678573749138;6032.547558933097;3901.3367727486398;3907.648311651965;3942.704297177723;3972.0268534209304;3983.7052957788833;3508.6666766657127;3642.907127861684;3673.779573225615;3846.3268927937497;3943.2507823513442;4653.417837935118;4664.743439110882;4673.6728429009645;4682.672212945061;4694.342792009122;4736.739479328601;4818.445878723922;5503.670279480936;5763.452472015152;5801.332846722681;1226.4480983557435;1250.693580072888;1282.4805953588811;1294.9287789171685;1303.361352937073;846.2595229174473;870.9520976346362;877.9517126558101;881.2905610983092;887.272436601993;4918.754062296871;5084.872803226063;5141.53726164647;5180.948190518122;5193.870153246124;5322.813701520428;5448.155535891943;5659.688717120598;5661.886762264814;5680;4869.9513004870205;4984.476629953802;5092.6435149539175;5146.974265128651;5178.741062946838;2490.4310284520634;2917.2998480364986;2931.6042334285025;2935.8532073396673;2957.275467510474;5092.28707980883;5209.947900520946;5324.6805191687845;5750.424957504216;5764.5676574257095;5158.4067832199025;5300.761465734051;5313.8937221255355;5385.192221166856;5732.541396688255;4904.308013735184;5003.724795136302;5706.914396284059;5717.456841600041;5760.711964401847;5084.6440749147205;5136.94692588026;5159.587233021274;5638.9436105638415;5640.266765320482;5205.687658740488;5415.675059496442;5579.330480342385;5884.558658100746;5917.497012753965;6242.968785156045;6251.031090181029;6255.874882502416;6260.212571394423;6267.811965641038;3532.8410221540607;3727.552693676776;3939.094008378032;4013.478247827764;4017.9598204017584;4899.877503062452;5005.524475174852;5145.970805838922;5943.346231914399;5959.76160953557;5284.603654725834;5660.9150862737915;5719.456651618089;5814.766709961069;5824.417558244142;5404.1625847212135;5742.28221472316;5859.44335288147;5888.352281249145;5924.8815023700145;4346.500152482505;5631.521320687787;5695.743691533974;5717.542596592346;5773.769049237983;5776.971115144397;5803.593748437569;5806.767729290781;5833.0375488044;5881.676507792113;5487.862803429946;5541.445855414588;5681.0910254359105;5707.229524014371;5713.428657134254 10:25:13 INFO - PROCESS | 6421 | |5;yui.html;689.2762599270766;703.5989485992983;708.9893651595223;721.1922646635766;726.3245181980758;11695.649130526077;13869.653258668539;14468.421263149461;14545.200013999225;14571.635709107277;11411.600593979212;13385;13400.530981415652;13409.061365704405;13437.932810335935;792.9920700793004;812.25272749071;815.5881279953616;816.1552792859362;817.3216230528677;639.9808005759835;663.4824836627438;784.8704963680985;806.7579726082181;818.9885491418094;657.4707360574736;806.1213277527494;853.9444936079166;856.387682806793;862.6290695001147;844.4975239732349;854.692310768123;855.6620135046684;855.9914400855974;860.7805009722543;543.2503145658966;623.3112410786107;631.2488139114439;631.4758750237293;636.5130675033603;11406.80228576004;13212.603621891358;13458.52895148665;13542.932285338511;13604.31978401076;10957.452127393599;12873.420696068606;13562;13619.591412257649;13699.589012329647;9849.803003939882;10836.67489975302;10941.23411361205;11205.103591712725;11370.772584548346;3304.256542277992;3577.83899724513;3675.8345874435713;3691.7046636269033;3752.155764952891;80638.5968070156;85959;87139.12860871374;89695.55152224198;92406.61390079155;10249.84625230622;10390.48047597617;10430.217733670004;10433.16534677224;10444.21668374875;20518.179272829217;20539.281125160847;20547.38357849237;20592.794072059387;20812.479688007617;7519.774406767806;7553.206913274027;7561.508501947355;7563.621818909032;7732.188120247405;4059.939100913489;4162.771047592411;4273.594008569181;4287.849925252601;4355.107203023436;2852.3297025199063;3310.652381499956;3397.677220664033;3419.46998215277;3420.8289585520624;596.9820905372845;617.0466629058116;617.8486270863577;621.940915613016;628.1488582970101;595.8957182493133;616.4051690119056;661.2825084783065;666.2072134160334;673.0778832998823;8285.917140828635;8960.610896508519;8975.192232699088;9037.412568183046;9229.077092290718;620.5966122020723;642.881067002606;646.9223693156852;660.2802944790105;663.5561436146385;3991.201759648082;3998.640122388999;4089.1821635672986;4098.979505102456;4236.131593023423;77670.6116469414;80270.39459210783;116864;118993;123560;64245.35754642394;79578.6021069891;82324.76512852192;96336;101170.98829011763;79408.60295698485;83227;84130.57934710287;85968;86800.56599717087;8982.86525702128;9366.718998430058;9381.953090234505;9456.716298511055;9481.241500680067;57213.71393143007;57878.7106064467;58264.70867645634;58587.48475091508;59076;70677.64661176661;73359.26640733525;73576.89634655377;74340;75660;10043.949780251052;10705.89294107049;11769.293842369143;11847.348395838311;12193.268403895794;12394.070444716863;13858.584242472742;13896.930515347358;14362.784558231426;14371.640708982359;9387.577559009998;9827.55775990068;11132.220744547803;12446.25322480654;12924.483020679067;9297.628094876129;10911.78176436451;11448.198626096093;12086.697832554257;12452.56416025471;12196.268223906594;12259.69350766238;12389.442475088463;12549.184303020274;12561.811572826598;10544.05103540685;10607.363558186533;10869.619563315246;11232.3260604364;11369.829452558384;10786.406747628957;11089.50097245642;11116.388598627153;11183.776324473627;11633.6509904703 10:25:13 INFO - PROCESS | 6421 | __end_tp_report 10:25:13 INFO - PROCESS | 6421 | __start_cc_report 10:25:13 INFO - PROCESS | 6421 | _x_x_mozilla_cycle_collect,368 10:25:13 INFO - PROCESS | 6421 | __end_cc_report 10:25:13 INFO - PROCESS | 6421 | __startTimestamp1480530313176__endTimestamp 10:25:13 INFO - PROCESS | 6421 | 10:25:13 INFO - PROCESS | 6421 | ------- Summary: start ------- 10:25:13 INFO - PROCESS | 6421 | Number of tests: 6 10:25:13 INFO - PROCESS | 6421 | 10:25:13 INFO - PROCESS | 6421 | [#0] dojo.html Cycles:165 Average:5675.36 Median:5862.24 stddev:647.88 (11.1%) stddev-sans-first:622.19 10:25:13 INFO - PROCESS | 6421 | Values: 3287.3 3306.4 3342.8 3351.9 3354.7 5614.0 5658.5 5665.9 5706.4 5717.9 5656.8 5728.1 5740.7 5744.8 5812.1 5152.1 5153.5 5198.9 5243.7 5259.6 5209.5 5215.5 5240.1 5266.4 5321.7 5090.5 5158.3 5176.5 5243.2 5247.7 5193.4 5195.9 5196.6 5201.3 5203.7 5076.6 5096.2 5100.3 5129.1 5156.1 5129.5 5571.9 5584.6 5654.4 5745.4 4547.9 4764.8 6204.7 6224.3 6236.9 5604.2 6193.6 6199.8 6258.3 6268.7 5813.7 5823.4 5826.4 5843.5 5852.8 6108.0 6186.8 6312.1 6316.5 6337.7 5273.3 6040.5 6081.2 6110.3 6141.2 6147.2 6150.2 6152.2 6179.9 6201.0 5439.5 5504.9 6127.3 6127.7 6130.3 6027.2 6110.6 6130.0 6141.8 6166.2 4900.1 4903.1 4940.3 4951.2 4972.7 4462.4 4463.4 4485.8 4488.0 4534.3 4445.6 4837.5 5430.0 5607.9 5907.7 6145.2 6185.6 6210.4 6216.9 6232.3 5687.8 5862.2 5865.5 5874.4 5898.2 5311.5 5356.9 5368.0 5373.4 5432.7 6344.0 6347.1 6355.2 6365.9 6380.0 6144.1 6155.9 6174.4 6184.7 6209.7 6131.9 6165.3 6228.0 6332.1 6335.0 6201.6 6202.9 6209.4 6219.4 6222.6 6118.1 6245.2 6274.7 6286.4 6288.5 5803.5 6054.7 6074.8 6083.0 6155.6 6057.8 6098.0 6116.5 6138.3 6155.6 5893.6 5908.9 5951.3 5996.3 6011.3 5908.1 5974.1 5989.3 6035.5 6035.8 5771.1 5808.0 5828.1 5845.3 5860.5 10:25:13 INFO - PROCESS | 6421 | 10:25:13 INFO - PROCESS | 6421 | [#1] ext.html Cycles:180 Average:70118.44 Median:38920.42 stddev:156583.42 (402.3%) stddev-sans-first:156935.33 10:25:13 INFO - PROCESS | 6421 | Values: 456.3 480.2 499.4 514.4 526.9 34815.0 36244.6 39029.0 39147.8 40963.6 39984.6 40642.8 40657.8 40702.8 40720.4 8993.6 9215.6 9217.7 9230.2 9255.0 9046.2 9075.5 9176.4 9183.3 9194.8 7700.0 8534.8 8924.1 9099.2 9212.4 7269.2 8554.2 9194.4 9212.4 9247.7 9100.5 9152.1 9162.3 9165.4 9177.6 35855.0 37883.2 37895.4 37933.2 37965.6 3242.5 3252.0 3299.6 3635.2 3789.5 25590.9 28624.6 29091.9 29291.0 29569.3 2970.4 3067.5 3185.8 3193.5 3202.6 469867.0 473654.0 476447.0 477011.6 477406.0 54227.2 54496.7 54574.0 54592.5 54603.7 54563.0 56707.7 57238.4 57313.0 57342.0 15154.9 15335.8 15362.0 15397.2 15425.3 11947.5 12040.6 12077.3 12085.3 12103.4 13767.3 14479.6 14582.3 14606.1 14768.7 3190.2 6800.9 7024.4 7034.4 7080.9 846.0 942.6 1066.6 1068.2 1071.8 28864.0 28952.1 29228.9 29358.9 29719.7 875.2 1013.4 1030.4 1053.7 1118.7 12773.9 14492.6 15192.0 15207.5 15530.2 659885.0 667844.0 668195.0 669280.0 670256.0 54708.2 55202.2 55338.7 55355.0 55402.0 1348.7 1359.8 1383.6 1387.8 1390.3 28077.6 28514.9 28937.9 29246.3 29247.6 51113.0 52433.0 53295.7 56073.4 56188.2 587817.0 595742.0 596624.0 598710.0 599672.0 39630.4 39991.0 40418.0 40420.8 40528.4 35754.6 43701.3 44155.1 44164.6 44904.8 36668.4 37312.7 37622.0 38442.6 38811.8 36762.7 36911.4 37747.3 37776.8 37933.2 23996.8 26173.0 32487.0 35871.0 36894.3 25597.9 33863.6 34288.3 34309.3 34367.8 20665.9 25009.0 25137.0 25199.7 25837.5 10:25:13 INFO - PROCESS | 6421 | 10:25:13 INFO - PROCESS | 6421 | [#2] jquery.html Cycles:180 Average:34091.16 Median:4553.53 stddev:98594.10 (2165.2%) stddev-sans-first:98838.13 10:25:13 INFO - PROCESS | 6421 | Values: 346.2 369.2 380.7 383.3 398.0 18499.8 19068.7 19253.1 19826.8 20050.9 11445.2 12491.7 18735.0 19315.4 19463.2 5197.7 5451.1 5454.9 5456.8 5478.0 5258.5 5351.6 5659.4 5707.6 5750.0 5726.6 5744.7 5764.7 5771.5 5772.6 5165.0 6036.1 6347.6 6352.3 6367.3 5404.8 5596.0 5611.1 5623.6 5628.8 12832.0 12988.4 13035.7 13046.6 14568.6 2295.0 2317.3 2324.2 2352.0 2507.0 6883.5 9935.9 10149.5 12519.9 13831.9 1769.7 1847.1 1856.4 1878.4 1906.8 87789.0 123006.0 127988.4 128523.7 129900.0 9121.6 11537.7 11624.8 11675.4 11855.4 14676.4 14741.8 14759.1 14770.4 14788.0 8129.3 8407.5 8451.7 8562.5 8583.8 8268.5 8284.2 8308.1 8470.0 8480.9 3915.9 4333.6 4542.4 4564.7 4651.8 1867.0 1912.5 1913.4 1922.2 1932.1 711.4 831.3 863.1 868.6 929.1 18681.6 20045.9 20403.8 20481.6 20541.6 900.3 916.7 921.7 935.5 963.5 8973.8 9921.6 10271.0 10430.2 10457.7 578438.0 580665.1 581772.0 602201.0 606011.0 89424.6 122374.0 123550.8 131353.3 132029.0 939.6 957.5 977.3 982.3 983.2 18194.7 18337.6 18399.7 18511.7 18751.2 53734.0 54952.0 55834.4 56934.7 57009.1 79358.0 79990.0 80046.0 80668.0 80851.0 7075.6 7385.7 7973.0 8006.4 8209.6 11292.7 11927.8 12178.8 12368.9 12629.1 9344.5 9745.0 9940.6 10397.9 10710.3 10640.6 10667.8 10729.2 10943.5 11053.5 9838.5 10563.4 10905.9 11262.0 11365.5 7784.3 7891.1 8079.4 8142.0 8306.3 8002.6 10264.9 10633.7 10901.8 11155.6 10:25:13 INFO - PROCESS | 6421 | 10:25:13 INFO - PROCESS | 6421 | [#3] mootools.html Cycles:180 Average:5308.69 Median:5098.80 stddev:2841.87 (55.7%) stddev-sans-first:2835.07 10:25:13 INFO - PROCESS | 6421 | Values: 1452.8 1478.5 1642.9 1753.6 1784.8 7416.5 7619.2 7857.6 8368.1 8381.5 7961.2 8122.4 8141.9 8246.5 8255.8 1905.8 2275.6 2321.9 2329.3 2342.3 2312.5 2344.1 2370.3 2371.2 2375.9 2298.5 2309.5 2321.9 2324.4 2330.7 1908.8 2285.6 2292.1 2319.1 2320.2 2318.2 2334.2 2338.1 2340.9 2354.5 8237.3 8280.0 8353.2 8353.7 8364.7 4348.0 5019.7 5134.3 5190.2 5208.3 3154.5 3242.6 3544.1 3548.3 3549.0 1024.2 1043.8 1065.7 1080.2 1086.9 10803.9 10848.6 10889.5 10926.8 10930.7 4461.6 4530.5 4629.5 4642.2 4709.2 7363.5 9254.3 9363.8 9367.3 9368.9 5121.5 5154.1 5160.0 5171.2 5176.3 4168.7 4453.5 4696.6 4720.7 4735.0 3321.3 3779.0 3785.1 3849.0 3906.2 1261.7 1281.2 1283.4 1286.5 1296.2 826.4 893.5 903.9 905.6 930.3 5044.6 5509.8 5736.1 5810.5 5815.2 968.6 981.8 984.9 999.8 1031.6 3737.2 3844.3 3850.5 3891.8 3906.9 8399.5 9669.9 10136.5 10148.5 10163.0 8369.7 8409.3 10080.7 10111.0 10131.9 7587.8 7633.3 7653.0 7774.2 7819.1 5043.8 5331.0 5540.3 5575.9 5756.1 7106.8 8444.5 8460.1 8551.8 8577.5 8380.0 8550.5 8626.4 8640.3 8658.4 5943.4 6411.9 6501.7 6733.8 6738.6 7534.1 7751.3 7807.6 7917.3 7957.2 6905.6 6940.2 7107.8 7109.2 7146.6 6952.0 7012.8 7048.4 7060.9 7094.5 6580.5 6666.9 6718.2 6719.9 6720.3 4161.4 4837.0 4838.1 4900.0 4920.5 4808.8 4818.8 4860.9 5002.0 5076.1 10:25:13 INFO - PROCESS | 6421 | 10:25:13 INFO - PROCESS | 6421 | [#4] prototype.html Cycles:180 Average:4550.82 Median:5143.75 stddev:1426.93 (27.7%) stddev-sans-first:1394.48 10:25:13 INFO - PROCESS | 6421 | Values: 281.4 290.7 310.8 313.1 314.3 4575.6 5327.6 5426.1 5488.0 5517.9 4642.9 5198.2 5301.7 5393.9 5422.3 3399.6 4095.4 4116.6 4158.3 4161.3 3830.6 4058.6 4131.4 4150.6 4168.2 4067.6 4079.6 4079.9 4096.4 4111.9 3420.9 3699.6 4044.9 4054.4 4061.0 2834.4 3198.8 3556.6 3571.1 3579.3 4726.6 4983.9 5277.9 5306.5 5353.9 3705.1 3902.4 3913.4 4267.0 4314.8 5707.5 5713.7 5739.6 5763.2 5819.3 3233.7 3608.9 3817.7 3910.2 3910.6 4965.6 5978.6 6025.4 6029.7 6032.5 3901.3 3907.6 3942.7 3972.0 3983.7 3508.7 3642.9 3673.8 3846.3 3943.3 4653.4 4664.7 4673.7 4682.7 4694.3 4736.7 4818.4 5503.7 5763.5 5801.3 1226.4 1250.7 1282.5 1294.9 1303.4 846.3 871.0 878.0 881.3 887.3 4918.8 5084.9 5141.5 5180.9 5193.9 5322.8 5448.2 5659.7 5661.9 5680.0 4870.0 4984.5 5092.6 5147.0 5178.7 2490.4 2917.3 2931.6 2935.9 2957.3 5092.3 5209.9 5324.7 5750.4 5764.6 5158.4 5300.8 5313.9 5385.2 5732.5 4904.3 5003.7 5706.9 5717.5 5760.7 5084.6 5136.9 5159.6 5638.9 5640.3 5205.7 5415.7 5579.3 5884.6 5917.5 6243.0 6251.0 6255.9 6260.2 6267.8 3532.8 3727.6 3939.1 4013.5 4018.0 4899.9 5005.5 5146.0 5943.3 5959.8 5284.6 5660.9 5719.5 5814.8 5824.4 5404.2 5742.3 5859.4 5888.4 5924.9 4346.5 5631.5 5695.7 5717.5 5773.8 5777.0 5803.6 5806.8 5833.0 5881.7 5487.9 5541.4 5681.1 5707.2 5713.4 10:25:13 INFO - PROCESS | 6421 | 10:25:13 INFO - PROCESS | 6421 | [#5] yui.html Cycles:180 Average:19862.94 Median:28878.48 stddev:29104.87 (100.8%) stddev-sans-first:29150.91 10:25:13 INFO - PROCESS | 6421 | Values: 689.3 703.6 709.0 721.2 726.3 11695.6 13869.7 14468.4 14545.2 14571.6 11411.6 13385.0 13400.5 13409.1 13437.9 793.0 812.3 815.6 816.2 817.3 640.0 663.5 784.9 806.8 819.0 657.5 806.1 853.9 856.4 862.6 844.5 854.7 855.7 856.0 860.8 543.3 623.3 631.2 631.5 636.5 11406.8 13212.6 13458.5 13542.9 13604.3 10957.5 12873.4 13562.0 13619.6 13699.6 9849.8 10836.7 10941.2 11205.1 11370.8 3304.3 3577.8 3675.8 3691.7 3752.2 80638.6 85959.0 87139.1 89695.6 92406.6 10249.8 10390.5 10430.2 10433.2 10444.2 20518.2 20539.3 20547.4 20592.8 20812.5 7519.8 7553.2 7561.5 7563.6 7732.2 4059.9 4162.8 4273.6 4287.8 4355.1 2852.3 3310.7 3397.7 3419.5 3420.8 597.0 617.0 617.8 621.9 628.1 595.9 616.4 661.3 666.2 673.1 8285.9 8960.6 8975.2 9037.4 9229.1 620.6 642.9 646.9 660.3 663.6 3991.2 3998.6 4089.2 4099.0 4236.1 77670.6 80270.4 116864.0 118993.0 123560.0 64245.4 79578.6 82324.8 96336.0 101171.0 79408.6 83227.0 84130.6 85968.0 86800.6 8982.9 9366.7 9382.0 9456.7 9481.2 57213.7 57878.7 58264.7 58587.5 59076.0 70677.6 73359.3 73576.9 74340.0 75660.0 10043.9 10705.9 11769.3 11847.3 12193.3 12394.1 13858.6 13896.9 14362.8 14371.6 9387.6 9827.6 11132.2 12446.3 12924.5 9297.6 10911.8 11448.2 12086.7 12452.6 12196.3 12259.7 12389.4 12549.2 12561.8 10544.1 10607.4 10869.6 11232.3 11369.8 10786.4 11089.5 11116.4 11183.8 11633.7 10:25:13 INFO - PROCESS | 6421 | -------- Summary: end -------- 10:25:13 INFO - PROCESS | 6421 | 10:25:13 INFO - TEST-INFO | 6421: exit 0 10:25:13 INFO - TEST-OK | dromaeo_css | took 1117673ms 10:25:13 INFO - TEST-START | kraken 10:25:13 INFO - operating with platform_type : mac_ 10:25:13 INFO - Initialising browser for kraken test... 10:25:13 INFO - TEST-INFO | started process 6425 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/tmpkj2mJp/profile http://localhost:57713/getInfo.html) 10:25:16 INFO - PROCESS | 6425 | 2016-11-30 10:25:16.851 plugin-container[6426:110088] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8937, name = 'com.apple.tsm.portname' 10:25:16 INFO - PROCESS | 6425 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:25:16 INFO - PROCESS | 6425 | 2016-11-30 10:25:16.854 plugin-container[6426:110088] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4707, name = 'com.apple.CFPasteboardClient' 10:25:16 INFO - PROCESS | 6425 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:25:16 INFO - PROCESS | 6425 | 2016-11-30 10:25:16.854 plugin-container[6426:110088] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:25:16 INFO - PROCESS | 6425 | __metrics Screen width/height:1600/1200 10:25:16 INFO - PROCESS | 6425 | colorDepth:24 10:25:16 INFO - PROCESS | 6425 | Browser inner width/height: 1024/689 10:25:16 INFO - PROCESS | 6425 | __metrics 10:25:17 ERROR - PROCESS | 6425 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 10:25:17 INFO - TEST-INFO | 6425: exit 0 10:25:17 INFO - Browser initialized. 10:25:17 INFO - Running cycle 1/1 for kraken test... 10:25:17 INFO - TEST-INFO | started process 6427 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/tmpkj2mJp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:25:20 INFO - PROCESS | 6427 | 2016-11-30 10:25:20.514 plugin-container[6428:110214] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 10:25:20 INFO - PROCESS | 6427 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:25:20 INFO - PROCESS | 6427 | 2016-11-30 10:25:20.515 plugin-container[6428:110214] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0f, name = 'com.apple.CFPasteboardClient' 10:25:20 INFO - PROCESS | 6427 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:25:20 INFO - PROCESS | 6427 | 2016-11-30 10:25:20.515 plugin-container[6428:110214] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:25:30 INFO - PROCESS | 6427 | RSS: Main: 228950016 10:25:30 INFO - PROCESS | 6427 | 10:25:33 INFO - PROCESS | 6427 | Cycle 1(1): loaded http://localhost:57713/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57713/tests/kraken/driver.html?testName=audio-beat-detection) 10:25:34 INFO - PROCESS | 6427 | RSS: Main: 240992256 10:25:34 INFO - PROCESS | 6427 | 10:25:36 INFO - PROCESS | 6427 | Cycle 1(1): loaded http://localhost:57713/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57713/tests/kraken/driver.html?testName=audio-dft) 10:25:37 INFO - PROCESS | 6427 | RSS: Main: 248664064 10:25:37 INFO - PROCESS | 6427 | 10:25:40 INFO - PROCESS | 6427 | Cycle 1(1): loaded http://localhost:57713/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57713/tests/kraken/driver.html?testName=audio-fft) 10:25:41 INFO - PROCESS | 6427 | RSS: Main: 252407808 10:25:41 INFO - PROCESS | 6427 | 10:25:43 INFO - PROCESS | 6427 | Cycle 1(1): loaded http://localhost:57713/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57713/tests/kraken/driver.html?testName=audio-oscillator) 10:25:43 INFO - PROCESS | 6427 | RSS: Main: 253812736 10:25:43 INFO - PROCESS | 6427 | 10:25:45 INFO - PROCESS | 6427 | Cycle 1(1): loaded http://localhost:57713/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57713/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:25:46 INFO - PROCESS | 6427 | RSS: Main: 254111744 10:25:46 INFO - PROCESS | 6427 | 10:25:49 INFO - PROCESS | 6427 | Cycle 1(1): loaded http://localhost:57713/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57713/tests/kraken/driver.html?testName=imaging-darkroom) 10:25:50 INFO - PROCESS | 6427 | RSS: Main: 258166784 10:25:50 INFO - PROCESS | 6427 | 10:25:53 INFO - PROCESS | 6427 | Cycle 1(1): loaded http://localhost:57713/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57713/tests/kraken/driver.html?testName=imaging-desaturate) 10:25:54 INFO - PROCESS | 6427 | RSS: Main: 258236416 10:25:54 INFO - PROCESS | 6427 | 10:25:56 INFO - PROCESS | 6427 | Cycle 1(1): loaded http://localhost:57713/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57713/tests/kraken/driver.html?testName=json-parse-financial) 10:25:57 INFO - PROCESS | 6427 | RSS: Main: 258076672 10:25:57 INFO - PROCESS | 6427 | 10:25:59 INFO - PROCESS | 6427 | Cycle 1(1): loaded http://localhost:57713/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57713/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:25:59 INFO - PROCESS | 6427 | RSS: Main: 256643072 10:25:59 INFO - PROCESS | 6427 | 10:26:01 INFO - PROCESS | 6427 | Cycle 1(1): loaded http://localhost:57713/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57713/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:26:02 INFO - PROCESS | 6427 | RSS: Main: 256679936 10:26:02 INFO - PROCESS | 6427 | 10:26:04 INFO - PROCESS | 6427 | Cycle 1(1): loaded http://localhost:57713/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57713/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:26:05 INFO - PROCESS | 6427 | RSS: Main: 256704512 10:26:05 INFO - PROCESS | 6427 | 10:26:08 INFO - PROCESS | 6427 | Cycle 1(1): loaded http://localhost:57713/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57713/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:26:09 INFO - PROCESS | 6427 | RSS: Main: 257036288 10:26:09 INFO - PROCESS | 6427 | 10:26:12 INFO - PROCESS | 6427 | Cycle 1(1): loaded http://localhost:57713/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57713/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:26:12 INFO - PROCESS | 6427 | RSS: Main: 256884736 10:26:12 INFO - PROCESS | 6427 | 10:26:14 INFO - PROCESS | 6427 | Cycle 1(1): loaded http://localhost:57713/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57713/tests/kraken/driver.html?testName=ai-astar) 10:26:14 INFO - PROCESS | 6427 | RSS: Main: 258555904 10:26:14 INFO - PROCESS | 6427 | 10:26:14 INFO - PROCESS | 6427 | __start_tp_report 10:26:14 INFO - PROCESS | 6427 | _x_x_mozilla_page_load 10:26:14 INFO - PROCESS | 6427 | _x_x_mozilla_page_load_details 10:26:14 INFO - PROCESS | 6427 | |i|pagename|runs| 10:26:14 INFO - PROCESS | 6427 | |0;ai-astar;106;119;120;120;119;117;121;119;120;119 10:26:14 INFO - PROCESS | 6427 | |1;audio-beat-detection;157;151;116;151;115;115;119;117;162;149 10:26:14 INFO - PROCESS | 6427 | |2;audio-dft;199;197;198;187;195;193;199;197;198;199 10:26:14 INFO - PROCESS | 6427 | |3;audio-fft;76;64;86;111;66;59;59;60;81;63 10:26:14 INFO - PROCESS | 6427 | |4;audio-oscillator;91;75;91;73;71;74;114;104;107;92 10:26:14 INFO - PROCESS | 6427 | |5;imaging-gaussian-blur;120;133;90;87;91;87;93;132;91;87 10:26:14 INFO - PROCESS | 6427 | |6;imaging-darkroom;175;125;177;152;97;100;101;167;171;99 10:26:14 INFO - PROCESS | 6427 | |7;imaging-desaturate;119;87;98;86;87;88;91;94;88;88 10:26:14 INFO - PROCESS | 6427 | |8;json-parse-financial;55;57;57;61;64;82;90;59;61;61 10:26:14 INFO - PROCESS | 6427 | |9;json-stringify-tinderbox;68;78;71;87;77;75;70;91;93;108 10:26:14 INFO - PROCESS | 6427 | |10;stanford-crypto-aes;87;86;88;88;89;84;84;88;86;87 10:26:14 INFO - PROCESS | 6427 | |11;stanford-crypto-ccm;166;160;162;158;163;172;171;151;221;169 10:26:14 INFO - PROCESS | 6427 | |12;stanford-crypto-pbkdf2;169;173;171;181;172;172;169;167;173;173 10:26:14 INFO - PROCESS | 6427 | |13;stanford-crypto-sha256-iterative;68;71;66;68;73;70;67;71;70;70 10:26:14 INFO - PROCESS | 6427 | __end_tp_report 10:26:14 INFO - PROCESS | 6427 | __start_cc_report 10:26:14 INFO - PROCESS | 6427 | _x_x_mozilla_cycle_collect,976 10:26:14 INFO - PROCESS | 6427 | __end_cc_report 10:26:14 INFO - PROCESS | 6427 | __startTimestamp1480530374627__endTimestamp 10:26:14 INFO - PROCESS | 6427 | 10:26:14 INFO - PROCESS | 6427 | ------- Summary: start ------- 10:26:14 INFO - PROCESS | 6427 | Number of tests: 14 10:26:14 INFO - PROCESS | 6427 | 10:26:14 INFO - PROCESS | 6427 | [#0] ai-astar Cycles:10 Average:118.00 Median:119.50 stddev:4.35 (3.6%) stddev-sans-first:1.12 10:26:14 INFO - PROCESS | 6427 | Values: 106.0 119.0 120.0 120.0 119.0 117.0 121.0 119.0 120.0 119.0 10:26:14 INFO - PROCESS | 6427 | 10:26:14 INFO - PROCESS | 6427 | [#1] audio-beat-detection Cycles:10 Average:135.20 Median:150.00 stddev:20.17 (13.4%) stddev-sans-first:19.79 10:26:14 INFO - PROCESS | 6427 | Values: 157.0 151.0 116.0 151.0 115.0 115.0 119.0 117.0 162.0 149.0 10:26:14 INFO - PROCESS | 6427 | 10:26:14 INFO - PROCESS | 6427 | [#2] audio-dft Cycles:10 Average:196.20 Median:198.00 stddev:3.77 (1.9%) stddev-sans-first:3.86 10:26:14 INFO - PROCESS | 6427 | Values: 199.0 197.0 198.0 187.0 195.0 193.0 199.0 197.0 198.0 199.0 10:26:14 INFO - PROCESS | 6427 | 10:26:14 INFO - PROCESS | 6427 | [#3] audio-fft Cycles:10 Average:72.50 Median:65.00 stddev:16.58 (25.5%) stddev-sans-first:17.54 10:26:14 INFO - PROCESS | 6427 | Values: 76.0 64.0 86.0 111.0 66.0 59.0 59.0 60.0 81.0 63.0 10:26:14 INFO - PROCESS | 6427 | 10:26:14 INFO - PROCESS | 6427 | [#4] audio-oscillator Cycles:10 Average:89.20 Median:74.50 stddev:15.60 (20.9%) stddev-sans-first:16.54 10:26:14 INFO - PROCESS | 6427 | Values: 91.0 75.0 91.0 73.0 71.0 74.0 114.0 104.0 107.0 92.0 10:26:14 INFO - PROCESS | 6427 | 10:26:14 INFO - PROCESS | 6427 | [#5] imaging-gaussian-blur Cycles:10 Average:101.10 Median:88.50 stddev:19.20 (21.7%) stddev-sans-first:19.11 10:26:14 INFO - PROCESS | 6427 | Values: 120.0 133.0 90.0 87.0 91.0 87.0 93.0 132.0 91.0 87.0 10:26:14 INFO - PROCESS | 6427 | 10:26:14 INFO - PROCESS | 6427 | [#6] imaging-darkroom Cycles:10 Average:136.40 Median:173.00 stddev:35.24 (20.4%) stddev-sans-first:34.49 10:26:14 INFO - PROCESS | 6427 | Values: 175.0 125.0 177.0 152.0 97.0 100.0 101.0 167.0 171.0 99.0 10:26:14 INFO - PROCESS | 6427 | 10:26:14 INFO - PROCESS | 6427 | [#7] imaging-desaturate Cycles:10 Average:92.60 Median:88.00 stddev:10.00 (11.4%) stddev-sans-first:3.97 10:26:14 INFO - PROCESS | 6427 | Values: 119.0 87.0 98.0 86.0 87.0 88.0 91.0 94.0 88.0 88.0 10:26:14 INFO - PROCESS | 6427 | 10:26:14 INFO - PROCESS | 6427 | [#8] json-parse-financial Cycles:10 Average:64.70 Median:61.00 stddev:11.67 (19.1%) stddev-sans-first:11.84 10:26:14 INFO - PROCESS | 6427 | Values: 55.0 57.0 57.0 61.0 64.0 82.0 90.0 59.0 61.0 61.0 10:26:14 INFO - PROCESS | 6427 | 10:26:14 INFO - PROCESS | 6427 | [#9] json-stringify-tinderbox Cycles:10 Average:81.80 Median:77.50 stddev:12.71 (16.4%) stddev-sans-first:12.46 10:26:14 INFO - PROCESS | 6427 | Values: 68.0 78.0 71.0 87.0 77.0 75.0 70.0 91.0 93.0 108.0 10:26:14 INFO - PROCESS | 6427 | 10:26:14 INFO - PROCESS | 6427 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:87.50 stddev:1.70 (1.9%) stddev-sans-first:1.80 10:26:14 INFO - PROCESS | 6427 | Values: 87.0 86.0 88.0 88.0 89.0 84.0 84.0 88.0 86.0 87.0 10:26:14 INFO - PROCESS | 6427 | 10:26:14 INFO - PROCESS | 6427 | [#11] stanford-crypto-ccm Cycles:10 Average:169.30 Median:167.50 stddev:19.25 (11.5%) stddev-sans-first:20.38 10:26:14 INFO - PROCESS | 6427 | Values: 166.0 160.0 162.0 158.0 163.0 172.0 171.0 151.0 221.0 169.0 10:26:14 INFO - PROCESS | 6427 | 10:26:14 INFO - PROCESS | 6427 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.00 Median:172.50 stddev:3.77 (2.2%) stddev-sans-first:3.84 10:26:14 INFO - PROCESS | 6427 | Values: 169.0 173.0 171.0 181.0 172.0 172.0 169.0 167.0 173.0 173.0 10:26:14 INFO - PROCESS | 6427 | 10:26:14 INFO - PROCESS | 6427 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:70.00 stddev:2.12 (3.0%) stddev-sans-first:2.19 10:26:14 INFO - PROCESS | 6427 | Values: 68.0 71.0 66.0 68.0 73.0 70.0 67.0 71.0 70.0 70.0 10:26:14 INFO - PROCESS | 6427 | -------- Summary: end -------- 10:26:14 INFO - PROCESS | 6427 | 10:26:15 INFO - TEST-INFO | 6427: exit 0 10:26:15 INFO - TEST-OK | kraken | took 62015ms 10:26:15 INFO - SUITE-END | took 1179s 10:26:16 INFO - Completed test suite (00:19:40) 10:26:16 INFO - javascript benchmark 10:26:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7062.013688865308, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3287.276799104198, 3306.38831816114, 3342.766006379553, 3351.9162020949466, 3354.7148492378146, 5613.971930140348, 5658.519025882805, 5665.915011274834, 5706.429357064291, 5717.914231286523, 5656.802011929583, 5728.054870946289, 5740.741666625001, 5744.770209191638, 5812.099124635688, 5152.149895267276, 5153.458886816887, 5198.92201616976, 5243.737813109348, 5259.5529380002745, 5209.505097015777, 5215.504527069922, 5240.052540366673, 5266.368035835705, 5321.680699158043, 5090.54185123337, 5158.277841102249, 5176.5341119299255, 5243.161094224944, 5247.711375874325, 5193.402758682762, 5195.922061169085, 5196.610254230948, 5201.297824793643, 5203.687778733288, 5076.568491678212, 5096.210087436416, 5100.336956195708, 5129.0767661820855, 5156.097682905514, 5129.461406552333, 5571.944280557183, 5584.636998595079, 5654.37801841797, 5745.396733342981, 4547.909041819178, 4764.785584648699, 6204.6587437690905, 6224.3464436234, 6236.937630623681, 5604.215409842625, 6193.566450348478, 6199.814005579839, 6258.3428739982555, 6268.65522396268, 5813.7383817728305, 5823.417658234142, 5826.372893834855, 5843.5325173985975, 5852.7658893643775, 6108.008189064015, 6186.81439556814, 6312.147860038928, 6316.463100636405, 6337.683115844189, 5273.2617433559335, 6040.486558642477, 6081.209442772411, 6110.285381942539, 6141.2098563120835, 6147.170132032118, 6150.169727086875, 6152.230971128609, 6179.949408600459, 6201.0, 5439.456054394608, 5504.899020195897, 6127.264728232641, 6127.693615319216, 6130.264368275746, 6027.246594175728, 6110.589135957139, 6130.000698177752, 6141.792871882774, 6166.198394208814, 4900.117978763857, 4903.092927808367, 4940.333055037596, 4951.232558953368, 4972.701637901738, 4462.3752674625575, 4463.352813841975, 4485.753283569435, 4488.0, 4534.251848445036, 4445.5776701213335, 4837.4920633333695, 5430.0, 5607.943920560824, 5907.734151963172, 6145.217886812774, 6185.628862268189, 6210.378962103753, 6216.875662486725, 6232.3144454110015, 5687.772489100473, 5862.237909071793, 5865.472107510344, 5874.441928016831, 5898.203742494708, 5311.548518375904, 5356.946430535645, 5368.00691872005, 5373.3551973762615, 5432.728363581805, 6344.0, 6347.111404403295, 6355.237371515448, 6365.936340636535, 6380.042993550912, 6144.078388241799, 6155.907661385172, 6174.351693072163, 6184.721687524162, 6209.720562574786, 6131.896637733107, 6165.260168779775, 6228.03465462854, 6332.0501924709815, 6334.986402175629, 6201.627902325875, 6202.945499265045, 6209.441150296314, 6219.378062193744, 6222.595531290452, 6118.071005858243, 6245.219347581552, 6274.717637706405, 6286.402791734778, 6288.465480434214, 5803.535717142534, 6054.7275372607455, 6074.757009719562, 6083.0, 6155.599886007574, 6057.7879774207695, 6097.979100309478, 6116.457510225511, 6138.263408391022, 6155.569110162246, 5893.557983151195, 5908.9068522323505, 5951.285845698544, 5996.310424301261, 6011.338752737108, 5908.143319218603, 5974.103884417372, 5989.341172471112, 6035.486983606443, 6035.818925432244, 5771.076627739541, 5807.983602869565, 5828.067509198508, 5845.269341332333, 5860.472557469848], "value": 5635.70017339532, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [456.3109704346438, 480.1741005470589, 499.36081815276435, 514.4495389932772, 526.8524813052346, 34815.0, 36244.63755362445, 39029.0, 39147.82556523309, 40963.59036409635, 39984.60015399845, 40642.78071657855, 40657.7967110164, 40702.7964860176, 40720.38919416211, 8993.550322483867, 9215.631374745002, 9217.723468295928, 9230.215431688315, 9255.0, 9046.185843274105, 9075.500847453388, 9176.449413035205, 9183.31125165612, 9194.77013074675, 7699.961500192491, 8534.78663033426, 8924.107589241057, 9099.22656574192, 9212.401193922407, 7269.236730143311, 8554.230119289263, 9194.448333100036, 9212.447253164764, 9247.72256832296, 9100.453972761656, 9152.130547597968, 9162.31282653797, 9165.404248723878, 9177.587008584629, 35855.0, 37883.24233515314, 37895.431568526496, 37933.24133517342, 37965.62034379649, 3242.4649932761304, 3252.040648008843, 3299.6040475142895, 3635.2002559436883, 3789.5073640426567, 25590.87204563984, 28624.570631440543, 29091.854540727374, 29291.0, 29569.26076848096, 2970.3910698306795, 3067.4968077840454, 3185.808851468896, 3193.4730769423018, 3202.6156861176573, 469867.0, 473654.0, 476447.0, 477011.61494192656, 477406.0, 54227.18659220115, 54496.72751636217, 54574.0, 54592.45407545953, 54603.72698136484, 54563.0, 56707.716461418255, 57238.42761572414, 57313.0, 57342.0, 15154.939154259097, 15335.769963450557, 15362.00146990442, 15397.153156576273, 15425.305861236271, 11947.462364193632, 12040.638780836589, 12077.335746534025, 12085.274883507018, 12103.394830258452, 13767.31163441824, 14479.638009049648, 14582.343794529272, 14606.12363258208, 14768.704625907421, 3190.202449387653, 6800.897986530107, 7024.367806897404, 7034.437245020488, 7080.858382832417, 845.9915400845913, 942.641796117471, 1066.6266806617778, 1068.2468859454066, 1071.8338657507943, 28863.989760358287, 28952.131436056952, 29228.853855730584, 29358.853205733834, 29719.702802971693, 875.2123089219754, 1013.4426065663855, 1030.3817709374466, 1053.6891616973012, 1118.6755840806238, 12773.872261277455, 14492.565223043326, 15192.012519186217, 15207.543773686808, 15530.223488825513, 659885.0, 667844.0, 668195.0, 669280.0, 670256.0, 54708.179377309374, 55202.17196742052, 55338.72330638321, 55355.0, 55402.0, 1348.6695759538975, 1359.8096266522696, 1383.6402535340883, 1387.8265216847894, 1390.2701081931864, 28077.57883631788, 28514.85742571274, 28937.855310724153, 29246.268843278238, 29247.561286580294, 51113.0, 52433.0, 53295.73352133214, 56073.43926560682, 56188.15717764319, 587817.0, 595742.0, 596624.0, 598710.0, 599672.0, 39630.40554391629, 39991.0, 40418.0, 40420.79789601033, 40528.3920741195, 35754.64245357513, 43701.34447983346, 44155.11689766251, 44164.55835441605, 44904.77547612241, 36668.379334254816, 37312.69405570792, 37622.0, 38442.615573845025, 38811.835644930696, 36762.713305035264, 36911.44632830563, 37747.26067255955, 37776.81111594424, 37933.24133517259, 23996.76003240015, 26173.0, 32487.0, 35871.0, 36894.262114758094, 25597.87201063983, 33863.645454181555, 34288.31423371568, 34309.313813723085, 34367.82816085903, 20665.89667051655, 25008.999640014925, 25137.0, 25199.74800251974, 25837.483250335263], "value": 19174.28276126743, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.18818869750436, 369.1877868688885, 380.7353889047113, 383.3062157494933, 397.9820908059137, 18499.815001849976, 19068.71396929047, 19253.133608987595, 19826.801731982676, 20050.89974550125, 11445.168772996321, 12491.687707807308, 18735.0, 19315.4205373839, 19463.221471141136, 5197.740112994354, 5451.100568406208, 5454.91817622736, 5456.781728730846, 5478.0, 5258.47415258473, 5351.57187425007, 5659.405762394951, 5707.62900411474, 5750.02249617566, 5726.570507211955, 5744.655320680752, 5764.711764411783, 5771.480566748992, 5772.5670574707065, 5165.0, 6036.0945858121195, 6347.555671103025, 6352.301246862841, 6367.267764207106, 5404.756785944642, 5595.972020139914, 5611.13027480737, 5623.634463759883, 5628.761672432059, 12831.973442124608, 12988.415521301564, 13035.696430356984, 13046.608601741962, 14568.635784105376, 2294.9770502295096, 2317.2700599311165, 2324.244620498345, 2351.9647205291935, 2507.0, 6883.518153729241, 9935.90064099357, 10149.543270552844, 12519.93740031303, 13831.893448524093, 1769.7433872088604, 1847.135345278748, 1856.424508402386, 1878.4176905159445, 1906.771187457514, 87789.0, 123006.0, 127988.36005820005, 128523.7147628521, 129900.0, 9121.589528471235, 11537.711557210969, 11624.767504650028, 11675.37298666356, 11855.407229638484, 14676.41294348214, 14741.778873316909, 14759.114453132846, 14770.40918363275, 14788.0, 8129.309008734205, 8407.495550267004, 8451.66193352259, 8562.48625082497, 8583.828323433621, 8268.462549934235, 8284.171582841667, 8308.12764659714, 8469.957650211709, 8480.872786908201, 3915.882523524299, 4333.631641310524, 4542.364069030338, 4564.7032942858605, 4651.790669419885, 1866.981330186708, 1912.512309361104, 1913.3685883658359, 1922.1638587214607, 1932.062949469506, 711.434409644334, 831.2560258568548, 863.1368631368631, 868.6351732272461, 929.1126973740062, 18681.626367472847, 20045.899770501055, 20403.79596204019, 20481.59036819285, 20541.589168216553, 900.2887718702283, 916.6699988004314, 921.6820197032014, 935.4901578639658, 963.5312873654786, 8973.820523589622, 9921.553530091163, 10271.00876866132, 10430.16558675304, 10457.68626941193, 578438.0, 580665.0966745139, 581772.0, 602201.0, 606011.0, 89424.5528772352, 122374.0, 123550.76449235572, 131353.34323328512, 132029.0, 939.6241503398695, 957.5260246178048, 977.2572844637984, 982.3467394182788, 983.1986930651497, 18194.727079093558, 18337.63324733471, 18399.724004140215, 18511.72232416488, 18751.15619797085, 53734.0, 54952.0, 55834.441655584546, 56934.7153264231, 57009.14486282792, 79358.0, 79990.0, 80046.0, 80668.0, 80851.0, 7075.646217689198, 7385.7045718170675, 7973.0, 8006.359491240571, 8209.589520524069, 11292.661220163409, 11927.82108268394, 12178.756424871275, 12368.876311237133, 12629.052821038274, 9344.532773361441, 9744.951275243578, 9940.602375904882, 10397.896021039693, 10710.250282480152, 10640.574377024832, 10667.839982400425, 10729.248952573245, 10943.45282735876, 11053.502592383524, 9838.508074596384, 10563.419011954416, 10905.890941090805, 11262.0, 11365.488553015299, 7784.3024563331965, 7891.092524359772, 8079.434439589172, 8142.0, 8306.293965013041, 8002.5598592077995, 10264.897351026693, 10633.734156646145, 10901.781964360827, 11155.553777848796], "value": 9140.606954434761, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1452.7675571908496, 1478.4973109142893, 1642.9260683269251, 1753.5791410061588, 1784.7947486039109, 7416.480846340758, 7619.238076192378, 7857.607119644016, 8368.121347258542, 8381.497110173394, 7961.243681850229, 8122.350211983042, 8141.91858081419, 8246.546439945801, 8255.793605159874, 1905.7808352039485, 2275.567642147995, 2321.93034208974, 2329.336139200328, 2342.273895092527, 2312.491251924574, 2344.074090734159, 2370.3244575296044, 2371.1819422299363, 2375.8812059397046, 2298.494331247123, 2309.4919117794143, 2321.8839058047115, 2324.407276144581, 2330.743618202005, 1908.761404824397, 2285.6342985122383, 2292.071710957065, 2319.072371051576, 2320.153144102399, 2318.2233951626226, 2334.1713691639393, 2338.1348900906605, 2340.941476463085, 2354.482013956944, 8237.258646721824, 8280.0, 8353.164683531659, 8353.665853365857, 8364.707235246737, 4347.978225117095, 5019.723915184663, 5134.255532947702, 5190.169572868361, 5208.2968799212, 3154.511050787132, 3242.6108866935883, 3544.131687736495, 3548.308079924416, 3549.0, 1024.2267088348249, 1043.843423486483, 1065.664315740547, 1080.1682704317632, 1086.8804431512526, 10803.891961080368, 10848.620298289601, 10889.509972051277, 10926.781464370668, 10930.726731831768, 4461.643068554573, 4530.524294949048, 4629.4722741495225, 4642.234031384851, 4709.246520556694, 7363.484556081023, 9254.305927055364, 9363.812723745486, 9367.250619950388, 9368.859467107999, 5121.4878512149235, 5154.072266991902, 5159.993801208803, 5171.198464238049, 5176.275321454999, 4168.7290326128705, 4453.532379100213, 4696.577308042292, 4720.740359280273, 4735.0, 3321.2693207494794, 3779.036345731876, 3785.1104990327804, 3848.9807550962064, 3906.2382835347403, 1261.7224210673637, 1281.1928485054543, 1283.4481173095471, 1286.5175559165314, 1296.2416986063258, 826.3719573124348, 893.5442924108621, 903.8644203369547, 905.6060613633091, 930.2743859789375, 5044.571211447068, 5509.752061157257, 5736.082226843769, 5810.535157187415, 5815.156802263648, 968.6416026070399, 981.76297864691, 984.9162821160138, 999.8300288950895, 1031.6234574380296, 3737.2338670572467, 3844.3464611016193, 3850.537935447708, 3891.785951772623, 3906.90232744178, 8399.53802540854, 9669.90330096704, 10136.493175341204, 10148.543315550818, 10163.0, 8369.748907532783, 8409.285210757154, 10080.69757907264, 10111.03945125212, 10131.898681013243, 7587.810304742426, 7633.274838890296, 7652.961735191288, 7774.183710710294, 7819.100803407681, 5043.773030213576, 5331.040412725747, 5540.307461567304, 5575.8884822304135, 5756.107803290497, 7106.751263705745, 8444.535550544779, 8460.069392366711, 8551.786205344915, 8577.528235947082, 8379.952505936757, 8550.529720865163, 8626.353023523136, 8640.308775298086, 8658.39391242607, 5943.405659434022, 6411.942029565256, 6501.707423165874, 6733.764318248838, 6738.629375384401, 7534.133574638987, 7751.263629955145, 7807.570583617956, 7917.287444129825, 7957.1644977276555, 6905.551139175937, 6940.236573976959, 7107.786766396809, 7109.182444019004, 7146.571205727673, 6952.0, 7012.789616311519, 7048.400885924754, 7060.929390706027, 7094.503384763017, 6580.473562114924, 6666.899996500153, 6718.22740384862, 6719.865602688016, 6720.260771315249, 4161.375793630858, 4837.0084132752, 4838.104950584153, 4899.975500122477, 4920.532549407943, 4808.7595620219545, 4818.783154757974, 4860.92708609364, 5001.999600080071, 5076.111680455831], "value": 4353.700265859406, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [281.41606167203054, 290.65412159530143, 310.7669248063952, 313.11544885697907, 314.27089153164655, 4575.565321294476, 5327.627066105364, 5426.077566813641, 5487.984722826275, 5517.889642207154, 4642.930356044653, 5198.220266959958, 5301.655392399492, 5393.892122157555, 5422.322209723785, 3399.5750531183603, 4095.4471146395153, 4116.567760385154, 4158.251514727363, 4161.313383291768, 3830.559485659143, 4058.5738497457783, 4131.421600975866, 4150.64719498843, 4168.207301108265, 4067.5560176137487, 4079.551249362568, 4079.8980025499304, 4096.3855421686685, 4111.9177616447805, 3420.948685769728, 3699.648533389324, 4044.878653640381, 4054.412110243998, 4060.964454064195, 2834.4472827798586, 3198.8088159610743, 3556.608773034964, 3571.1250743567994, 3579.28414317135, 4726.598239149676, 4983.875403114951, 5277.920831187535, 5306.522412982811, 5353.946460535384, 3705.09225239818, 3902.4195200943664, 3913.3563903160457, 4266.978665106686, 4314.762688052156, 5707.458986073737, 5713.714414256759, 5739.626924249952, 5763.193152958589, 5819.301683797971, 3233.7413006959387, 3608.9278214435826, 3817.675497582709, 3910.237503686782, 3910.608939106095, 4965.602751779849, 5978.581499295051, 6025.397460253939, 6029.678573749138, 6032.547558933097, 3901.3367727486398, 3907.648311651965, 3942.704297177723, 3972.0268534209304, 3983.7052957788833, 3508.6666766657127, 3642.907127861684, 3673.779573225615, 3846.3268927937497, 3943.2507823513442, 4653.417837935118, 4664.743439110882, 4673.6728429009645, 4682.672212945061, 4694.342792009122, 4736.739479328601, 4818.445878723922, 5503.670279480936, 5763.452472015152, 5801.332846722681, 1226.4480983557435, 1250.693580072888, 1282.4805953588811, 1294.9287789171685, 1303.361352937073, 846.2595229174473, 870.9520976346362, 877.9517126558101, 881.2905610983092, 887.272436601993, 4918.754062296871, 5084.872803226063, 5141.53726164647, 5180.948190518122, 5193.870153246124, 5322.813701520428, 5448.155535891943, 5659.688717120598, 5661.886762264814, 5680.0, 4869.9513004870205, 4984.476629953802, 5092.6435149539175, 5146.974265128651, 5178.741062946838, 2490.4310284520634, 2917.2998480364986, 2931.6042334285025, 2935.8532073396673, 2957.275467510474, 5092.28707980883, 5209.947900520946, 5324.6805191687845, 5750.424957504216, 5764.5676574257095, 5158.4067832199025, 5300.761465734051, 5313.8937221255355, 5385.192221166856, 5732.541396688255, 4904.308013735184, 5003.724795136302, 5706.914396284059, 5717.456841600041, 5760.711964401847, 5084.6440749147205, 5136.94692588026, 5159.587233021274, 5638.9436105638415, 5640.266765320482, 5205.687658740488, 5415.675059496442, 5579.330480342385, 5884.558658100746, 5917.497012753965, 6242.968785156045, 6251.031090181029, 6255.874882502416, 6260.212571394423, 6267.811965641038, 3532.8410221540607, 3727.552693676776, 3939.094008378032, 4013.478247827764, 4017.9598204017584, 4899.877503062452, 5005.524475174852, 5145.970805838922, 5943.346231914399, 5959.76160953557, 5284.603654725834, 5660.9150862737915, 5719.456651618089, 5814.766709961069, 5824.417558244142, 5404.1625847212135, 5742.28221472316, 5859.44335288147, 5888.352281249145, 5924.8815023700145, 4346.500152482505, 5631.521320687787, 5695.743691533974, 5717.542596592346, 5773.769049237983, 5776.971115144397, 5803.593748437569, 5806.767729290781, 5833.0375488044, 5881.676507792113, 5487.862803429946, 5541.445855414588, 5681.0910254359105, 5707.229524014371, 5713.428657134254], "value": 4090.96512397029, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [689.2762599270766, 703.5989485992983, 708.9893651595223, 721.1922646635766, 726.3245181980758, 11695.649130526077, 13869.653258668539, 14468.421263149461, 14545.200013999225, 14571.635709107277, 11411.600593979212, 13385.0, 13400.530981415652, 13409.061365704405, 13437.932810335935, 792.9920700793004, 812.25272749071, 815.5881279953616, 816.1552792859362, 817.3216230528677, 639.9808005759835, 663.4824836627438, 784.8704963680985, 806.7579726082181, 818.9885491418094, 657.4707360574736, 806.1213277527494, 853.9444936079166, 856.387682806793, 862.6290695001147, 844.4975239732349, 854.692310768123, 855.6620135046684, 855.9914400855974, 860.7805009722543, 543.2503145658966, 623.3112410786107, 631.2488139114439, 631.4758750237293, 636.5130675033603, 11406.80228576004, 13212.603621891358, 13458.52895148665, 13542.932285338511, 13604.31978401076, 10957.452127393599, 12873.420696068606, 13562.0, 13619.591412257649, 13699.589012329647, 9849.803003939882, 10836.67489975302, 10941.23411361205, 11205.103591712725, 11370.772584548346, 3304.256542277992, 3577.83899724513, 3675.8345874435713, 3691.7046636269033, 3752.155764952891, 80638.5968070156, 85959.0, 87139.12860871374, 89695.55152224198, 92406.61390079155, 10249.84625230622, 10390.48047597617, 10430.217733670004, 10433.16534677224, 10444.21668374875, 20518.179272829217, 20539.281125160847, 20547.38357849237, 20592.794072059387, 20812.479688007617, 7519.774406767806, 7553.206913274027, 7561.508501947355, 7563.621818909032, 7732.188120247405, 4059.939100913489, 4162.771047592411, 4273.594008569181, 4287.849925252601, 4355.107203023436, 2852.3297025199063, 3310.652381499956, 3397.677220664033, 3419.46998215277, 3420.8289585520624, 596.9820905372845, 617.0466629058116, 617.8486270863577, 621.940915613016, 628.1488582970101, 595.8957182493133, 616.4051690119056, 661.2825084783065, 666.2072134160334, 673.0778832998823, 8285.917140828635, 8960.610896508519, 8975.192232699088, 9037.412568183046, 9229.077092290718, 620.5966122020723, 642.881067002606, 646.9223693156852, 660.2802944790105, 663.5561436146385, 3991.201759648082, 3998.640122388999, 4089.1821635672986, 4098.979505102456, 4236.131593023423, 77670.6116469414, 80270.39459210783, 116864.0, 118993.0, 123560.0, 64245.35754642394, 79578.6021069891, 82324.76512852192, 96336.0, 101170.98829011763, 79408.60295698485, 83227.0, 84130.57934710287, 85968.0, 86800.56599717087, 8982.86525702128, 9366.718998430058, 9381.953090234505, 9456.716298511055, 9481.241500680067, 57213.71393143007, 57878.7106064467, 58264.70867645634, 58587.48475091508, 59076.0, 70677.64661176661, 73359.26640733525, 73576.89634655377, 74340.0, 75660.0, 10043.949780251052, 10705.89294107049, 11769.293842369143, 11847.348395838311, 12193.268403895794, 12394.070444716863, 13858.584242472742, 13896.930515347358, 14362.784558231426, 14371.640708982359, 9387.577559009998, 9827.55775990068, 11132.220744547803, 12446.25322480654, 12924.483020679067, 9297.628094876129, 10911.78176436451, 11448.198626096093, 12086.697832554257, 12452.56416025471, 12196.268223906594, 12259.69350766238, 12389.442475088463, 12549.184303020274, 12561.811572826598, 10544.05103540685, 10607.363558186533, 10869.619563315246, 11232.3260604364, 11369.829452558384, 10786.406747628957, 11089.50097245642, 11116.388598627153, 11183.776324473627, 11633.6509904703], "value": 7050.164396052889, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1585.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 119.0, 120.0, 120.0, 119.0, 117.0, 121.0, 119.0, 120.0, 119.0], "value": 118.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 151.0, 116.0, 151.0, 115.0, 115.0, 119.0, 117.0, 162.0, 149.0], "value": 135.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 197.0, 198.0, 187.0, 195.0, 193.0, 199.0, 197.0, 198.0, 199.0], "value": 196.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 64.0, 86.0, 111.0, 66.0, 59.0, 59.0, 60.0, 81.0, 63.0], "value": 72.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 75.0, 91.0, 73.0, 71.0, 74.0, 114.0, 104.0, 107.0, 92.0], "value": 89.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 133.0, 90.0, 87.0, 91.0, 87.0, 93.0, 132.0, 91.0, 87.0], "value": 101.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 125.0, 177.0, 152.0, 97.0, 100.0, 101.0, 167.0, 171.0, 99.0], "value": 136.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 87.0, 98.0, 86.0, 87.0, 88.0, 91.0, 94.0, 88.0, 88.0], "value": 92.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 57.0, 57.0, 61.0, 64.0, 82.0, 90.0, 59.0, 61.0, 61.0], "value": 64.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 78.0, 71.0, 87.0, 77.0, 75.0, 70.0, 91.0, 93.0, 108.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 88.0, 88.0, 89.0, 84.0, 84.0, 88.0, 86.0, 87.0], "value": 86.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 160.0, 162.0, 158.0, 163.0, 172.0, 171.0, 151.0, 221.0, 169.0], "value": 169.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 173.0, 171.0, 181.0, 172.0, 172.0, 169.0, 167.0, 173.0, 173.0], "value": 172.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 66.0, 68.0, 73.0, 70.0, 67.0, 71.0, 70.0, 70.0], "value": 69.4, "unit": "score"}]}]} 10:26:16 INFO - Return code: 0 10:26:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:26:16 ERROR - # TBPL SUCCESS # 10:26:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:26:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:26:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:26:16 INFO - 2016-11-30 10:26:16.470 screenresolution[6432:110606] starting screenresolution argv=screenresolution get 10:26:16 INFO - 2016-11-30 10:26:16.473 screenresolution[6432:110606] Display 0: 1600x1200x32@60 10:26:16 INFO - 2016-11-30 10:26:16.479 screenresolution[6433:110609] starting screenresolution argv=screenresolution list 10:26:16 INFO - Available Modes on Display 0 10:26:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:26:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:26:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:26:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:26:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:26:16 INFO - Intel Iris: 10:26:16 INFO - Chipset Model: Intel Iris 10:26:16 INFO - Type: GPU 10:26:16 INFO - Bus: Built-In 10:26:16 INFO - VRAM (Dynamic, Max): 1536 MB 10:26:16 INFO - Vendor: Intel (0x8086) 10:26:16 INFO - Device ID: 0x0a2e 10:26:16 INFO - Revision ID: 0x0009 10:26:16 INFO - Displays: 10:26:16 INFO - Display: 10:26:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:26:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:26:16 INFO - Display Serial Number: 1600x1200 60 10:26:16 INFO - Main Display: Yes 10:26:16 INFO - Mirror: Off 10:26:16 INFO - Online: Yes 10:26:16 INFO - Rotation: Supported 10:26:16 INFO - Return code: 0 10:26:16 INFO - Running post-action listener: _resource_record_post_action 10:26:16 INFO - [mozharness: 2016-11-30 18:26:16.716704Z] Finished run-tests step (success) 10:26:16 INFO - Running post-run listener: _resource_record_post_run 10:26:16 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 3269120; Write bytes: 662614016; Read time: 27; Write time: 1986 10:26:16 INFO - TinderboxPrint: CPU usage
54.3% 10:26:16 INFO - TinderboxPrint: I/O read bytes / time
3,269,120 / 27 10:26:16 INFO - TinderboxPrint: I/O write bytes / time
662,614,016 / 1,986 10:26:16 INFO - TinderboxPrint: CPU idle
2,214.4 (45.7%) 10:26:16 INFO - TinderboxPrint: CPU system
987.7 (20.4%) 10:26:16 INFO - TinderboxPrint: CPU user
1,647.7 (34.0%) 10:26:16 INFO - TinderboxPrint: Swap in / out
352,788,480 / 0 10:26:16 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 344539648; Write bytes: 345015808; Read time: 27077; Write time: 748 10:26:16 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 2404864; Write bytes: 310684160; Read time: 24; Write time: 1208 10:26:17 INFO - Running post-run listener: _upload_blobber_files 10:26:17 INFO - Blob upload gear active. 10:26:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:26:17 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 10:26:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:26:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:26:17 INFO - (blobuploader) - INFO - Open directory for files ... 10:26:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:26:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:26:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:26:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:26:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:26:19 INFO - (blobuploader) - INFO - Done attempting. 10:26:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:26:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:26:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:26:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:26:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:26:20 INFO - (blobuploader) - INFO - Done attempting. 10:26:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:26:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:26:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:26:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:26:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:26:22 INFO - (blobuploader) - INFO - Done attempting. 10:26:22 INFO - (blobuploader) - INFO - Iteration through files over. 10:26:22 INFO - Return code: 0 10:26:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:26:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:26:22 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ab453d747de0ed08b2dc099832bae31001590ddbf5303251401227488c6c2dada465d6f79da785763aac1bf7703788122a4b8fc3608988f8f257466c7e5f3022", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c55b50bb4f8d4ecddeb4aca1045169902fd16f31c94a56a6bed7a1adb0c15698c9fa7db70e1f24dbbdba5f156b9a19ec117d68a0d50a477c7f3c309be9853620", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/270717a86ba81cdf719550096244c0657df9a7cef0e0c694af0cff5fcb128d8d51ed16ece4f8522330d0f5c659f620579476d39ab5b1e19458ef9fab2aacf008"} 10:26:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:26:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:26:22 INFO - Contents: 10:26:22 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ab453d747de0ed08b2dc099832bae31001590ddbf5303251401227488c6c2dada465d6f79da785763aac1bf7703788122a4b8fc3608988f8f257466c7e5f3022", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c55b50bb4f8d4ecddeb4aca1045169902fd16f31c94a56a6bed7a1adb0c15698c9fa7db70e1f24dbbdba5f156b9a19ec117d68a0d50a477c7f3c309be9853620", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/270717a86ba81cdf719550096244c0657df9a7cef0e0c694af0cff5fcb128d8d51ed16ece4f8522330d0f5c659f620579476d39ab5b1e19458ef9fab2aacf008"} 10:26:22 INFO - Running post-run listener: copy_logs_to_upload_dir 10:26:22 INFO - Copying logs to upload dir... 10:26:22 INFO - mkdir: /builds/slave/test/build/upload/logs 10:26:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.071227 ========= master_lag: -0.13 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-11-30 10:26:22.466266) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-30 10:26:22.473799) ========= 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.pw4tUhLOA0/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.IqylKf73XF/Listeners TMPDIR=/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ab453d747de0ed08b2dc099832bae31001590ddbf5303251401227488c6c2dada465d6f79da785763aac1bf7703788122a4b8fc3608988f8f257466c7e5f3022", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c55b50bb4f8d4ecddeb4aca1045169902fd16f31c94a56a6bed7a1adb0c15698c9fa7db70e1f24dbbdba5f156b9a19ec117d68a0d50a477c7f3c309be9853620", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/270717a86ba81cdf719550096244c0657df9a7cef0e0c694af0cff5fcb128d8d51ed16ece4f8522330d0f5c659f620579476d39ab5b1e19458ef9fab2aacf008"} build_url:https://queue.taskcluster.net/v1/task/MILHvp24QGu-jPZIsXD1tA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011359 build_url: 'https://queue.taskcluster.net/v1/task/MILHvp24QGu-jPZIsXD1tA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ab453d747de0ed08b2dc099832bae31001590ddbf5303251401227488c6c2dada465d6f79da785763aac1bf7703788122a4b8fc3608988f8f257466c7e5f3022", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c55b50bb4f8d4ecddeb4aca1045169902fd16f31c94a56a6bed7a1adb0c15698c9fa7db70e1f24dbbdba5f156b9a19ec117d68a0d50a477c7f3c309be9853620", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/270717a86ba81cdf719550096244c0657df9a7cef0e0c694af0cff5fcb128d8d51ed16ece4f8522330d0f5c659f620579476d39ab5b1e19458ef9fab2aacf008"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-30 10:26:22.510206) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 10:26:22.510536) ========= 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.pw4tUhLOA0/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.IqylKf73XF/Listeners TMPDIR=/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/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.005307 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 10:26:22.559191) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-30 10:26:22.562524) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-30 10:26:22.562837) ========= ========= Total master_lag: 0.02 =========