builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0242 starttime: 1493635052.71 results: success (0) buildid: 20170501022117 builduid: b853e2bd75864f7bad79989805028274 revision: de63010ad9d6877979587327e4b63038a561dfc5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-01 03:37:32.708144) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-01 03:37:32.708596) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-01 03:37:32.708871) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-01 03:37:32.734058) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 03:37:32.734378) ========= 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.wyKO0rfjKU/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.XpYtnZXDis/Listeners TMPDIR=/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-05-01 03:37:32-- 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% 76.4M=0s 2017-05-01 03:37:33 (76.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.606278 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 03:37:33.364766) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 03:37:33.365071) ========= 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.wyKO0rfjKU/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.XpYtnZXDis/Listeners TMPDIR=/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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.022404 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 03:37:33.413180) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-01 03:37:33.413482) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev de63010ad9d6877979587327e4b63038a561dfc5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev de63010ad9d6877979587327e4b63038a561dfc5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wyKO0rfjKU/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.XpYtnZXDis/Listeners TMPDIR=/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-05-01 03:37:33,464 truncating revision to first 12 chars 2017-05-01 03:37:33,464 Setting DEBUG logging. 2017-05-01 03:37:33,464 attempt 1/10 2017-05-01 03:37:33,464 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/de63010ad9d6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-01 03:37:34,790 unpacking tar archive at: mozilla-central-de63010ad9d6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.596676 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-01 03:37:35.036927) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-01 03:37:35.037642) ========= script_repo_revision: de63010ad9d6877979587327e4b63038a561dfc5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-01 03:37:35.038553) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-01 03:37:35.039227) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-01 03:37:35.064095) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2017-05-01 03:37:35.064824) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wyKO0rfjKU/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.XpYtnZXDis/Listeners TMPDIR=/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 03:37:35 INFO - MultiFileLogger online at 20170501 03:37:35 in /builds/slave/test 03:37:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:37:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:37:35 INFO - {'append_to_log': False, 03:37:35 INFO - 'base_work_dir': '/builds/slave/test', 03:37:35 INFO - 'blob_upload_branch': 'Firefox', 03:37:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:37:35 INFO - 'branch': 'Firefox', 03:37:35 INFO - 'buildbot_json_path': 'buildprops.json', 03:37:35 INFO - 'config_files': ('talos/mac_config.py',), 03:37:35 INFO - 'default_actions': ('clobber', 03:37:35 INFO - 'read-buildbot-config', 03:37:35 INFO - 'download-and-extract', 03:37:35 INFO - 'populate-webroot', 03:37:35 INFO - 'create-virtualenv', 03:37:35 INFO - 'install', 03:37:35 INFO - 'run-tests'), 03:37:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:37:35 INFO - 'download_minidump_stackwalk': True, 03:37:35 INFO - 'download_symbols': 'ondemand', 03:37:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:37:35 INFO - 'tooltool.py': '/tools/tooltool.py', 03:37:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:37:35 INFO - '/tools/misc-python/virtualenv.py')}, 03:37:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:37:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:37:35 INFO - 'gecko_profile': False, 03:37:35 INFO - 'gecko_profile_interval': 0, 03:37:35 INFO - 'installer_path': 'installer.exe', 03:37:35 INFO - 'log_level': 'info', 03:37:35 INFO - 'log_name': 'talos', 03:37:35 INFO - 'log_to_console': True, 03:37:35 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:37:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:37:35 INFO - 'opt_config_files': (), 03:37:35 INFO - 'pip_index': False, 03:37:35 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:37:35 INFO - 'cmd': ('bash', 03:37:35 INFO - '-c', 03:37:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:37:35 INFO - 'enabled': True, 03:37:35 INFO - 'halt_on_failure': False, 03:37:35 INFO - 'name': 'check_screen_resolution'},), 03:37:35 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:37:35 INFO - 'cmd': ('bash', 03:37:35 INFO - '-c', 03:37:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:37:35 INFO - 'enabled': True, 03:37:35 INFO - 'halt_on_failure': False, 03:37:35 INFO - 'name': 'check_screen_resolution'},), 03:37:35 INFO - 'run_cmd_checks_enabled': True, 03:37:35 INFO - 'suite': 'dromaeojs-e10s', 03:37:35 INFO - 'system_bits': '32', 03:37:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:37:35 INFO - 'title': 't-yosemite-r7-0242', 03:37:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:37:35 INFO - 'use_talos_json': True, 03:37:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:37:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:37:35 INFO - 'work_dir': 'build'} 03:37:35 INFO - [mozharness: 2017-05-01 10:37:35.236178Z] Running clobber step. 03:37:35 INFO - Running pre-action listener: _resource_record_pre_action 03:37:35 INFO - Running main action method: clobber 03:37:35 INFO - rmtree: /builds/slave/test/build 03:37:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:37:37 INFO - Running post-action listener: _resource_record_post_action 03:37:37 INFO - [mozharness: 2017-05-01 10:37:37.119661Z] Finished clobber step (success) 03:37:37 INFO - [mozharness: 2017-05-01 10:37:37.119821Z] Running read-buildbot-config step. 03:37:37 INFO - Running pre-action listener: _resource_record_pre_action 03:37:37 INFO - Running main action method: read_buildbot_config 03:37:37 INFO - Using buildbot properties: 03:37:37 INFO - { 03:37:37 INFO - "project": "", 03:37:37 INFO - "product": "firefox", 03:37:37 INFO - "script_repo_revision": "production", 03:37:37 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 03:37:37 INFO - "repository": "", 03:37:37 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 03:37:37 INFO - "buildid": "20170501022117", 03:37:37 INFO - "pgo_build": "False", 03:37:37 INFO - "basedir": "/builds/slave/test", 03:37:37 INFO - "buildnumber": 136, 03:37:37 INFO - "slavename": "t-yosemite-r7-0242", 03:37:37 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 03:37:37 INFO - "platform": "yosemite_r7", 03:37:37 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 03:37:37 INFO - "branch": "mozilla-central", 03:37:37 INFO - "repo_path": "mozilla-central", 03:37:37 INFO - "revision": "de63010ad9d6877979587327e4b63038a561dfc5", 03:37:37 INFO - "stage_platform": "macosx64", 03:37:37 INFO - "builduid": "b853e2bd75864f7bad79989805028274", 03:37:37 INFO - "slavebuilddir": "test" 03:37:37 INFO - } 03:37:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/SFhZjpPLToGWLkXAhCWKyw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 03:37:37 INFO - Running post-action listener: _resource_record_post_action 03:37:37 INFO - [mozharness: 2017-05-01 10:37:37.124370Z] Finished read-buildbot-config step (success) 03:37:37 INFO - [mozharness: 2017-05-01 10:37:37.124524Z] Running download-and-extract step. 03:37:37 INFO - Running pre-action listener: _resource_record_pre_action 03:37:37 INFO - Running main action method: download_and_extract 03:37:37 INFO - mkdir: /builds/slave/test/build/tests 03:37:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:37 INFO - trying https://queue.taskcluster.net/v1/task/SFhZjpPLToGWLkXAhCWKyw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 03:37:37 INFO - Downloading https://queue.taskcluster.net/v1/task/SFhZjpPLToGWLkXAhCWKyw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 03:37:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SFhZjpPLToGWLkXAhCWKyw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 03:37:38 INFO - Downloaded 1325 bytes. 03:37:38 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 03:37:38 INFO - Using the following test package requirements: 03:37:38 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:37:38 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 03:37:38 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 03:37:38 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:37:38 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 03:37:38 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:37:38 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 03:37:38 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:37:38 INFO - u'jsshell-mac.zip'], 03:37:38 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:37:38 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 03:37:38 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 03:37:38 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:37:38 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 03:37:38 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:37:38 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 03:37:38 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:37:38 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 03:37:38 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:37:38 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 03:37:38 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:37:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SFhZjpPLToGWLkXAhCWKyw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 03:37:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SFhZjpPLToGWLkXAhCWKyw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:37:38 INFO - Fetch https://queue.taskcluster.net/v1/task/SFhZjpPLToGWLkXAhCWKyw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 03:37:40 INFO - Content-Length response header: 52700850 03:37:40 INFO - Bytes received: 52700850 03:37:56 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 03:37:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SFhZjpPLToGWLkXAhCWKyw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 03:37:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SFhZjpPLToGWLkXAhCWKyw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:37:56 INFO - Fetch https://queue.taskcluster.net/v1/task/SFhZjpPLToGWLkXAhCWKyw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 03:37:58 INFO - Content-Length response header: 52700850 03:37:58 INFO - Bytes received: 52700850 03:38:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SFhZjpPLToGWLkXAhCWKyw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 03:38:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SFhZjpPLToGWLkXAhCWKyw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 03:38:13 INFO - Fetch https://queue.taskcluster.net/v1/task/SFhZjpPLToGWLkXAhCWKyw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 03:38:14 INFO - Content-Length response header: 14408811 03:38:14 INFO - Bytes received: 14408811 03:38:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:38:14 INFO - trying https://queue.taskcluster.net/v1/task/SFhZjpPLToGWLkXAhCWKyw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:38:14 INFO - Downloading https://queue.taskcluster.net/v1/task/SFhZjpPLToGWLkXAhCWKyw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 03:38:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SFhZjpPLToGWLkXAhCWKyw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 03:38:16 INFO - Downloaded 71249747 bytes. 03:38:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SFhZjpPLToGWLkXAhCWKyw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:38:16 INFO - mkdir: /builds/slave/test/properties 03:38:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:38:16 INFO - Writing to file /builds/slave/test/properties/build_url 03:38:16 INFO - Contents: 03:38:16 INFO - build_url:https://queue.taskcluster.net/v1/task/SFhZjpPLToGWLkXAhCWKyw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:38:17 INFO - Running post-action listener: _resource_record_post_action 03:38:17 INFO - Running post-action listener: set_extra_try_arguments 03:38:17 INFO - [mozharness: 2017-05-01 10:38:17.488483Z] Finished download-and-extract step (success) 03:38:17 INFO - [mozharness: 2017-05-01 10:38:17.488636Z] Running populate-webroot step. 03:38:17 INFO - Running pre-action listener: _resource_record_pre_action 03:38:17 INFO - Running main action method: populate_webroot 03:38:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:38:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:38:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:38:17 INFO - '--tppagecycles', 03:38:17 INFO - '7'], 03:38:17 INFO - 'tests': ['tsvgm']}}, 03:38:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:38:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:38:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:38:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:38:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:38:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:38:17 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:38:17 INFO - 'talos_options': ['--disable-e10s'], 03:38:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:38:17 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:38:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:38:17 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:38:17 INFO - 'talos_options': ['--disable-e10s'], 03:38:17 INFO - 'tests': ['damp', 'tps']}, 03:38:17 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:38:17 INFO - 'tests': ['damp', 'tps']}, 03:38:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:38:17 INFO - 'tests': ['dromaeo_dom']}, 03:38:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:38:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:38:17 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 03:38:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:38:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:38:17 INFO - 'tests': ['a11yr', 03:38:17 INFO - 'ts_paint', 03:38:17 INFO - 'tpaint', 03:38:17 INFO - 'sessionrestore', 03:38:17 INFO - 'sessionrestore_no_auto_restore', 03:38:17 INFO - 'tabpaint']}, 03:38:17 INFO - 'other-e10s': {'tests': ['a11yr', 03:38:17 INFO - 'ts_paint', 03:38:17 INFO - 'tpaint', 03:38:17 INFO - 'sessionrestore', 03:38:17 INFO - 'sessionrestore_no_auto_restore', 03:38:17 INFO - 'tabpaint']}, 03:38:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:38:17 INFO - 'ts_paint', 03:38:17 INFO - 'tpaint', 03:38:17 INFO - 'sessionrestore', 03:38:17 INFO - 'sessionrestore_no_auto_restore', 03:38:17 INFO - 'tabpaint']}, 03:38:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:38:17 INFO - 'ts_paint', 03:38:17 INFO - 'tpaint', 03:38:17 INFO - 'sessionrestore', 03:38:17 INFO - 'sessionrestore_no_auto_restore', 03:38:17 INFO - 'tabpaint']}, 03:38:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:38:17 INFO - 'tests': ['a11yr', 03:38:17 INFO - 'ts_paint', 03:38:17 INFO - 'tpaint', 03:38:17 INFO - 'sessionrestore', 03:38:17 INFO - 'sessionrestore_no_auto_restore', 03:38:17 INFO - 'tabpaint']}, 03:38:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:38:17 INFO - 'tests': ['a11yr', 03:38:17 INFO - 'ts_paint', 03:38:17 INFO - 'tpaint', 03:38:17 INFO - 'sessionrestore', 03:38:17 INFO - 'sessionrestore_no_auto_restore', 03:38:17 INFO - 'tabpaint']}, 03:38:17 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 03:38:17 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 03:38:17 INFO - 'bloom_basic_ref']}, 03:38:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:38:17 INFO - 'tests': ['tsvgx', 03:38:17 INFO - 'tsvgr_opacity', 03:38:17 INFO - 'tart', 03:38:17 INFO - 'tscrollx', 03:38:17 INFO - 'cart', 03:38:17 INFO - 'tsvg_static']}, 03:38:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:38:17 INFO - 'tsvgr_opacity', 03:38:17 INFO - 'tart', 03:38:17 INFO - 'tscrollx', 03:38:17 INFO - 'cart', 03:38:17 INFO - 'tsvg_static']}, 03:38:17 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:38:17 INFO - 'talos_options': ['--disable-e10s'], 03:38:17 INFO - 'tests': ['tp5o']}, 03:38:17 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:38:17 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:38:17 INFO - 'talos_options': ['--disable-e10s', 03:38:17 INFO - '--xperf_path', 03:38:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:38:17 INFO - 'tests': ['tp5n']}, 03:38:17 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:38:17 INFO - 'talos_options': ['--xperf_path', 03:38:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:38:17 INFO - 'tests': ['tp5n']}}, 03:38:17 INFO - 'talos.zip': {'path': '', 03:38:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:38:17 INFO - Running post-action listener: _resource_record_post_action 03:38:17 INFO - [mozharness: 2017-05-01 10:38:17.508361Z] Finished populate-webroot step (success) 03:38:17 INFO - [mozharness: 2017-05-01 10:38:17.508502Z] Running create-virtualenv step. 03:38:17 INFO - Running pre-action listener: _resource_record_pre_action 03:38:17 INFO - Running main action method: create_virtualenv 03:38:17 INFO - Creating virtualenv /builds/slave/test/build/venv 03:38:17 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:38:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:38:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:38:17 INFO - Using real prefix '/tools/python27' 03:38:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:38:18 INFO - Installing distribute.............................................................................................................................................................................................done. 03:38:21 INFO - Installing pip.................done. 03:38:21 INFO - Return code: 0 03:38:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:38:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:38:21 INFO - Reading from file tmpfile_stdout 03:38:21 INFO - Output received: 03:38:21 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) 03:38:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:38:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:38:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:38:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:21 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 0x10f7b5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7b8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4504b1f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f593d30>, '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 0x10f4b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f588be8>, '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.wyKO0rfjKU/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.XpYtnZXDis/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:38:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:38:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:38:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wyKO0rfjKU/Render', 03:38:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:38:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:38:21 INFO - 'HOME': '/Users/cltbld', 03:38:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:38:21 INFO - 'LOGNAME': 'cltbld', 03:38:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:21 INFO - 'MOZ_NO_REMOTE': '1', 03:38:21 INFO - 'NO_EM_RESTART': '1', 03:38:21 INFO - 'PAGER': '/bin/cat', 03:38:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:38:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:21 INFO - 'PWD': '/builds/slave/test', 03:38:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:38:21 INFO - 'SHELL': '/bin/bash', 03:38:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XpYtnZXDis/Listeners', 03:38:21 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 03:38:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:38:21 INFO - 'USER': 'cltbld', 03:38:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:38:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:38:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:21 INFO - 'XPC_FLAGS': '0x0', 03:38:21 INFO - 'XPC_SERVICE_NAME': '0', 03:38:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:38:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:21 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:38:21 INFO - Cleaning up... 03:38:21 INFO - Return code: 0 03:38:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:38:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:38:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:38:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:21 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 0x10f7b5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7b8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4504b1f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f593d30>, '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 0x10f4b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f588be8>, '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.wyKO0rfjKU/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.XpYtnZXDis/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:38:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:38:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:38:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wyKO0rfjKU/Render', 03:38:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:38:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:38:21 INFO - 'HOME': '/Users/cltbld', 03:38:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:38:21 INFO - 'LOGNAME': 'cltbld', 03:38:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:21 INFO - 'MOZ_NO_REMOTE': '1', 03:38:21 INFO - 'NO_EM_RESTART': '1', 03:38:21 INFO - 'PAGER': '/bin/cat', 03:38:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:38:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:21 INFO - 'PWD': '/builds/slave/test', 03:38:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:38:21 INFO - 'SHELL': '/bin/bash', 03:38:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XpYtnZXDis/Listeners', 03:38:21 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 03:38:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:38:21 INFO - 'USER': 'cltbld', 03:38:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:38:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:38:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:21 INFO - 'XPC_FLAGS': '0x0', 03:38:21 INFO - 'XPC_SERVICE_NAME': '0', 03:38:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:38:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:22 INFO - Downloading/unpacking psutil>=3.1.1 03:38:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:38:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:38:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:38:25 INFO - Installing collected packages: psutil 03:38:25 INFO - Running setup.py install for psutil 03:38:25 INFO - building 'psutil._psutil_osx' extension 03:38:25 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 03:38:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 03:38:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 03:38:26 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 03:38:26 INFO - building 'psutil._psutil_posix' extension 03:38:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 03:38:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:38:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:38:26 INFO - ^ 03:38:26 INFO - 1 warning generated. 03:38:26 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 03:38:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:38:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:38:26 INFO - Successfully installed psutil 03:38:26 INFO - Cleaning up... 03:38:26 INFO - Return code: 0 03:38:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:38:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:38:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:38:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f7b5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7b8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4504b1f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f593d30>, '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 0x10f4b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f588be8>, '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.wyKO0rfjKU/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.XpYtnZXDis/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:38:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:38:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:38:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wyKO0rfjKU/Render', 03:38:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:38:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:38:26 INFO - 'HOME': '/Users/cltbld', 03:38:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:38:26 INFO - 'LOGNAME': 'cltbld', 03:38:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:26 INFO - 'MOZ_NO_REMOTE': '1', 03:38:26 INFO - 'NO_EM_RESTART': '1', 03:38:26 INFO - 'PAGER': '/bin/cat', 03:38:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:38:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:26 INFO - 'PWD': '/builds/slave/test', 03:38:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:38:26 INFO - 'SHELL': '/bin/bash', 03:38:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XpYtnZXDis/Listeners', 03:38:26 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 03:38:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:38:26 INFO - 'USER': 'cltbld', 03:38:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:38:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:38:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:26 INFO - 'XPC_FLAGS': '0x0', 03:38:26 INFO - 'XPC_SERVICE_NAME': '0', 03:38:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:38:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:38:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:38:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:38:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:38:29 INFO - Installing collected packages: mozsystemmonitor 03:38:29 INFO - Running setup.py install for mozsystemmonitor 03:38:29 INFO - Successfully installed mozsystemmonitor 03:38:29 INFO - Cleaning up... 03:38:29 INFO - Return code: 0 03:38:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:38:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:38:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:38:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:29 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 0x10f7b5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7b8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4504b1f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f593d30>, '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 0x10f4b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f588be8>, '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.wyKO0rfjKU/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.XpYtnZXDis/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:38:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:38:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:38:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wyKO0rfjKU/Render', 03:38:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:38:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:38:29 INFO - 'HOME': '/Users/cltbld', 03:38:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:38:29 INFO - 'LOGNAME': 'cltbld', 03:38:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:29 INFO - 'MOZ_NO_REMOTE': '1', 03:38:29 INFO - 'NO_EM_RESTART': '1', 03:38:29 INFO - 'PAGER': '/bin/cat', 03:38:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:38:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:29 INFO - 'PWD': '/builds/slave/test', 03:38:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:38:29 INFO - 'SHELL': '/bin/bash', 03:38:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XpYtnZXDis/Listeners', 03:38:29 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 03:38:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:38:29 INFO - 'USER': 'cltbld', 03:38:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:38:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:38:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:29 INFO - 'XPC_FLAGS': '0x0', 03:38:29 INFO - 'XPC_SERVICE_NAME': '0', 03:38:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:38:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:30 INFO - Downloading/unpacking jsonschema==2.5.1 03:38:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:38:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:38:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:32 INFO - Downloading functools32-3.2.3-2.tar.gz 03:38:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:38:33 INFO - warning: no files found matching '*.txt' 03:38:33 INFO - no previously-included directories found matching 'build' 03:38:33 INFO - no previously-included directories found matching 'dist' 03:38:33 INFO - no previously-included directories found matching '.git*' 03:38:33 INFO - Installing collected packages: jsonschema, functools32 03:38:33 INFO - Running setup.py install for functools32 03:38:33 INFO - warning: no files found matching '*.txt' 03:38:33 INFO - no previously-included directories found matching 'build' 03:38:33 INFO - no previously-included directories found matching 'dist' 03:38:33 INFO - no previously-included directories found matching '.git*' 03:38:33 INFO - Successfully installed jsonschema functools32 03:38:33 INFO - Cleaning up... 03:38:33 INFO - Return code: 0 03:38:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:38:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:38:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:38:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:33 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 0x10f7b5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7b8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4504b1f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f593d30>, '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 0x10f4b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f588be8>, '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.wyKO0rfjKU/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.XpYtnZXDis/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:38:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:38:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:38:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wyKO0rfjKU/Render', 03:38:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:38:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:38:33 INFO - 'HOME': '/Users/cltbld', 03:38:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:38:33 INFO - 'LOGNAME': 'cltbld', 03:38:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:33 INFO - 'MOZ_NO_REMOTE': '1', 03:38:33 INFO - 'NO_EM_RESTART': '1', 03:38:33 INFO - 'PAGER': '/bin/cat', 03:38:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:38:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:33 INFO - 'PWD': '/builds/slave/test', 03:38:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:38:33 INFO - 'SHELL': '/bin/bash', 03:38:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XpYtnZXDis/Listeners', 03:38:33 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 03:38:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:38:33 INFO - 'USER': 'cltbld', 03:38:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:38:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:38:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:33 INFO - 'XPC_FLAGS': '0x0', 03:38:33 INFO - 'XPC_SERVICE_NAME': '0', 03:38:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:38:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:38:33 INFO - Cleaning up... 03:38:33 INFO - Return code: 0 03:38:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:38:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:38:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:38:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:33 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 0x10f7b5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7b8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4504b1f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f593d30>, '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 0x10f4b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f588be8>, '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.wyKO0rfjKU/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.XpYtnZXDis/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:38:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:38:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:38:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wyKO0rfjKU/Render', 03:38:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:38:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:38:33 INFO - 'HOME': '/Users/cltbld', 03:38:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:38:33 INFO - 'LOGNAME': 'cltbld', 03:38:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:33 INFO - 'MOZ_NO_REMOTE': '1', 03:38:33 INFO - 'NO_EM_RESTART': '1', 03:38:33 INFO - 'PAGER': '/bin/cat', 03:38:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:38:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:33 INFO - 'PWD': '/builds/slave/test', 03:38:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:38:33 INFO - 'SHELL': '/bin/bash', 03:38:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XpYtnZXDis/Listeners', 03:38:33 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 03:38:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:38:33 INFO - 'USER': 'cltbld', 03:38:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:38:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:38:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:33 INFO - 'XPC_FLAGS': '0x0', 03:38:33 INFO - 'XPC_SERVICE_NAME': '0', 03:38:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:38:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:33 INFO - Downloading/unpacking blobuploader==1.2.4 03:38:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:36 INFO - Downloading blobuploader-1.2.4.tar.gz 03:38:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:38:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:38: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 03:38: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 03:38: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 03:38: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 03:38: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 03:38: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 03:38:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:38:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:38:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:37 INFO - Downloading docopt-0.6.1.tar.gz 03:38:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:38:37 INFO - Installing collected packages: blobuploader, requests, docopt 03:38:37 INFO - Running setup.py install for blobuploader 03:38:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:38:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:38:38 INFO - Running setup.py install for requests 03:38:38 INFO - Running setup.py install for docopt 03:38:38 INFO - Successfully installed blobuploader requests docopt 03:38:38 INFO - Cleaning up... 03:38:38 INFO - Return code: 0 03:38:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:38:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:38:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:38:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:38 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 0x10f7b5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7b8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4504b1f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f593d30>, '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 0x10f4b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f588be8>, '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.wyKO0rfjKU/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.XpYtnZXDis/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:38:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:38:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:38:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wyKO0rfjKU/Render', 03:38:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:38:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:38:38 INFO - 'HOME': '/Users/cltbld', 03:38:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:38:38 INFO - 'LOGNAME': 'cltbld', 03:38:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:38 INFO - 'MOZ_NO_REMOTE': '1', 03:38:38 INFO - 'NO_EM_RESTART': '1', 03:38:38 INFO - 'PAGER': '/bin/cat', 03:38:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:38:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:38 INFO - 'PWD': '/builds/slave/test', 03:38:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:38:38 INFO - 'SHELL': '/bin/bash', 03:38:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XpYtnZXDis/Listeners', 03:38:38 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 03:38:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:38:38 INFO - 'USER': 'cltbld', 03:38:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:38:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:38:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:38 INFO - 'XPC_FLAGS': '0x0', 03:38:38 INFO - 'XPC_SERVICE_NAME': '0', 03:38:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:38:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:38:39 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-mUK0Xc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:38:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:38:39 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-6OsDAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:38:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:38:39 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-a2T3eW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:38:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:38:39 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-oyxhTm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:38:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:38:39 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-t4gKbP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:38:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:38:39 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-9bqu0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:38:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:38:39 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-Uub9y3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:38:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:38:39 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-egMeqh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:38:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:38:39 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-tmINKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:38:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:38:40 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-qWpgIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:38:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:38:40 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-cz7TY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:38:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:38:40 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-0XIQkC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:38:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:38:40 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-1o9D7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:38:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:38:40 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-Taui07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:38:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:38:40 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-51l_fm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:38:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:38:40 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-9KqnNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:38:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:38:40 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-jQm_1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:38:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:38:40 INFO - Running setup.py install for manifestparser 03:38:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:38:41 INFO - Running setup.py install for mozcrash 03:38:41 INFO - Running setup.py install for mozdebug 03:38:41 INFO - Running setup.py install for mozdevice 03:38:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:38:41 INFO - Running setup.py install for mozfile 03:38:41 INFO - Running setup.py install for mozhttpd 03:38:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:38:41 INFO - Running setup.py install for mozinfo 03:38:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:38:41 INFO - Running setup.py install for mozInstall 03:38:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:38:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:38:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:38:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:38:42 INFO - Running setup.py install for mozleak 03:38:42 INFO - Running setup.py install for mozlog 03:38:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:38:42 INFO - Running setup.py install for moznetwork 03:38:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:38:42 INFO - Running setup.py install for mozprocess 03:38:42 INFO - Running setup.py install for mozprofile 03:38:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:38:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:38:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:38:42 INFO - Running setup.py install for mozrunner 03:38:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:38:43 INFO - Running setup.py install for mozscreenshot 03:38:43 INFO - Running setup.py install for moztest 03:38:43 INFO - Running setup.py install for mozversion 03:38:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:38:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:38:43 INFO - Cleaning up... 03:38:43 INFO - Return code: 0 03:38:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:38: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')]} 03:38:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38: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')]} 03:38:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:43 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 0x10f7b5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7b8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4504b1f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f593d30>, '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 0x10f4b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f588be8>, '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.wyKO0rfjKU/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.XpYtnZXDis/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:38:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:38:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:38:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wyKO0rfjKU/Render', 03:38:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:38:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:38:43 INFO - 'HOME': '/Users/cltbld', 03:38:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:38:43 INFO - 'LOGNAME': 'cltbld', 03:38:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:43 INFO - 'MOZ_NO_REMOTE': '1', 03:38:43 INFO - 'NO_EM_RESTART': '1', 03:38:43 INFO - 'PAGER': '/bin/cat', 03:38:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:38:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:43 INFO - 'PWD': '/builds/slave/test', 03:38:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:38:43 INFO - 'SHELL': '/bin/bash', 03:38:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XpYtnZXDis/Listeners', 03:38:43 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 03:38:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:38:43 INFO - 'USER': 'cltbld', 03:38:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:38:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:38:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:43 INFO - 'XPC_FLAGS': '0x0', 03:38:43 INFO - 'XPC_SERVICE_NAME': '0', 03:38:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:38:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:38:43 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-E1nrD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:38:43 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:38:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:38:43 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-_u6qHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:38:43 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)) 03:38:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:38:43 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-7vBoE9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:38:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:38:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:38:44 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-TZoHhZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:38:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:38:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:38:44 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-JONN2v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:38:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:38:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:38:44 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-T64qmU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:38:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:38:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:38:44 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-vuSFrh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:38:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:38:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:38:44 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-GDcTMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:38:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:38:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:38:44 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-PkmPqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:38:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:38:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:38:44 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-GuwZJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:38:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:38:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:38:44 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-xPds4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:38:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:38:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:38:44 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-608L8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:38:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:38:45 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-Ia9QUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:38:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:38:45 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-2aQhA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:38:45 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)) 03:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:38:45 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-xVsB22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:38:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:38:45 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-aYKCmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:38:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:38:45 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-BNGA2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:38:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:38:45 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)) 03:38:45 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)) 03:38:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:38:45 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:38:45 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:38:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:38:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:48 INFO - Downloading blessings-1.6.tar.gz 03:38:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:38:48 INFO - Installing collected packages: blessings 03:38:48 INFO - Running setup.py install for blessings 03:38:48 INFO - Successfully installed blessings 03:38:48 INFO - Cleaning up... 03:38:48 INFO - Return code: 0 03:38:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:38:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:38:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:38:48 INFO - Reading from file tmpfile_stdout 03:38:48 INFO - Current package versions: 03:38:48 INFO - blessings == 1.6 03:38:48 INFO - blobuploader == 1.2.4 03:38:48 INFO - docopt == 0.6.1 03:38:48 INFO - functools32 == 3.2.3-2 03:38:48 INFO - jsonschema == 2.5.1 03:38:48 INFO - manifestparser == 1.1 03:38:48 INFO - mozInstall == 1.12 03:38:48 INFO - mozcrash == 1.0 03:38:48 INFO - mozdebug == 0.1 03:38:48 INFO - mozdevice == 0.50 03:38:48 INFO - mozfile == 1.2 03:38:48 INFO - mozhttpd == 0.7 03:38:48 INFO - mozinfo == 0.9 03:38:48 INFO - mozleak == 0.1 03:38:48 INFO - mozlog == 3.4 03:38:48 INFO - moznetwork == 0.27 03:38:48 INFO - mozprocess == 0.25 03:38:48 INFO - mozprofile == 0.28 03:38:48 INFO - mozrunner == 6.13 03:38:48 INFO - mozscreenshot == 0.1 03:38:48 INFO - mozsystemmonitor == 0.3 03:38:48 INFO - moztest == 0.8 03:38:48 INFO - mozversion == 1.4 03:38:48 INFO - psutil == 3.1.1 03:38:48 INFO - requests == 1.2.3 03:38:48 INFO - wsgiref == 0.1.2 03:38:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:38:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:38:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:38:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:48 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 0x10f7b5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7b8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4504b1f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f593d30>, '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 0x10f4b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f588be8>, '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.wyKO0rfjKU/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.XpYtnZXDis/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:38:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:38:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:38:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wyKO0rfjKU/Render', 03:38:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:38:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:38:48 INFO - 'HOME': '/Users/cltbld', 03:38:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:38:48 INFO - 'LOGNAME': 'cltbld', 03:38:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:48 INFO - 'MOZ_NO_REMOTE': '1', 03:38:48 INFO - 'NO_EM_RESTART': '1', 03:38:48 INFO - 'PAGER': '/bin/cat', 03:38:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:38:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:48 INFO - 'PWD': '/builds/slave/test', 03:38:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:38:48 INFO - 'SHELL': '/bin/bash', 03:38:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XpYtnZXDis/Listeners', 03:38:48 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 03:38:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:38:48 INFO - 'USER': 'cltbld', 03:38:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:38:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:38:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:48 INFO - 'XPC_FLAGS': '0x0', 03:38:48 INFO - 'XPC_SERVICE_NAME': '0', 03:38:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:38:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:38:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:38:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:38:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:38:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:38:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:38:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:38:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:38:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:38:49 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:38:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:38:49 INFO - Cleaning up... 03:38:49 INFO - Return code: 0 03:38:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:38:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:38:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:38:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:49 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 0x10f7b5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7b8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4504b1f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f593d30>, '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 0x10f4b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f588be8>, '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.wyKO0rfjKU/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.XpYtnZXDis/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:38:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:38:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:38:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wyKO0rfjKU/Render', 03:38:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:38:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:38:49 INFO - 'HOME': '/Users/cltbld', 03:38:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:38:49 INFO - 'LOGNAME': 'cltbld', 03:38:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:49 INFO - 'MOZ_NO_REMOTE': '1', 03:38:49 INFO - 'NO_EM_RESTART': '1', 03:38:49 INFO - 'PAGER': '/bin/cat', 03:38:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:38:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:49 INFO - 'PWD': '/builds/slave/test', 03:38:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:38:49 INFO - 'SHELL': '/bin/bash', 03:38:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XpYtnZXDis/Listeners', 03:38:49 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 03:38:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:38:49 INFO - 'USER': 'cltbld', 03:38:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:38:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:38:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:49 INFO - 'XPC_FLAGS': '0x0', 03:38:49 INFO - 'XPC_SERVICE_NAME': '0', 03:38:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:38:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:38:49 INFO - Cleaning up... 03:38:49 INFO - Return code: 0 03:38:49 INFO - Running post-action listener: _resource_record_post_action 03:38:49 INFO - Running post-action listener: _start_resource_monitoring 03:38:49 INFO - Starting resource monitoring. 03:38:49 INFO - [mozharness: 2017-05-01 10:38:49.397608Z] Finished create-virtualenv step (success) 03:38:49 INFO - [mozharness: 2017-05-01 10:38:49.398595Z] Running install step. 03:38:49 INFO - Running pre-action listener: _resource_record_pre_action 03:38:49 INFO - Running main action method: install 03:38:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:38:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:38:49 INFO - Reading from file tmpfile_stdout 03:38:49 INFO - Detecting whether we're running mozinstall >=1.0... 03:38:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:38:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:38:49 INFO - Reading from file tmpfile_stdout 03:38:49 INFO - Output received: 03:38:49 INFO - Usage: mozinstall [options] installer 03:38:49 INFO - Options: 03:38:49 INFO - -h, --help show this help message and exit 03:38:49 INFO - -d DEST, --destination=DEST 03:38:49 INFO - Directory to install application into. [default: 03:38:49 INFO - "/builds/slave/test"] 03:38:49 INFO - --app=APP Application being installed. [default: firefox] 03:38:49 INFO - mkdir: /builds/slave/test/build/application 03:38:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:38:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 03:39:09 INFO - Reading from file tmpfile_stdout 03:39:09 INFO - Output received: 03:39:09 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:39:09 INFO - Running post-action listener: _resource_record_post_action 03:39:09 INFO - [mozharness: 2017-05-01 10:39:09.861278Z] Finished install step (success) 03:39:09 INFO - [mozharness: 2017-05-01 10:39:09.861414Z] Running run-tests step. 03:39:09 INFO - Running pre-action listener: _resource_record_pre_action 03:39:09 INFO - Running main action method: run_tests 03:39:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:39:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:39:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:39:09 INFO - 2017-05-01 03:39:09.876 screenresolution[2506:37770] starting screenresolution argv=screenresolution get 03:39:09 INFO - 2017-05-01 03:39:09.879 screenresolution[2506:37770] Display 0: 1600x1200x32@60 03:39:09 INFO - 2017-05-01 03:39:09.884 screenresolution[2507:37773] starting screenresolution argv=screenresolution list 03:39:09 INFO - Available Modes on Display 0 03:39:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:39:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:39:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:39:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:39:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:39:10 INFO - Intel Iris: 03:39:10 INFO - Chipset Model: Intel Iris 03:39:10 INFO - Type: GPU 03:39:10 INFO - Bus: Built-In 03:39:10 INFO - VRAM (Dynamic, Max): 1536 MB 03:39:10 INFO - Vendor: Intel (0x8086) 03:39:10 INFO - Device ID: 0x0a2e 03:39:10 INFO - Revision ID: 0x0009 03:39:10 INFO - Displays: 03:39:10 INFO - Display: 03:39:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:39:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:39:10 INFO - Display Serial Number: 1600x1200 60 03:39:10 INFO - Main Display: Yes 03:39:10 INFO - Mirror: Off 03:39:10 INFO - Online: Yes 03:39:10 INFO - Rotation: Supported 03:39:10 INFO - Return code: 0 03:39:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:39:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:39:10 INFO - Python 2.7.3 03:39:10 INFO - Return code: 0 03:39:10 INFO - grabbing minidump binary from tooltool 03:39: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')]} 03:39:10 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 0x10f593d30>, '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 0x10f4b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f588be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:39:10 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:39:10 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 03:39:10 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:39:10 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:39:10 INFO - Return code: 0 03:39:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:39:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:39:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:39:10 INFO - ENV: RUST_BACKTRACE is now 1 03:39:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:39:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:39:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SFhZjpPLToGWLkXAhCWKyw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0242', '--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 03:39:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SFhZjpPLToGWLkXAhCWKyw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0242 --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 03:39:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wyKO0rfjKU/Render', 03:39:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:39:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:39:10 INFO - 'HOME': '/Users/cltbld', 03:39:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:39:10 INFO - 'LOGNAME': 'cltbld', 03:39:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:39:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:39:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:10 INFO - 'MOZ_NO_REMOTE': '1', 03:39:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:39:10 INFO - 'NO_EM_RESTART': '1', 03:39:10 INFO - 'PAGER': '/bin/cat', 03:39:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:39:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:10 INFO - 'PWD': '/builds/slave/test', 03:39:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:39:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:39:10 INFO - 'RUST_BACKTRACE': '1', 03:39:10 INFO - 'SHELL': '/bin/bash', 03:39:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XpYtnZXDis/Listeners', 03:39:10 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 03:39:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:39:10 INFO - 'USER': 'cltbld', 03:39:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:39:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:39:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:10 INFO - 'XPC_FLAGS': '0x0', 03:39:10 INFO - 'XPC_SERVICE_NAME': '0', 03:39:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:39:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SFhZjpPLToGWLkXAhCWKyw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0242', '--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 03:39:10 INFO - mozversion application_buildid: 20170501022117 03:39:10 INFO - mozversion application_changeset: de63010ad9d6877979587327e4b63038a561dfc5 03:39:10 INFO - mozversion application_display_name: Nightly 03:39:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:39:10 INFO - mozversion application_name: Firefox 03:39:10 INFO - mozversion application_remotingname: firefox 03:39:10 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:39:10 INFO - mozversion application_vendor: Mozilla 03:39:10 INFO - mozversion application_version: 55.0a1 03:39:10 INFO - mozversion platform_buildid: 20170501022117 03:39:10 INFO - mozversion platform_changeset: de63010ad9d6877979587327e4b63038a561dfc5 03:39:10 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:39:10 INFO - mozversion platform_version: 55.0a1 03:39:10 INFO - using testdate: 1493635150 03:39:10 INFO - actual date: 1493635150 03:39:10 INFO - starting webserver on 'localhost:56646' 03:39:10 INFO - SUITE-START | Running 2 tests 03:39:10 INFO - TEST-START | dromaeo_css 03:39:10 INFO - operating with platform_type : mac_ 03:39:10 INFO - Initialising browser for dromaeo_css test... 03:39:10 INFO - TEST-INFO | started process 2517 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/tmpM_id3p/profile http://localhost:56646/getInfo.html) 03:39:13 INFO - PID 2517 | 2017-05-01 03:39:13.276 plugin-container[2519:37947] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4a57, name = 'com.apple.tsm.portname' 03:39:13 INFO - PID 2517 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:39:13 INFO - PID 2517 | 2017-05-01 03:39:13.279 plugin-container[2519:37947] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9e0f, name = 'com.apple.CFPasteboardClient' 03:39:13 INFO - PID 2517 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:39:13 INFO - PID 2517 | 2017-05-01 03:39:13.279 plugin-container[2519:37947] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:39:13 INFO - PID 2517 | __metrics Screen width/height:1600/1200 03:39:13 INFO - PID 2517 | colorDepth:24 03:39:13 INFO - PID 2517 | Browser inner width/height: 1024/689 03:39:13 INFO - PID 2517 | __metrics 03:39:14 INFO - TEST-INFO | 2517: exit 0 03:39:14 INFO - Browser initialized. 03:39:14 INFO - Running cycle 1/1 for dromaeo_css test... 03:39:14 INFO - TEST-INFO | started process 2520 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/tmpM_id3p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:39:16 INFO - PID 2520 | 2017-05-01 03:39:16.895 plugin-container[2521:38078] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4447, name = 'com.apple.tsm.portname' 03:39:16 INFO - PID 2520 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:39:16 INFO - PID 2520 | 2017-05-01 03:39:16.896 plugin-container[2521:38078] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9b0b, name = 'com.apple.CFPasteboardClient' 03:39:16 INFO - PID 2520 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:39:16 INFO - PID 2520 | 2017-05-01 03:39:16.896 plugin-container[2521:38078] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:39:26 INFO - PID 2520 | RSS: Main: 235020288 03:39:26 INFO - PID 2520 | 03:42:31 INFO - PID 2520 | Cycle 1(1): loaded http://localhost:56646/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56646/tests/dromaeo/cssquery-ext.html) 03:42:33 INFO - PID 2520 | RSS: Main: 251412480 03:42:33 INFO - PID 2520 | 03:44:14 INFO - PID 2520 | ************************* 03:44:14 INFO - PID 2520 | A coding exception was thrown and uncaught in a Task. 03:44:14 INFO - PID 2520 | 03:44:14 ERROR - PID 2520 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:44:14 INFO - PID 2520 | Full stack: 03:44:14 INFO - PID 2520 | ************************* 03:44:14 INFO - PID 2520 | ************************* 03:44:14 INFO - PID 2520 | A coding exception was thrown and uncaught in a Task. 03:44:14 INFO - PID 2520 | 03:44:14 ERROR - PID 2520 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:44:14 INFO - PID 2520 | Full stack: 03:44:14 INFO - PID 2520 | ************************* 03:44:14 INFO - PID 2520 | ************************* 03:44:14 INFO - PID 2520 | A coding exception was thrown and uncaught in a Task. 03:44:14 INFO - PID 2520 | 03:44:14 ERROR - PID 2520 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:44:14 INFO - PID 2520 | Full stack: 03:44:14 INFO - PID 2520 | ************************* 03:44:14 INFO - PID 2520 | ************************* 03:44:14 INFO - PID 2520 | A coding exception was thrown and uncaught in a Task. 03:44:14 INFO - PID 2520 | 03:44:14 ERROR - PID 2520 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:44:14 INFO - PID 2520 | Full stack: 03:44:14 INFO - PID 2520 | ************************* 03:45:35 INFO - PID 2520 | Cycle 1(1): loaded http://localhost:56646/tests/dromaeo/cssquery-ext.html (next: http://localhost:56646/tests/dromaeo/cssquery-jquery.html) 03:45:35 INFO - PID 2520 | RSS: Main: 256868352 03:45:35 INFO - PID 2520 | 03:48:37 INFO - PID 2520 | Cycle 1(1): loaded http://localhost:56646/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56646/tests/dromaeo/cssquery-mootools.html) 03:48:38 INFO - PID 2520 | RSS: Main: 267476992 03:48:38 INFO - PID 2520 | 03:51:39 INFO - PID 2520 | Cycle 1(1): loaded http://localhost:56646/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56646/tests/dromaeo/cssquery-prototype.html) 03:51:40 INFO - PID 2520 | RSS: Main: 259919872 03:51:40 INFO - PID 2520 | 03:54:43 INFO - PID 2520 | Cycle 1(1): loaded http://localhost:56646/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56646/tests/dromaeo/cssquery-yui.html) 03:54:44 INFO - PID 2520 | RSS: Main: 269131776 03:54:44 INFO - PID 2520 | 03:57:45 INFO - PID 2520 | Cycle 1(1): loaded http://localhost:56646/tests/dromaeo/cssquery-yui.html (next: http://localhost:56646/tests/dromaeo/cssquery-dojo.html) 03:57:46 INFO - PID 2520 | RSS: Main: 263757824 03:57:46 INFO - PID 2520 | 03:57:46 INFO - PID 2520 | __start_tp_report 03:57:46 INFO - PID 2520 | _x_x_mozilla_page_load 03:57:46 INFO - PID 2520 | _x_x_mozilla_page_load_details 03:57:46 INFO - PID 2520 | |i|pagename|runs| 03:57:46 INFO - PID 2520 | |0;dojo.html;3072.278014666553;3643.1620727232735;3648.3068217038776;3690.907727306817;3696.815159242039;6134.202553668017;6242.500599952004;6274.152989346442;6274.372562743723;6314.368563143684;6161.537884658657;6177.444030037295;6203.813885583429;6257.061440783885;6318.715657795398;5472.315960504917;5488.423715509874;5508.476694714006;5522.144067669517;5526.972365138168;5538.169274608821;5605.215269862202;5614.494695477406;5663.886722265553;5669.262995810539;5305.575553955713;5525.364583072957;5536.975659503005;5573.8606534836545;5633.15502674598;5458.5087342139395;5490.3960564338295;5515.834524964257;5553.444655534455;5574.136008918624;5445.50990410861;5458.235846981386;5482.5888058395385;5500.4499550045075;5510.421405752379;5036.219385995177;6006.609570377911;6272.3100458949475;6275.341089185661;6298.149749783766;6452.612843229421;6539.411452969255;6650.9667451662435;6724.327567243286;6727.966360168217;6866.896996545006;6872.41584465321;6880.483963702743;6881.827954301132;6885.1049363582915;6268.905966410507;6334.556581039329;6369.9681501592195;6372.490200783926;6382.329855365213;5663.518600918968;6703.128593282842;6809.250982391933;6936.063631409796;6967.581945083311;6396.1045453636525;6463.418292353711;6562;6618.172728408949;6698.63157526331;6723.159605049369;6823.078884350648;6840.657967101724;6844.965775171092;6864.553804002824;6709.832254193587;6712.697928593225;6715.56348837324;6724.226713927863;6726.125603671491;5521.861953451196;6463.48292136628;6590.670466476657;6718.630475323806;6727.764528241488;5342.065138600729;5365.463453654604;5375.7849686012905;5406.053940560386;5438.102713052381;4785.3300537924715;4787.808487660454;4790.592799612003;4798.976005120022;4850.708957462563;5734.369219385864;6297.433231009231;6321.273053598803;6359.872802543923;6367.076773867763;6659.234188068434;6690.464762818963;6766.289539598271;6777.288384719632;6815.454763618998;6347.079673447324;6348.809535713936;6357.268914074848;6363.5863668861375;6370.936290637034;5937.139114828326;5964.343922168558;6043.3050199227655;6044.214252147281;6110.602810817371;5621.943780562142;6895;6899.241083480712;6933.757318493828;7097.9290207097265;6801.557898736566;6831.4876384272375;6862.039314495874;6866.141732283465;6881.827954301182;6977.686004129928;7026.19198792125;7055.082839231072;7057.7176912922905;7078.681459334445;6499.5775274607;6711.899321510279;6738.966305168443;6746.69639866217;6778;6662.167229096363;6732.461403087839;6766.289539598468;6785.38931496148;6825.249222585611;6345.3654634538025;6423.646699431576;6475.805725828232;6645;6651.06885036105;6619.470442364695;6641.136652235178;6651.102101216274;6657.900131497934;6675.566088204251;5111.284420181252;5919.727258639413;6169.290531588746;6527.3472652734345;6534.673266336569;6447.194100737408;6575.178102737158;6582.506312026713;6593.901091483535;6599.505037122139;5814.854628634318;6047.879042419039;6442.871142577029;6453.386928241809;6476.935230647633 03:57:46 INFO - PID 2520 | |1;ext.html;745.4818900863902;807.2936180841764;826.7147833997269;1202.9157958942878;1273.8853503184712;36592.634073659254;37701.245975080485;37740.43389349159;37768.43347349792;37836.62163378369;37745.811270943675;38056;38152.427713584315;38157.42763858545;38181.80909095458;7835.529868207912;7998.12020677725;8286.875696864552;8525.95737021314;8536.615852286663;8082.474639148466;8599.61301741423;8603.225709686127;8604.698835540757;8634.870476942819;7564.470487065908;8368.661014237723;8552;8631.309495240366;8648.870266946002;8508.319334453228;8553.690503564003;8605.139486051406;8609.956950215272;8612.39713220075;8399.202075802788;8431.156884311582;8499.61751721174;8508.617112229964;8511.404201705884;37497;37557;37588;37778.24443511114;37838.81080594607;3674.1182116292166;3705.925281668313;3714.257148570297;3715.498407714978;3724.4971928789537;30693.539596906063;30772;30784.38431231363;30862.074137775904;30940;3105.316830297331;3162.920926976844;3164.4145833020734;3167.255694911694;3178.2213357727273;291550;298949.5052524745;301156;304610;306185;47396.5260347399;47775;47781.805454863905;47840;47906.76046619745;41764.74705758832;50343.24485132726;50360.496395036316;54943.725281374136;55068.17397739037;11759.529618815151;14264.072835265883;14287.857121428653;14412.495562655256;14417.351219195161;8446.535440550706;10839.241253112206;10947.905209478988;11225.550977960953;11557.017653499546;12462.875371246353;13950.930245348709;14034.228117453638;14079.296035198198;14186.432542698176;5186.910748742806;6197.690115494297;6218.875622487525;6260.843478913063;6279.246490421178;984.945827979468;993.438707130469;999.9150072243941;1020.9438480883623;1034.0848349211003;23970.280891573282;24134.75865241325;24291.878540607184;24393.512129757306;24421.38946526351;1089.5042755546208;1095.1403148528368;1122.4612186150694;1130.3669944830922;1132.388510204497;10474.74303083635;11638.592649257405;12234.632961011184;12430.875691242973;12433.93783031079;319954;320098;322469;322930;329341;54381.728091360084;54587.18119228215;54650.45349546533;54761;55106;1516.2343016776458;1548.202675622033;1580.2651766928434;1580.936762529486;1584.7702083198103;17622.647547049244;23729.52540949137;23777;23826.88086559556;23997;37770.81114594409;37775.05562360963;37848;37903.24193516169;37974.810125949196;280000;281027;281931;283006;283710;34999;35158.29683406369;35263.94208173759;35563.97706195003;35564;43068.35397468978;43573.56426435822;44914;44983.875403115184;45077;24373.75626243786;29601.5559766608;30045.647945842928;30510.84744576263;30826.53760193554;30046.948356807407;30390;30773.538396924512;30829.845850770602;30860.84569577138;36536.45195322019;36957.89126326214;37059;37084.25831483409;37109.25781484301;29649.25876853096;30715;30797.8460107698;31300.373992519566;31715.048548543582;24023.877140533135;24063.879680601483;24160.033598655857;24413.023479060637;24555.50888982246 03:57:46 INFO - PID 2520 | |2;jquery.html;371.84196716395536;420.5311078147866;423.31423094586756;427.2139263754691;452.9853128991061;21488.92555372233;21505.81718005511;22226.555468890634;22890.969906354214;23160.652590211117;17897.64204715905;21765.64687062586;21892.45268868275;22179.11283548656;22425.55148897021;5790.449907258803;6759.526833121683;6950.652467376636;6978.581285122884;7004.194517630462;6101.420365065312;6872.72509099638;6916.135483064617;6920.4463642908695;6925.168979722441;6659.933400666004;6838.042674025641;6865.759698410531;6876.7593134240315;6918.584884906922;6801.727930882758;6819.931800681979;6863.107795986515;6900.068490753734;6918.100646915894;6463.83840403989;6751.628660423675;6756.864862702768;6761.966190169018;6789.219239787439;21375.572488550297;27310.04414845471;29572.40855182906;29765.255868603243;29800.701992980008;1840.2822899069374;2333.5566242414056;2333.754955729641;2341.1220792202926;2343.3438637181616;15226.923865380602;17618.559536011573;19188.808111918843;19276.614467710708;19391.80608193914;2182.3125715399756;2253.7182852143483;2301.1255722825385;2306.2389411494332;2346.612808886549;150888;152802.23598881933;155041.44958550384;155187.5849932014;157139;23422.297331080095;24837.62743558848;25093.77456296595;25118;25214.747852521607;41079;41109.76670699884;41110.38334424986;41149.38275925864;41305.96735081647;8855;8911.465312081296;9002.36983411168;9200.033996430413;9232.769180770534;7382.22486638906;8255.844181814551;8494.532800695897;8614.741557753277;8750.956245218733;6822.556533825285;7980.882676425305;8150.75547733569;8211.71259005932;8267.421280510307;2252.9211477598533;2261.592913275626;2266.648669456237;2272.3523795718143;2438.0613463816558;874.8058899601997;881.990121311108;926.2080920812742;955.2692190474154;995;16601.920875143078;21476.355709328745;21659.350219493124;21715;21738.13047478083;891.7012800711705;962.5620342744035;997.1324947295755;1008.2841182760176;1023.7031260934245;9327.813443731087;10213.74465638365;10620.150387969099;11109.388983605817;11194.160437967184;464347;523254;541338;542791;546109;110930;136460.3176984109;137586.31206843903;141236;141444.8783268252;1189.9762004759857;1207.106741011645;1246.1650694035018;1248.9875101249054;1249.568898729955;19043.619127617647;21743.891280543496;21997.780022199575;22040.88979555156;22293.10827566879;55697;59426.70286648539;59440.405595943485;59905.40094598998;60306.69846650738;55601.7219913914;73573.52852942805;75490.11274718176;76320;76986.6150669243;9100.908990910271;9107.863382049141;9120.452772833385;9223.58493867791;9240.336739386976;14692.253475364141;14740.852591473948;14840.035397699115;14890.181040042467;14980.176090315137;11849.052075834084;12059.698507537381;12146.210496317712;12240.450269421768;12434.570024447305;11600.30398176112;11653.65039048796;11670.008049315564;11684.415779211175;11925.344106073902;12301.138920275494;12429.37853107323;12637.368131593199;12693.873061269638;12715.80926286125;8906.59920303575;9146.908530914605;9207.263418926335;9240.168384845396;9389.38968967015;9559.904400955902;10260.846087308548;11996.400179990791;12327.75344493123;12397.070219733376 03:57:46 INFO - PID 2520 | |3;mootools.html;1351.7972304154375;1481.0965311160196;1485.1683057487808;1485.183149267903;1507.4799194277978;10114.44370559619;10410.271281010333;11616.070714342854;11968.341741204242;12162;10205.285630005903;11375.805540418261;11607.419629018537;12003.579874704386;12018.278903265787;2222.1666874921902;2459.5242854287376;2510.2469259222207;2550.1711943618307;2555.603881398377;2079.729635147429;2486.9378265543323;2531.898724051045;2533.7972962162985;2538.796896248305;2106.262808017197;2121.087932189158;2341.0752752662775;2520.2565243253284;2560.590305551112;2469.802415806731;2481.491294284667;2485.6395822605623;2488.50229954009;2488.688913885764;2431.7932975697086;2444.8777561121874;2454.7422520635255;2460.458699086198;2465.976619702821;11823.763524729457;11916.642500724905;12054.216475929037;12059.517619295219;12077.275363478131;6537.869242615121;6774.187097548276;6777.423918966893;6782.898256526156;6785.660716964132;4051.6556092732153;4277.764722940237;4363.105563359503;4411.735295882258;4418.270985287424;1209.6189700244395;1228.2446295528187;1256.7109564800148;1258.106744211611;1297.2864924291696;16646.58383540409;16655.91672041644;16810.83189168117;16877.324907003705;16912.492625221264;5887.882242355129;5957.4042595740075;6111.205543279345;6188.2883468400805;6193.411625895533;13379.799303010463;14057.43770249199;14067.859321406859;14143.929280353737;14160.504382346568;6783.660816959133;6841.657917104125;6846.520743548003;6848.794536163923;6849.897251541231;5411.756470958816;6069.180660610849;6224.657643829632;6280.654563998933;6283;4033.757974521538;4647.767611619473;4799;4844.273358996179;4884.7069175849565;1428.5571472843244;1452.7530319845653;1460.5983354577363;1463.604826696807;1473.8894582906325;746.932776050158;781.0510230070491;820.8891799607096;825.3933358981144;840.1808236968907;5609.49514543693;6737.326267373223;6778.186617605918;6851.417629501549;6978.441724662015;518.2174915876977;594.01097173207;601.1553766957431;603.7766026570197;613.4662843326334;3795.354789685705;3832.1760821423527;3931.6068393161027;3941.7832019239218;3978.124812541236;13565.186088834504;13836.446542138201;14102.788458173136;14167.574972750834;14171;13892.513762018281;13968.930155349159;14181;14273.072250303698;14283.928580357031;7649.923500765032;8293.087760346478;8325.875111873327;8352.0812710603;8360.080391156967;5706.942930570641;6302.212223472066;6498.252700939453;6519.771807986698;6554.770583029762;11039.613613523488;12125.726798686012;12498.000159986997;12667.746645067231;12763.170393924365;12739.808902866649;12844.743105138032;12995.28525931083;13026.674333141369;13241.867581324064;7438.628068596657;7917.524948503108;8844.336674749291;9117.954410227907;9194.49430281341;11233.55065797359;11322.811104834203;11337.546498140311;11372.260803047775;11383.203175777617;9082.954585227297;9376.57805398745;9398.859017114612;9403.952980235055;9536.189423899046;7462.850742985219;9174.449533028039;9207.079292070739;9235.492047937429;9397.248220142235;8149.79625509367;8258.091609922783;8356.289715374262;8357.95821020891;8364.330853531825;6005.207687538747;6028.246469191351;6086.269647642312;6219.689015549114;6256.937430625636;6028.457438830526;6137.60105593135;6183.938160618336;6261.499080073674;6340.239171299474 03:57:46 INFO - PID 2520 | |4;prototype.html;380.9085819403342;399.516584932232;403.7315185401708;406.7127541331685;406.9918601627967;5207.401148867882;5341.278927344807;6071.635701857892;6309.936900630993;6386.6806659666945;5088.592912566995;5263.86840328992;5665.093585026397;5989.760409583622;6249.4687951524065;4398.582134697199;4556.9746806968415;4756.595689366391;4757.215059515193;4770.112358427888;4689.249720044793;4720.90558188836;4773.236282194849;4775.832845850396;4777.283407488887;3519.5248641433336;4176.477940257468;4273.529911709709;4652.022890271638;4742.881427964311;4065.573114822945;4465.285554311295;4539.205639013176;4732.716037037789;4775.14047471455;4173.807150468214;4177.9346266702105;4184.372344148372;4237.258479766028;4247.405363249148;5602.271704678406;5826.8928903508195;6084.5436592255755;6087.360827113178;6116;5665.773369065232;5684.772609095631;5686.147077938301;5695.14572814077;5729.828105156852;5175.689458632456;5374.656335916021;5873.709253391181;6440.645764482952;6786.491013174032;4221.810018549173;4898;4906.386701662293;4930.506949305077;4938.753062346868;6904.827379315507;7023.192332881682;7062.964685176593;7113.0753002109395;7216.494845360774;3974.82113304902;4340.153670034376;4472.955270447319;4966.627502937295;5023.2214006829;4458.308962110878;5097.235414687752;5102.4897510248675;5128.743562821844;5135.640505164677;4715.7877895494785;4985.180409150634;5630.774769009276;5691.601587888808;5731.312242530923;6026.54800889935;6678.6326752028135;6740.9325906740305;6758.594484330857;6762.594244345257;1484.2411742085662;1602.7355486344622;1719.9226034828462;1725.7066298729246;1749.9912500437417;1166.5392170092935;1195.6174024312136;1206.1737709668905;1210.497643477947;1211.7640007192615;4841.782119804618;5302.2576839241765;6354.555181137276;6357.682115894187;6385.584936979081;5353.518183363516;6358.887194740902;6974.651267436608;6991.965040174767;6999.405050570656;5368.771959636707;6095.2685677718955;6270.561060725797;6283.717232724538;6356.523260755462;3108.9584989028476;3477.94783078254;3546.5034895114704;3584.6953008994005;3646.663303077707;5517.668939863621;6651.86696266072;7063.540869843444;7068.126946359219;7158.391536719333;6259.186305780219;6282.591631543935;7015.824604384829;7123.002779610859;7179.641017949081;6024.97575412181;6758.8648227036165;7080.964595177094;7150.034745309316;7159.534630249017;5923.851903702442;6252.906206406817;6428.292887782433;6907.585544867324;6917.097798105561;5233.979374022029;6584.176977877765;6769.593824370553;6789.762358317435;6856.657167141722;7127.180374257026;7141.321574450419;7161.606111663908;7171.605561694157;7186.209516953236;4325.935110973275;4331;4369.628581570602;4403.779811009501;4428.630682584801;6758.459323254227;6854.588724676336;6892.207396149306;6918.584884906922;7023.227444980946;6629.6353700545005;6728.495362847708;6731.596104233761;6757.391834734897;6760.053592496956;6149.661768602769;6309.022101574264;6738.561993470409;6763.5941843489545;6790.8641827164165;5431.619786614899;6227.688615569113;6515.478761699147;6614.801555953329;6621.602703837785;6547.869042619026;6730.394264516217;6751.831204219738;6764.425023872829;6780.38976492118;5703.771849126155;6509.381608747161;6517.706703198272;6556.3443655634055;6575.671216439255 03:57:46 INFO - PID 2520 | |5;yui.html;837.7612380471567;850.9149085091492;851.2508992086963;872.7948932000978;879.6569337958196;16783.076930768817;17228.48314550564;17238.56903577411;18600.906995465037;19270.614587708238;17973.7303940441;18371;18472.538186545342;18610.627787444242;18765.7185142223;975.7609385700513;979.8481235408523;985.6698006167942;992.0377234082928;993.0169132558786;916.6241840845255;963.2005435488562;988.0218583602218;997.4165113408665;1004.7387679203423;873.5151990645189;1038.5170895533574;1038.532660302863;1039.433508737736;1041.0162396535238;1029.6910926721953;1034.9948250258738;1035.316690983947;1035.5081336365242;1036.7097212780434;744.7616762635959;744.7636922708278;756.9545827250382;757.6363345594091;759.1459607941066;17040.914795426066;17441.38955136577;17596.648067038586;17605.383811566535;17620.911895440568;16890.98654080759;17133.485995420157;17275.30898764048;17468.47594572165;17470.650586988188;13752.106113102616;13790.103643263155;13916.86083139176;14016.649583760385;14069.929650351785;3429.3655673700196;3496.702780263681;3497.667721566447;3501.6498350165034;3503.2818272254126;132800;133073;134699;135324;135661.965070525;12935.935320323526;13118.737625247442;13163.60509184726;13258.27079510617;13291.069625126149;25153.74846251551;25383.238502844943;25511.36221594438;25531.48937021249;25564.74435255661;6417.839554011187;7694.692212311556;7818.648160832776;7948.205179482005;8046.758597242092;3763.9811800941366;3842.5965273646425;3857.3442514772555;3862.9763112775136;3864.594217607167;3778.3387907116144;3818.217265460574;3841.1741475582326;3863.3239183142837;3869.187470631199;933.1554942776797;954.0888451528773;961.6682244625594;963.1620490173594;967.8064387122604;523.2862375719549;592.517098564677;600.1987346891948;603.0652488642586;618.1685632823845;10279.126274266771;10581.576736930436;12042.75914481723;12056.397180140957;12178.330191839357;499.74762744814365;645.6932956845461;648.0732552449947;656.5404217048085;660.2341284110408;4875.293082503017;5204.724842413633;5447.536959358499;5508.779648814083;5625.521830644359;103296.96703033024;105341.47329263458;111673.44163279294;113277.4336128314;115217.4239128799;89021.55489222512;90318.09681903229;95635.08729825364;97302.02697973071;97564;75144.62427687827;78262;78461;80075.19924800794;80895.59552202202;12154.453049612612;12737.172083814523;12737.29944853042;12739.61781146567;12754.42605082755;39000.80499597484;39699.206015880096;39746;41709.79145104255;42469.57530424656;50524.74737626289;51067.74466127794;51119.66497193985;51450.74274628603;51741;15974.440894568634;16235.918820406296;16579.253933573258;16699.74950375721;16718.08050557231;17764.733528997334;18123.912565246126;18146.818531815043;18355;18453.630927381644;16101.355945762038;16295.51113466598;16459.506214813573;16697;16811.07539085313;11646.825297620711;16219.837801621832;16491.58771030734;16605.75091373606;16837.989720616803;16002.599935001717;16083.276252568428;16600.169991500617;16700.164991750607;16701.5824604381;10013.198944084601;10817.675469735921;11627.76744465089;11947.402629868646;12133.272003679807;12582.433790479266;12670.746585068431;13004;13034.4134513949;13071.346432678138 03:57:46 INFO - PID 2520 | __end_tp_report 03:57:46 INFO - PID 2520 | __start_cc_report 03:57:46 INFO - PID 2520 | _x_x_mozilla_cycle_collect,422 03:57:46 INFO - PID 2520 | __end_cc_report 03:57:46 INFO - PID 2520 | __startTimestamp1493636266020__endTimestamp 03:57:46 INFO - PID 2520 | 03:57:46 INFO - PID 2520 | ------- Summary: start ------- 03:57:46 INFO - PID 2520 | Number of tests: 6 03:57:46 INFO - PID 2520 | 03:57:46 INFO - PID 2520 | [#0] dojo.html Cycles:165 Average:6186.30 Median:6372.49 stddev:737.51 (11.6%) stddev-sans-first:698.14 03:57:46 INFO - PID 2520 | Values: 3072.3 3643.2 3648.3 3690.9 3696.8 6134.2 6242.5 6274.2 6274.4 6314.4 6161.5 6177.4 6203.8 6257.1 6318.7 5472.3 5488.4 5508.5 5522.1 5527.0 5538.2 5605.2 5614.5 5663.9 5669.3 5305.6 5525.4 5537.0 5573.9 5633.2 5458.5 5490.4 5515.8 5553.4 5574.1 5445.5 5458.2 5482.6 5500.4 5510.4 5036.2 6006.6 6272.3 6275.3 6298.1 6452.6 6539.4 6651.0 6724.3 6728.0 6866.9 6872.4 6880.5 6881.8 6885.1 6268.9 6334.6 6370.0 6372.5 6382.3 5663.5 6703.1 6809.3 6936.1 6967.6 6396.1 6463.4 6562.0 6618.2 6698.6 6723.2 6823.1 6840.7 6845.0 6864.6 6709.8 6712.7 6715.6 6724.2 6726.1 5521.9 6463.5 6590.7 6718.6 6727.8 5342.1 5365.5 5375.8 5406.1 5438.1 4785.3 4787.8 4790.6 4799.0 4850.7 5734.4 6297.4 6321.3 6359.9 6367.1 6659.2 6690.5 6766.3 6777.3 6815.5 6347.1 6348.8 6357.3 6363.6 6370.9 5937.1 5964.3 6043.3 6044.2 6110.6 5621.9 6895.0 6899.2 6933.8 7097.9 6801.6 6831.5 6862.0 6866.1 6881.8 6977.7 7026.2 7055.1 7057.7 7078.7 6499.6 6711.9 6739.0 6746.7 6778.0 6662.2 6732.5 6766.3 6785.4 6825.2 6345.4 6423.6 6475.8 6645.0 6651.1 6619.5 6641.1 6651.1 6657.9 6675.6 5111.3 5919.7 6169.3 6527.3 6534.7 6447.2 6575.2 6582.5 6593.9 6599.5 5814.9 6047.9 6442.9 6453.4 6476.9 03:57:46 INFO - PID 2520 | 03:57:46 INFO - PID 2520 | [#1] ext.html Cycles:180 Average:45224.18 Median:35413.96 stddev:79288.19 (223.9%) stddev-sans-first:79440.28 03:57:46 INFO - PID 2520 | Values: 745.5 807.3 826.7 1202.9 1273.9 36592.6 37701.2 37740.4 37768.4 37836.6 37745.8 38056.0 38152.4 38157.4 38181.8 7835.5 7998.1 8286.9 8526.0 8536.6 8082.5 8599.6 8603.2 8604.7 8634.9 7564.5 8368.7 8552.0 8631.3 8648.9 8508.3 8553.7 8605.1 8610.0 8612.4 8399.2 8431.2 8499.6 8508.6 8511.4 37497.0 37557.0 37588.0 37778.2 37838.8 3674.1 3705.9 3714.3 3715.5 3724.5 30693.5 30772.0 30784.4 30862.1 30940.0 3105.3 3162.9 3164.4 3167.3 3178.2 291550.0 298949.5 301156.0 304610.0 306185.0 47396.5 47775.0 47781.8 47840.0 47906.8 41764.7 50343.2 50360.5 54943.7 55068.2 11759.5 14264.1 14287.9 14412.5 14417.4 8446.5 10839.2 10947.9 11225.6 11557.0 12462.9 13950.9 14034.2 14079.3 14186.4 5186.9 6197.7 6218.9 6260.8 6279.2 984.9 993.4 999.9 1020.9 1034.1 23970.3 24134.8 24291.9 24393.5 24421.4 1089.5 1095.1 1122.5 1130.4 1132.4 10474.7 11638.6 12234.6 12430.9 12433.9 319954.0 320098.0 322469.0 322930.0 329341.0 54381.7 54587.2 54650.5 54761.0 55106.0 1516.2 1548.2 1580.3 1580.9 1584.8 17622.6 23729.5 23777.0 23826.9 23997.0 37770.8 37775.1 37848.0 37903.2 37974.8 280000.0 281027.0 281931.0 283006.0 283710.0 34999.0 35158.3 35263.9 35564.0 35564.0 43068.4 43573.6 44914.0 44983.9 45077.0 24373.8 29601.6 30045.6 30510.8 30826.5 30046.9 30390.0 30773.5 30829.8 30860.8 36536.5 36957.9 37059.0 37084.3 37109.3 29649.3 30715.0 30797.8 31300.4 31715.0 24023.9 24063.9 24160.0 24413.0 24555.5 03:57:46 INFO - PID 2520 | 03:57:46 INFO - PID 2520 | [#2] jquery.html Cycles:180 Average:36105.86 Median:26262.40 stddev:89275.42 (339.9%) stddev-sans-first:89485.55 03:57:46 INFO - PID 2520 | Values: 371.8 420.5 423.3 427.2 453.0 21488.9 21505.8 22226.6 22891.0 23160.7 17897.6 21765.6 21892.5 22179.1 22425.6 5790.4 6759.5 6950.7 6978.6 7004.2 6101.4 6872.7 6916.1 6920.4 6925.2 6659.9 6838.0 6865.8 6876.8 6918.6 6801.7 6819.9 6863.1 6900.1 6918.1 6463.8 6751.6 6756.9 6762.0 6789.2 21375.6 27310.0 29572.4 29765.3 29800.7 1840.3 2333.6 2333.8 2341.1 2343.3 15226.9 17618.6 19188.8 19276.6 19391.8 2182.3 2253.7 2301.1 2306.2 2346.6 150888.0 152802.2 155041.4 155187.6 157139.0 23422.3 24837.6 25093.8 25118.0 25214.7 41079.0 41109.8 41110.4 41149.4 41306.0 8855.0 8911.5 9002.4 9200.0 9232.8 7382.2 8255.8 8494.5 8614.7 8751.0 6822.6 7980.9 8150.8 8211.7 8267.4 2252.9 2261.6 2266.6 2272.4 2438.1 874.8 882.0 926.2 955.3 995.0 16601.9 21476.4 21659.4 21715.0 21738.1 891.7 962.6 997.1 1008.3 1023.7 9327.8 10213.7 10620.2 11109.4 11194.2 464347.0 523254.0 541338.0 542791.0 546109.0 110930.0 136460.3 137586.3 141236.0 141444.9 1190.0 1207.1 1246.2 1249.0 1249.6 19043.6 21743.9 21997.8 22040.9 22293.1 55697.0 59426.7 59440.4 59905.4 60306.7 55601.7 73573.5 75490.1 76320.0 76986.6 9100.9 9107.9 9120.5 9223.6 9240.3 14692.3 14740.9 14840.0 14890.2 14980.2 11849.1 12059.7 12146.2 12240.5 12434.6 11600.3 11653.7 11670.0 11684.4 11925.3 12301.1 12429.4 12637.4 12693.9 12715.8 8906.6 9146.9 9207.3 9240.2 9389.4 9559.9 10260.8 11996.4 12327.8 12397.1 03:57:46 INFO - PID 2520 | 03:57:46 INFO - PID 2520 | [#3] mootools.html Cycles:180 Average:7076.24 Median:3813.77 stddev:4454.53 (116.8%) stddev-sans-first:4446.25 03:57:46 INFO - PID 2520 | Values: 1351.8 1481.1 1485.2 1485.2 1507.5 10114.4 10410.3 11616.1 11968.3 12162.0 10205.3 11375.8 11607.4 12003.6 12018.3 2222.2 2459.5 2510.2 2550.2 2555.6 2079.7 2486.9 2531.9 2533.8 2538.8 2106.3 2121.1 2341.1 2520.3 2560.6 2469.8 2481.5 2485.6 2488.5 2488.7 2431.8 2444.9 2454.7 2460.5 2466.0 11823.8 11916.6 12054.2 12059.5 12077.3 6537.9 6774.2 6777.4 6782.9 6785.7 4051.7 4277.8 4363.1 4411.7 4418.3 1209.6 1228.2 1256.7 1258.1 1297.3 16646.6 16655.9 16810.8 16877.3 16912.5 5887.9 5957.4 6111.2 6188.3 6193.4 13379.8 14057.4 14067.9 14143.9 14160.5 6783.7 6841.7 6846.5 6848.8 6849.9 5411.8 6069.2 6224.7 6280.7 6283.0 4033.8 4647.8 4799.0 4844.3 4884.7 1428.6 1452.8 1460.6 1463.6 1473.9 746.9 781.1 820.9 825.4 840.2 5609.5 6737.3 6778.2 6851.4 6978.4 518.2 594.0 601.2 603.8 613.5 3795.4 3832.2 3931.6 3941.8 3978.1 13565.2 13836.4 14102.8 14167.6 14171.0 13892.5 13968.9 14181.0 14273.1 14283.9 7649.9 8293.1 8325.9 8352.1 8360.1 5706.9 6302.2 6498.3 6519.8 6554.8 11039.6 12125.7 12498.0 12667.7 12763.2 12739.8 12844.7 12995.3 13026.7 13241.9 7438.6 7917.5 8844.3 9118.0 9194.5 11233.6 11322.8 11337.5 11372.3 11383.2 9083.0 9376.6 9398.9 9404.0 9536.2 7462.9 9174.4 9207.1 9235.5 9397.2 8149.8 8258.1 8356.3 8358.0 8364.3 6005.2 6028.2 6086.3 6219.7 6256.9 6028.5 6137.6 6183.9 6261.5 6340.2 03:57:46 INFO - PID 2520 | 03:57:46 INFO - PID 2520 | [#4] prototype.html Cycles:180 Average:5396.51 Median:5779.10 stddev:1657.48 (28.7%) stddev-sans-first:1618.81 03:57:46 INFO - PID 2520 | Values: 380.9 399.5 403.7 406.7 407.0 5207.4 5341.3 6071.6 6309.9 6386.7 5088.6 5263.9 5665.1 5989.8 6249.5 4398.6 4557.0 4756.6 4757.2 4770.1 4689.2 4720.9 4773.2 4775.8 4777.3 3519.5 4176.5 4273.5 4652.0 4742.9 4065.6 4465.3 4539.2 4732.7 4775.1 4173.8 4177.9 4184.4 4237.3 4247.4 5602.3 5826.9 6084.5 6087.4 6116.0 5665.8 5684.8 5686.1 5695.1 5729.8 5175.7 5374.7 5873.7 6440.6 6786.5 4221.8 4898.0 4906.4 4930.5 4938.8 6904.8 7023.2 7063.0 7113.1 7216.5 3974.8 4340.2 4473.0 4966.6 5023.2 4458.3 5097.2 5102.5 5128.7 5135.6 4715.8 4985.2 5630.8 5691.6 5731.3 6026.5 6678.6 6740.9 6758.6 6762.6 1484.2 1602.7 1719.9 1725.7 1750.0 1166.5 1195.6 1206.2 1210.5 1211.8 4841.8 5302.3 6354.6 6357.7 6385.6 5353.5 6358.9 6974.7 6992.0 6999.4 5368.8 6095.3 6270.6 6283.7 6356.5 3109.0 3477.9 3546.5 3584.7 3646.7 5517.7 6651.9 7063.5 7068.1 7158.4 6259.2 6282.6 7015.8 7123.0 7179.6 6025.0 6758.9 7081.0 7150.0 7159.5 5923.9 6252.9 6428.3 6907.6 6917.1 5234.0 6584.2 6769.6 6789.8 6856.7 7127.2 7141.3 7161.6 7171.6 7186.2 4325.9 4331.0 4369.6 4403.8 4428.6 6758.5 6854.6 6892.2 6918.6 7023.2 6629.6 6728.5 6731.6 6757.4 6760.1 6149.7 6309.0 6738.6 6763.6 6790.9 5431.6 6227.7 6515.5 6614.8 6621.6 6547.9 6730.4 6751.8 6764.4 6780.4 5703.8 6509.4 6517.7 6556.3 6575.7 03:57:46 INFO - PID 2520 | 03:57:46 INFO - PID 2520 | [#5] yui.html Cycles:180 Average:22081.23 Median:18536.72 stddev:31808.71 (171.6%) stddev-sans-first:31857.95 03:57:46 INFO - PID 2520 | Values: 837.8 850.9 851.3 872.8 879.7 16783.1 17228.5 17238.6 18600.9 19270.6 17973.7 18371.0 18472.5 18610.6 18765.7 975.8 979.8 985.7 992.0 993.0 916.6 963.2 988.0 997.4 1004.7 873.5 1038.5 1038.5 1039.4 1041.0 1029.7 1035.0 1035.3 1035.5 1036.7 744.8 744.8 757.0 757.6 759.1 17040.9 17441.4 17596.6 17605.4 17620.9 16891.0 17133.5 17275.3 17468.5 17470.7 13752.1 13790.1 13916.9 14016.6 14069.9 3429.4 3496.7 3497.7 3501.6 3503.3 132800.0 133073.0 134699.0 135324.0 135662.0 12935.9 13118.7 13163.6 13258.3 13291.1 25153.7 25383.2 25511.4 25531.5 25564.7 6417.8 7694.7 7818.6 7948.2 8046.8 3764.0 3842.6 3857.3 3863.0 3864.6 3778.3 3818.2 3841.2 3863.3 3869.2 933.2 954.1 961.7 963.2 967.8 523.3 592.5 600.2 603.1 618.2 10279.1 10581.6 12042.8 12056.4 12178.3 499.7 645.7 648.1 656.5 660.2 4875.3 5204.7 5447.5 5508.8 5625.5 103297.0 105341.5 111673.4 113277.4 115217.4 89021.6 90318.1 95635.1 97302.0 97564.0 75144.6 78262.0 78461.0 80075.2 80895.6 12154.5 12737.2 12737.3 12739.6 12754.4 39000.8 39699.2 39746.0 41709.8 42469.6 50524.7 51067.7 51119.7 51450.7 51741.0 15974.4 16235.9 16579.3 16699.7 16718.1 17764.7 18123.9 18146.8 18355.0 18453.6 16101.4 16295.5 16459.5 16697.0 16811.1 11646.8 16219.8 16491.6 16605.8 16838.0 16002.6 16083.3 16600.2 16700.2 16701.6 10013.2 10817.7 11627.8 11947.4 12133.3 12582.4 12670.7 13004.0 13034.4 13071.3 03:57:46 INFO - PID 2520 | -------- Summary: end -------- 03:57:46 INFO - PID 2520 | 03:57:46 INFO - TEST-INFO | 2520: exit 0 03:57:46 INFO - TEST-OK | dromaeo_css | took 1116174ms 03:57:46 INFO - TEST-START | kraken 03:57:46 INFO - operating with platform_type : mac_ 03:57:46 INFO - Initialising browser for kraken test... 03:57:46 INFO - TEST-INFO | started process 2531 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/tmpF9ounV/profile http://localhost:56646/getInfo.html) 03:57:49 INFO - PID 2531 | 2017-05-01 03:57:49.803 plugin-container[2532:40460] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x433f, name = 'com.apple.tsm.portname' 03:57:49 INFO - PID 2531 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:57:49 INFO - PID 2531 | 2017-05-01 03:57:49.806 plugin-container[2532:40460] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x961b, name = 'com.apple.CFPasteboardClient' 03:57:49 INFO - PID 2531 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:57:49 INFO - PID 2531 | 2017-05-01 03:57:49.806 plugin-container[2532:40460] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:57:49 INFO - PID 2531 | __metrics Screen width/height:1600/1200 03:57:49 INFO - PID 2531 | colorDepth:24 03:57:49 INFO - PID 2531 | Browser inner width/height: 1024/689 03:57:49 INFO - PID 2531 | __metrics 03:57:51 INFO - TEST-INFO | 2531: exit 0 03:57:51 INFO - Browser initialized. 03:57:51 INFO - Running cycle 1/1 for kraken test... 03:57:51 INFO - TEST-INFO | started process 2533 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/tmpF9ounV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:57:53 INFO - PID 2533 | 2017-05-01 03:57:53.426 plugin-container[2534:40587] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x923f, name = 'com.apple.tsm.portname' 03:57:53 INFO - PID 2533 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:57:53 INFO - PID 2533 | 2017-05-01 03:57:53.426 plugin-container[2534:40587] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x960b, name = 'com.apple.CFPasteboardClient' 03:57:53 INFO - PID 2533 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:57:53 INFO - PID 2533 | 2017-05-01 03:57:53.426 plugin-container[2534:40587] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:58:03 INFO - PID 2533 | RSS: Main: 235163648 03:58:03 INFO - PID 2533 | 03:58:06 INFO - PID 2533 | Cycle 1(1): loaded http://localhost:56646/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56646/tests/kraken/driver.html?testName=audio-beat-detection) 03:58:07 INFO - PID 2533 | RSS: Main: 248279040 03:58:07 INFO - PID 2533 | 03:58:09 INFO - PID 2533 | Cycle 1(1): loaded http://localhost:56646/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56646/tests/kraken/driver.html?testName=audio-dft) 03:58:10 INFO - PID 2533 | RSS: Main: 256966656 03:58:10 INFO - PID 2533 | 03:58:13 INFO - PID 2533 | Cycle 1(1): loaded http://localhost:56646/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56646/tests/kraken/driver.html?testName=audio-fft) 03:58:14 INFO - PID 2533 | RSS: Main: 259510272 03:58:14 INFO - PID 2533 | 03:58:16 INFO - PID 2533 | Cycle 1(1): loaded http://localhost:56646/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56646/tests/kraken/driver.html?testName=audio-oscillator) 03:58:16 INFO - PID 2533 | RSS: Main: 260378624 03:58:16 INFO - PID 2533 | 03:58:18 INFO - PID 2533 | Cycle 1(1): loaded http://localhost:56646/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56646/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:58:19 INFO - PID 2533 | RSS: Main: 262209536 03:58:19 INFO - PID 2533 | 03:58:22 INFO - PID 2533 | Cycle 1(1): loaded http://localhost:56646/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56646/tests/kraken/driver.html?testName=imaging-darkroom) 03:58:23 INFO - PID 2533 | RSS: Main: 267931648 03:58:23 INFO - PID 2533 | 03:58:26 INFO - PID 2533 | Cycle 1(1): loaded http://localhost:56646/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56646/tests/kraken/driver.html?testName=imaging-desaturate) 03:58:26 INFO - PID 2533 | RSS: Main: 268984320 03:58:26 INFO - PID 2533 | 03:58:29 INFO - PID 2533 | Cycle 1(1): loaded http://localhost:56646/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56646/tests/kraken/driver.html?testName=json-parse-financial) 03:58:30 INFO - PID 2533 | RSS: Main: 268681216 03:58:30 INFO - PID 2533 | 03:58:31 INFO - PID 2533 | Cycle 1(1): loaded http://localhost:56646/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56646/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:58:32 INFO - PID 2533 | RSS: Main: 267964416 03:58:32 INFO - PID 2533 | 03:58:34 INFO - PID 2533 | Cycle 1(1): loaded http://localhost:56646/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56646/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:58:34 INFO - PID 2533 | RSS: Main: 268087296 03:58:34 INFO - PID 2533 | 03:58:37 INFO - PID 2533 | Cycle 1(1): loaded http://localhost:56646/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56646/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:58:37 INFO - PID 2533 | RSS: Main: 267661312 03:58:37 INFO - PID 2533 | 03:58:40 INFO - PID 2533 | Cycle 1(1): loaded http://localhost:56646/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56646/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:58:41 INFO - PID 2533 | RSS: Main: 267956224 03:58:41 INFO - PID 2533 | 03:58:44 INFO - PID 2533 | Cycle 1(1): loaded http://localhost:56646/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56646/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:58:45 INFO - PID 2533 | RSS: Main: 268046336 03:58:45 INFO - PID 2533 | 03:58:47 INFO - PID 2533 | Cycle 1(1): loaded http://localhost:56646/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56646/tests/kraken/driver.html?testName=ai-astar) 03:58:47 INFO - PID 2533 | RSS: Main: 270020608 03:58:47 INFO - PID 2533 | 03:58:47 INFO - PID 2533 | __start_tp_report 03:58:47 INFO - PID 2533 | _x_x_mozilla_page_load 03:58:47 INFO - PID 2533 | _x_x_mozilla_page_load_details 03:58:47 INFO - PID 2533 | |i|pagename|runs| 03:58:47 INFO - PID 2533 | |0;ai-astar;141;113;113;114;114;115;124;173;154;114 03:58:47 INFO - PID 2533 | |1;audio-beat-detection;191;110;111;150;108;114;109;112;148;110 03:58:47 INFO - PID 2533 | |2;audio-dft;201;198;219;270;251;195;198;202;198;236 03:58:47 INFO - PID 2533 | |3;audio-fft;84;60;61;90;63;61;72;75;82;58 03:58:47 INFO - PID 2533 | |4;audio-oscillator;91;73;106;58;73;93;106;57;91;120 03:58:47 INFO - PID 2533 | |5;imaging-gaussian-blur;93;93;93;92;94;98;111;92;93;119 03:58:47 INFO - PID 2533 | |6;imaging-darkroom;98;99;99;108;124;98;103;153;98;98 03:58:47 INFO - PID 2533 | |7;imaging-desaturate;108;90;90;90;92;97;91;91;85;91 03:58:47 INFO - PID 2533 | |8;json-parse-financial;51;51;51;50;51;51;54;53;52;51 03:58:47 INFO - PID 2533 | |9;json-stringify-tinderbox;60;59;55;63;70;64;60;58;59;59 03:58:47 INFO - PID 2533 | |10;stanford-crypto-aes;85;86;83;83;85;86;84;83;90;88 03:58:47 INFO - PID 2533 | |11;stanford-crypto-ccm;135;138;148;150;137;162;160;155;208;161 03:58:47 INFO - PID 2533 | |12;stanford-crypto-pbkdf2;181;221;187;215;173;160;159;240;239;193 03:58:47 INFO - PID 2533 | |13;stanford-crypto-sha256-iterative;68;66;70;60;79;93;98;79;69;71 03:58:47 INFO - PID 2533 | __end_tp_report 03:58:47 INFO - PID 2533 | __start_cc_report 03:58:47 INFO - PID 2533 | _x_x_mozilla_cycle_collect,993 03:58:47 INFO - PID 2533 | __end_cc_report 03:58:47 INFO - PID 2533 | __startTimestamp1493636327353__endTimestamp 03:58:47 INFO - PID 2533 | 03:58:47 INFO - PID 2533 | ------- Summary: start ------- 03:58:47 INFO - PID 2533 | Number of tests: 14 03:58:47 INFO - PID 2533 | 03:58:47 INFO - PID 2533 | [#0] ai-astar Cycles:10 Average:127.50 Median:119.50 stddev:21.32 (17.8%) stddev-sans-first:22.05 03:58:47 INFO - PID 2533 | Values: 141.0 113.0 113.0 114.0 114.0 115.0 124.0 173.0 154.0 114.0 03:58:47 INFO - PID 2533 | 03:58:47 INFO - PID 2533 | [#1] audio-beat-detection Cycles:10 Average:126.30 Median:113.00 stddev:27.84 (24.6%) stddev-sans-first:17.04 03:58:47 INFO - PID 2533 | Values: 191.0 110.0 111.0 150.0 108.0 114.0 109.0 112.0 148.0 110.0 03:58:47 INFO - PID 2533 | 03:58:47 INFO - PID 2533 | [#2] audio-dft Cycles:10 Average:216.80 Median:210.50 stddev:26.62 (12.6%) stddev-sans-first:27.61 03:58:47 INFO - PID 2533 | Values: 201.0 198.0 219.0 270.0 251.0 195.0 198.0 202.0 198.0 236.0 03:58:47 INFO - PID 2533 | 03:58:47 INFO - PID 2533 | [#3] audio-fft Cycles:10 Average:70.60 Median:73.50 stddev:11.64 (15.8%) stddev-sans-first:11.30 03:58:47 INFO - PID 2533 | Values: 84.0 60.0 61.0 90.0 63.0 61.0 72.0 75.0 82.0 58.0 03:58:47 INFO - PID 2533 | 03:58:47 INFO - PID 2533 | [#4] audio-oscillator Cycles:10 Average:86.80 Median:73.00 stddev:21.11 (28.9%) stddev-sans-first:22.34 03:58:47 INFO - PID 2533 | Values: 91.0 73.0 106.0 58.0 73.0 93.0 106.0 57.0 91.0 120.0 03:58:47 INFO - PID 2533 | 03:58:47 INFO - PID 2533 | [#5] imaging-gaussian-blur Cycles:10 Average:97.80 Median:93.00 stddev:9.41 (10.1%) stddev-sans-first:9.82 03:58:47 INFO - PID 2533 | Values: 93.0 93.0 93.0 92.0 94.0 98.0 111.0 92.0 93.0 119.0 03:58:47 INFO - PID 2533 | 03:58:47 INFO - PID 2533 | [#6] imaging-darkroom Cycles:10 Average:107.80 Median:98.00 stddev:17.85 (18.2%) stddev-sans-first:18.58 03:58:47 INFO - PID 2533 | Values: 98.0 99.0 99.0 108.0 124.0 98.0 103.0 153.0 98.0 98.0 03:58:47 INFO - PID 2533 | 03:58:47 INFO - PID 2533 | [#7] imaging-desaturate Cycles:10 Average:92.50 Median:91.00 stddev:6.17 (6.8%) stddev-sans-first:3.07 03:58:47 INFO - PID 2533 | Values: 108.0 90.0 90.0 90.0 92.0 97.0 91.0 91.0 85.0 91.0 03:58:47 INFO - PID 2533 | 03:58:47 INFO - PID 2533 | [#8] json-parse-financial Cycles:10 Average:51.50 Median:51.00 stddev:1.18 (2.3%) stddev-sans-first:1.24 03:58:47 INFO - PID 2533 | Values: 51.0 51.0 51.0 50.0 51.0 51.0 54.0 53.0 52.0 51.0 03:58:47 INFO - PID 2533 | 03:58:47 INFO - PID 2533 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:60.00 stddev:4.11 (6.9%) stddev-sans-first:4.35 03:58:47 INFO - PID 2533 | Values: 60.0 59.0 55.0 63.0 70.0 64.0 60.0 58.0 59.0 59.0 03:58:47 INFO - PID 2533 | 03:58:47 INFO - PID 2533 | [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:85.50 stddev:2.31 (2.7%) stddev-sans-first:2.45 03:58:47 INFO - PID 2533 | Values: 85.0 86.0 83.0 83.0 85.0 86.0 84.0 83.0 90.0 88.0 03:58:47 INFO - PID 2533 | 03:58:47 INFO - PID 2533 | [#11] stanford-crypto-ccm Cycles:10 Average:155.40 Median:157.50 stddev:21.09 (13.4%) stddev-sans-first:21.04 03:58:47 INFO - PID 2533 | Values: 135.0 138.0 148.0 150.0 137.0 162.0 160.0 155.0 208.0 161.0 03:58:47 INFO - PID 2533 | 03:58:47 INFO - PID 2533 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:196.80 Median:204.00 stddev:30.32 (14.9%) stddev-sans-first:31.62 03:58:47 INFO - PID 2533 | Values: 181.0 221.0 187.0 215.0 173.0 160.0 159.0 240.0 239.0 193.0 03:58:47 INFO - PID 2533 | 03:58:47 INFO - PID 2533 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.30 Median:75.00 stddev:12.09 (16.1%) stddev-sans-first:12.53 03:58:47 INFO - PID 2533 | Values: 68.0 66.0 70.0 60.0 79.0 93.0 98.0 79.0 69.0 71.0 03:58:47 INFO - PID 2533 | -------- Summary: end -------- 03:58:47 INFO - PID 2533 | 03:58:48 INFO - TEST-INFO | 2533: exit 0 03:58:48 INFO - TEST-OK | kraken | took 61753ms 03:58:48 INFO - SUITE-END | took 1177s 03:58:48 INFO - Completed test suite (00:19:38) 03:58:48 INFO - javascript benchmark 03:58:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7993.228434704958, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3072.278014666553, 3643.1620727232735, 3648.3068217038776, 3690.907727306817, 3696.815159242039, 6134.202553668017, 6242.500599952004, 6274.152989346442, 6274.372562743723, 6314.368563143684, 6161.537884658657, 6177.444030037295, 6203.813885583429, 6257.061440783885, 6318.715657795398, 5472.315960504917, 5488.423715509874, 5508.476694714006, 5522.144067669517, 5526.972365138168, 5538.169274608821, 5605.215269862202, 5614.494695477406, 5663.886722265553, 5669.262995810539, 5305.575553955713, 5525.364583072957, 5536.975659503005, 5573.8606534836545, 5633.15502674598, 5458.5087342139395, 5490.3960564338295, 5515.834524964257, 5553.444655534455, 5574.136008918624, 5445.50990410861, 5458.235846981386, 5482.5888058395385, 5500.4499550045075, 5510.421405752379, 5036.219385995177, 6006.609570377911, 6272.3100458949475, 6275.341089185661, 6298.149749783766, 6452.612843229421, 6539.411452969255, 6650.9667451662435, 6724.327567243286, 6727.966360168217, 6866.896996545006, 6872.41584465321, 6880.483963702743, 6881.827954301132, 6885.1049363582915, 6268.905966410507, 6334.556581039329, 6369.9681501592195, 6372.490200783926, 6382.329855365213, 5663.518600918968, 6703.128593282842, 6809.250982391933, 6936.063631409796, 6967.581945083311, 6396.1045453636525, 6463.418292353711, 6562.0, 6618.172728408949, 6698.63157526331, 6723.159605049369, 6823.078884350648, 6840.657967101724, 6844.965775171092, 6864.553804002824, 6709.832254193587, 6712.697928593225, 6715.56348837324, 6724.226713927863, 6726.125603671491, 5521.861953451196, 6463.48292136628, 6590.670466476657, 6718.630475323806, 6727.764528241488, 5342.065138600729, 5365.463453654604, 5375.7849686012905, 5406.053940560386, 5438.102713052381, 4785.3300537924715, 4787.808487660454, 4790.592799612003, 4798.976005120022, 4850.708957462563, 5734.369219385864, 6297.433231009231, 6321.273053598803, 6359.872802543923, 6367.076773867763, 6659.234188068434, 6690.464762818963, 6766.289539598271, 6777.288384719632, 6815.454763618998, 6347.079673447324, 6348.809535713936, 6357.268914074848, 6363.5863668861375, 6370.936290637034, 5937.139114828326, 5964.343922168558, 6043.3050199227655, 6044.214252147281, 6110.602810817371, 5621.943780562142, 6895.0, 6899.241083480712, 6933.757318493828, 7097.9290207097265, 6801.557898736566, 6831.4876384272375, 6862.039314495874, 6866.141732283465, 6881.827954301182, 6977.686004129928, 7026.19198792125, 7055.082839231072, 7057.7176912922905, 7078.681459334445, 6499.5775274607, 6711.899321510279, 6738.966305168443, 6746.69639866217, 6778.0, 6662.167229096363, 6732.461403087839, 6766.289539598468, 6785.38931496148, 6825.249222585611, 6345.3654634538025, 6423.646699431576, 6475.805725828232, 6645.0, 6651.06885036105, 6619.470442364695, 6641.136652235178, 6651.102101216274, 6657.900131497934, 6675.566088204251, 5111.284420181252, 5919.727258639413, 6169.290531588746, 6527.3472652734345, 6534.673266336569, 6447.194100737408, 6575.178102737158, 6582.506312026713, 6593.901091483535, 6599.505037122139, 5814.854628634318, 6047.879042419039, 6442.871142577029, 6453.386928241809, 6476.935230647633], "value": 6138.565145561585, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [745.4818900863902, 807.2936180841764, 826.7147833997269, 1202.9157958942878, 1273.8853503184712, 36592.634073659254, 37701.245975080485, 37740.43389349159, 37768.43347349792, 37836.62163378369, 37745.811270943675, 38056.0, 38152.427713584315, 38157.42763858545, 38181.80909095458, 7835.529868207912, 7998.12020677725, 8286.875696864552, 8525.95737021314, 8536.615852286663, 8082.474639148466, 8599.61301741423, 8603.225709686127, 8604.698835540757, 8634.870476942819, 7564.470487065908, 8368.661014237723, 8552.0, 8631.309495240366, 8648.870266946002, 8508.319334453228, 8553.690503564003, 8605.139486051406, 8609.956950215272, 8612.39713220075, 8399.202075802788, 8431.156884311582, 8499.61751721174, 8508.617112229964, 8511.404201705884, 37497.0, 37557.0, 37588.0, 37778.24443511114, 37838.81080594607, 3674.1182116292166, 3705.925281668313, 3714.257148570297, 3715.498407714978, 3724.4971928789537, 30693.539596906063, 30772.0, 30784.38431231363, 30862.074137775904, 30940.0, 3105.316830297331, 3162.920926976844, 3164.4145833020734, 3167.255694911694, 3178.2213357727273, 291550.0, 298949.5052524745, 301156.0, 304610.0, 306185.0, 47396.5260347399, 47775.0, 47781.805454863905, 47840.0, 47906.76046619745, 41764.74705758832, 50343.24485132726, 50360.496395036316, 54943.725281374136, 55068.17397739037, 11759.529618815151, 14264.072835265883, 14287.857121428653, 14412.495562655256, 14417.351219195161, 8446.535440550706, 10839.241253112206, 10947.905209478988, 11225.550977960953, 11557.017653499546, 12462.875371246353, 13950.930245348709, 14034.228117453638, 14079.296035198198, 14186.432542698176, 5186.910748742806, 6197.690115494297, 6218.875622487525, 6260.843478913063, 6279.246490421178, 984.945827979468, 993.438707130469, 999.9150072243941, 1020.9438480883623, 1034.0848349211003, 23970.280891573282, 24134.75865241325, 24291.878540607184, 24393.512129757306, 24421.38946526351, 1089.5042755546208, 1095.1403148528368, 1122.4612186150694, 1130.3669944830922, 1132.388510204497, 10474.74303083635, 11638.592649257405, 12234.632961011184, 12430.875691242973, 12433.93783031079, 319954.0, 320098.0, 322469.0, 322930.0, 329341.0, 54381.728091360084, 54587.18119228215, 54650.45349546533, 54761.0, 55106.0, 1516.2343016776458, 1548.202675622033, 1580.2651766928434, 1580.936762529486, 1584.7702083198103, 17622.647547049244, 23729.52540949137, 23777.0, 23826.88086559556, 23997.0, 37770.81114594409, 37775.05562360963, 37848.0, 37903.24193516169, 37974.810125949196, 280000.0, 281027.0, 281931.0, 283006.0, 283710.0, 34999.0, 35158.29683406369, 35263.94208173759, 35563.97706195003, 35564.0, 43068.35397468978, 43573.56426435822, 44914.0, 44983.875403115184, 45077.0, 24373.75626243786, 29601.5559766608, 30045.647945842928, 30510.84744576263, 30826.53760193554, 30046.948356807407, 30390.0, 30773.538396924512, 30829.845850770602, 30860.84569577138, 36536.45195322019, 36957.89126326214, 37059.0, 37084.25831483409, 37109.25781484301, 29649.25876853096, 30715.0, 30797.8460107698, 31300.373992519566, 31715.048548543582, 24023.877140533135, 24063.879680601483, 24160.033598655857, 24413.023479060637, 24555.50888982246], "value": 17517.28304117081, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.84196716395536, 420.5311078147866, 423.31423094586756, 427.2139263754691, 452.9853128991061, 21488.92555372233, 21505.81718005511, 22226.555468890634, 22890.969906354214, 23160.652590211117, 17897.64204715905, 21765.64687062586, 21892.45268868275, 22179.11283548656, 22425.55148897021, 5790.449907258803, 6759.526833121683, 6950.652467376636, 6978.581285122884, 7004.194517630462, 6101.420365065312, 6872.72509099638, 6916.135483064617, 6920.4463642908695, 6925.168979722441, 6659.933400666004, 6838.042674025641, 6865.759698410531, 6876.7593134240315, 6918.584884906922, 6801.727930882758, 6819.931800681979, 6863.107795986515, 6900.068490753734, 6918.100646915894, 6463.83840403989, 6751.628660423675, 6756.864862702768, 6761.966190169018, 6789.219239787439, 21375.572488550297, 27310.04414845471, 29572.40855182906, 29765.255868603243, 29800.701992980008, 1840.2822899069374, 2333.5566242414056, 2333.754955729641, 2341.1220792202926, 2343.3438637181616, 15226.923865380602, 17618.559536011573, 19188.808111918843, 19276.614467710708, 19391.80608193914, 2182.3125715399756, 2253.7182852143483, 2301.1255722825385, 2306.2389411494332, 2346.612808886549, 150888.0, 152802.23598881933, 155041.44958550384, 155187.5849932014, 157139.0, 23422.297331080095, 24837.62743558848, 25093.77456296595, 25118.0, 25214.747852521607, 41079.0, 41109.76670699884, 41110.38334424986, 41149.38275925864, 41305.96735081647, 8855.0, 8911.465312081296, 9002.36983411168, 9200.033996430413, 9232.769180770534, 7382.22486638906, 8255.844181814551, 8494.532800695897, 8614.741557753277, 8750.956245218733, 6822.556533825285, 7980.882676425305, 8150.75547733569, 8211.71259005932, 8267.421280510307, 2252.9211477598533, 2261.592913275626, 2266.648669456237, 2272.3523795718143, 2438.0613463816558, 874.8058899601997, 881.990121311108, 926.2080920812742, 955.2692190474154, 995.0, 16601.920875143078, 21476.355709328745, 21659.350219493124, 21715.0, 21738.13047478083, 891.7012800711705, 962.5620342744035, 997.1324947295755, 1008.2841182760176, 1023.7031260934245, 9327.813443731087, 10213.74465638365, 10620.150387969099, 11109.388983605817, 11194.160437967184, 464347.0, 523254.0, 541338.0, 542791.0, 546109.0, 110930.0, 136460.3176984109, 137586.31206843903, 141236.0, 141444.8783268252, 1189.9762004759857, 1207.106741011645, 1246.1650694035018, 1248.9875101249054, 1249.568898729955, 19043.619127617647, 21743.891280543496, 21997.780022199575, 22040.88979555156, 22293.10827566879, 55697.0, 59426.70286648539, 59440.405595943485, 59905.40094598998, 60306.69846650738, 55601.7219913914, 73573.52852942805, 75490.11274718176, 76320.0, 76986.6150669243, 9100.908990910271, 9107.863382049141, 9120.452772833385, 9223.58493867791, 9240.336739386976, 14692.253475364141, 14740.852591473948, 14840.035397699115, 14890.181040042467, 14980.176090315137, 11849.052075834084, 12059.698507537381, 12146.210496317712, 12240.450269421768, 12434.570024447305, 11600.30398176112, 11653.65039048796, 11670.008049315564, 11684.415779211175, 11925.344106073902, 12301.138920275494, 12429.37853107323, 12637.368131593199, 12693.873061269638, 12715.80926286125, 8906.59920303575, 9146.908530914605, 9207.263418926335, 9240.168384845396, 9389.38968967015, 9559.904400955902, 10260.846087308548, 11996.400179990791, 12327.75344493123, 12397.070219733376], "value": 11199.114054139827, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1351.7972304154375, 1481.0965311160196, 1485.1683057487808, 1485.183149267903, 1507.4799194277978, 10114.44370559619, 10410.271281010333, 11616.070714342854, 11968.341741204242, 12162.0, 10205.285630005903, 11375.805540418261, 11607.419629018537, 12003.579874704386, 12018.278903265787, 2222.1666874921902, 2459.5242854287376, 2510.2469259222207, 2550.1711943618307, 2555.603881398377, 2079.729635147429, 2486.9378265543323, 2531.898724051045, 2533.7972962162985, 2538.796896248305, 2106.262808017197, 2121.087932189158, 2341.0752752662775, 2520.2565243253284, 2560.590305551112, 2469.802415806731, 2481.491294284667, 2485.6395822605623, 2488.50229954009, 2488.688913885764, 2431.7932975697086, 2444.8777561121874, 2454.7422520635255, 2460.458699086198, 2465.976619702821, 11823.763524729457, 11916.642500724905, 12054.216475929037, 12059.517619295219, 12077.275363478131, 6537.869242615121, 6774.187097548276, 6777.423918966893, 6782.898256526156, 6785.660716964132, 4051.6556092732153, 4277.764722940237, 4363.105563359503, 4411.735295882258, 4418.270985287424, 1209.6189700244395, 1228.2446295528187, 1256.7109564800148, 1258.106744211611, 1297.2864924291696, 16646.58383540409, 16655.91672041644, 16810.83189168117, 16877.324907003705, 16912.492625221264, 5887.882242355129, 5957.4042595740075, 6111.205543279345, 6188.2883468400805, 6193.411625895533, 13379.799303010463, 14057.43770249199, 14067.859321406859, 14143.929280353737, 14160.504382346568, 6783.660816959133, 6841.657917104125, 6846.520743548003, 6848.794536163923, 6849.897251541231, 5411.756470958816, 6069.180660610849, 6224.657643829632, 6280.654563998933, 6283.0, 4033.757974521538, 4647.767611619473, 4799.0, 4844.273358996179, 4884.7069175849565, 1428.5571472843244, 1452.7530319845653, 1460.5983354577363, 1463.604826696807, 1473.8894582906325, 746.932776050158, 781.0510230070491, 820.8891799607096, 825.3933358981144, 840.1808236968907, 5609.49514543693, 6737.326267373223, 6778.186617605918, 6851.417629501549, 6978.441724662015, 518.2174915876977, 594.01097173207, 601.1553766957431, 603.7766026570197, 613.4662843326334, 3795.354789685705, 3832.1760821423527, 3931.6068393161027, 3941.7832019239218, 3978.124812541236, 13565.186088834504, 13836.446542138201, 14102.788458173136, 14167.574972750834, 14171.0, 13892.513762018281, 13968.930155349159, 14181.0, 14273.072250303698, 14283.928580357031, 7649.923500765032, 8293.087760346478, 8325.875111873327, 8352.0812710603, 8360.080391156967, 5706.942930570641, 6302.212223472066, 6498.252700939453, 6519.771807986698, 6554.770583029762, 11039.613613523488, 12125.726798686012, 12498.000159986997, 12667.746645067231, 12763.170393924365, 12739.808902866649, 12844.743105138032, 12995.28525931083, 13026.674333141369, 13241.867581324064, 7438.628068596657, 7917.524948503108, 8844.336674749291, 9117.954410227907, 9194.49430281341, 11233.55065797359, 11322.811104834203, 11337.546498140311, 11372.260803047775, 11383.203175777617, 9082.954585227297, 9376.57805398745, 9398.859017114612, 9403.952980235055, 9536.189423899046, 7462.850742985219, 9174.449533028039, 9207.079292070739, 9235.492047937429, 9397.248220142235, 8149.79625509367, 8258.091609922783, 8356.289715374262, 8357.95821020891, 8364.330853531825, 6005.207687538747, 6028.246469191351, 6086.269647642312, 6219.689015549114, 6256.937430625636, 6028.457438830526, 6137.60105593135, 6183.938160618336, 6261.499080073674, 6340.239171299474], "value": 5320.771458690324, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.9085819403342, 399.516584932232, 403.7315185401708, 406.7127541331685, 406.9918601627967, 5207.401148867882, 5341.278927344807, 6071.635701857892, 6309.936900630993, 6386.6806659666945, 5088.592912566995, 5263.86840328992, 5665.093585026397, 5989.760409583622, 6249.4687951524065, 4398.582134697199, 4556.9746806968415, 4756.595689366391, 4757.215059515193, 4770.112358427888, 4689.249720044793, 4720.90558188836, 4773.236282194849, 4775.832845850396, 4777.283407488887, 3519.5248641433336, 4176.477940257468, 4273.529911709709, 4652.022890271638, 4742.881427964311, 4065.573114822945, 4465.285554311295, 4539.205639013176, 4732.716037037789, 4775.14047471455, 4173.807150468214, 4177.9346266702105, 4184.372344148372, 4237.258479766028, 4247.405363249148, 5602.271704678406, 5826.8928903508195, 6084.5436592255755, 6087.360827113178, 6116.0, 5665.773369065232, 5684.772609095631, 5686.147077938301, 5695.14572814077, 5729.828105156852, 5175.689458632456, 5374.656335916021, 5873.709253391181, 6440.645764482952, 6786.491013174032, 4221.810018549173, 4898.0, 4906.386701662293, 4930.506949305077, 4938.753062346868, 6904.827379315507, 7023.192332881682, 7062.964685176593, 7113.0753002109395, 7216.494845360774, 3974.82113304902, 4340.153670034376, 4472.955270447319, 4966.627502937295, 5023.2214006829, 4458.308962110878, 5097.235414687752, 5102.4897510248675, 5128.743562821844, 5135.640505164677, 4715.7877895494785, 4985.180409150634, 5630.774769009276, 5691.601587888808, 5731.312242530923, 6026.54800889935, 6678.6326752028135, 6740.9325906740305, 6758.594484330857, 6762.594244345257, 1484.2411742085662, 1602.7355486344622, 1719.9226034828462, 1725.7066298729246, 1749.9912500437417, 1166.5392170092935, 1195.6174024312136, 1206.1737709668905, 1210.497643477947, 1211.7640007192615, 4841.782119804618, 5302.2576839241765, 6354.555181137276, 6357.682115894187, 6385.584936979081, 5353.518183363516, 6358.887194740902, 6974.651267436608, 6991.965040174767, 6999.405050570656, 5368.771959636707, 6095.2685677718955, 6270.561060725797, 6283.717232724538, 6356.523260755462, 3108.9584989028476, 3477.94783078254, 3546.5034895114704, 3584.6953008994005, 3646.663303077707, 5517.668939863621, 6651.86696266072, 7063.540869843444, 7068.126946359219, 7158.391536719333, 6259.186305780219, 6282.591631543935, 7015.824604384829, 7123.002779610859, 7179.641017949081, 6024.97575412181, 6758.8648227036165, 7080.964595177094, 7150.034745309316, 7159.534630249017, 5923.851903702442, 6252.906206406817, 6428.292887782433, 6907.585544867324, 6917.097798105561, 5233.979374022029, 6584.176977877765, 6769.593824370553, 6789.762358317435, 6856.657167141722, 7127.180374257026, 7141.321574450419, 7161.606111663908, 7171.605561694157, 7186.209516953236, 4325.935110973275, 4331.0, 4369.628581570602, 4403.779811009501, 4428.630682584801, 6758.459323254227, 6854.588724676336, 6892.207396149306, 6918.584884906922, 7023.227444980946, 6629.6353700545005, 6728.495362847708, 6731.596104233761, 6757.391834734897, 6760.053592496956, 6149.661768602769, 6309.022101574264, 6738.561993470409, 6763.5941843489545, 6790.8641827164165, 5431.619786614899, 6227.688615569113, 6515.478761699147, 6614.801555953329, 6621.602703837785, 6547.869042619026, 6730.394264516217, 6751.831204219738, 6764.425023872829, 6780.38976492118, 5703.771849126155, 6509.381608747161, 6517.706703198272, 6556.3443655634055, 6575.671216439255], "value": 4895.812803818165, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [837.7612380471567, 850.9149085091492, 851.2508992086963, 872.7948932000978, 879.6569337958196, 16783.076930768817, 17228.48314550564, 17238.56903577411, 18600.906995465037, 19270.614587708238, 17973.7303940441, 18371.0, 18472.538186545342, 18610.627787444242, 18765.7185142223, 975.7609385700513, 979.8481235408523, 985.6698006167942, 992.0377234082928, 993.0169132558786, 916.6241840845255, 963.2005435488562, 988.0218583602218, 997.4165113408665, 1004.7387679203423, 873.5151990645189, 1038.5170895533574, 1038.532660302863, 1039.433508737736, 1041.0162396535238, 1029.6910926721953, 1034.9948250258738, 1035.316690983947, 1035.5081336365242, 1036.7097212780434, 744.7616762635959, 744.7636922708278, 756.9545827250382, 757.6363345594091, 759.1459607941066, 17040.914795426066, 17441.38955136577, 17596.648067038586, 17605.383811566535, 17620.911895440568, 16890.98654080759, 17133.485995420157, 17275.30898764048, 17468.47594572165, 17470.650586988188, 13752.106113102616, 13790.103643263155, 13916.86083139176, 14016.649583760385, 14069.929650351785, 3429.3655673700196, 3496.702780263681, 3497.667721566447, 3501.6498350165034, 3503.2818272254126, 132800.0, 133073.0, 134699.0, 135324.0, 135661.965070525, 12935.935320323526, 13118.737625247442, 13163.60509184726, 13258.27079510617, 13291.069625126149, 25153.74846251551, 25383.238502844943, 25511.36221594438, 25531.48937021249, 25564.74435255661, 6417.839554011187, 7694.692212311556, 7818.648160832776, 7948.205179482005, 8046.758597242092, 3763.9811800941366, 3842.5965273646425, 3857.3442514772555, 3862.9763112775136, 3864.594217607167, 3778.3387907116144, 3818.217265460574, 3841.1741475582326, 3863.3239183142837, 3869.187470631199, 933.1554942776797, 954.0888451528773, 961.6682244625594, 963.1620490173594, 967.8064387122604, 523.2862375719549, 592.517098564677, 600.1987346891948, 603.0652488642586, 618.1685632823845, 10279.126274266771, 10581.576736930436, 12042.75914481723, 12056.397180140957, 12178.330191839357, 499.74762744814365, 645.6932956845461, 648.0732552449947, 656.5404217048085, 660.2341284110408, 4875.293082503017, 5204.724842413633, 5447.536959358499, 5508.779648814083, 5625.521830644359, 103296.96703033024, 105341.47329263458, 111673.44163279294, 113277.4336128314, 115217.4239128799, 89021.55489222512, 90318.09681903229, 95635.08729825364, 97302.02697973071, 97564.0, 75144.62427687827, 78262.0, 78461.0, 80075.19924800794, 80895.59552202202, 12154.453049612612, 12737.172083814523, 12737.29944853042, 12739.61781146567, 12754.42605082755, 39000.80499597484, 39699.206015880096, 39746.0, 41709.79145104255, 42469.57530424656, 50524.74737626289, 51067.74466127794, 51119.66497193985, 51450.74274628603, 51741.0, 15974.440894568634, 16235.918820406296, 16579.253933573258, 16699.74950375721, 16718.08050557231, 17764.733528997334, 18123.912565246126, 18146.818531815043, 18355.0, 18453.630927381644, 16101.355945762038, 16295.51113466598, 16459.506214813573, 16697.0, 16811.07539085313, 11646.825297620711, 16219.837801621832, 16491.58771030734, 16605.75091373606, 16837.989720616803, 16002.599935001717, 16083.276252568428, 16600.169991500617, 16700.164991750607, 16701.5824604381, 10013.198944084601, 10817.675469735921, 11627.76744465089, 11947.402629868646, 12133.272003679807, 12582.433790479266, 12670.746585068431, 13004.0, 13034.4134513949, 13071.346432678138], "value": 8313.53577164673, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1551.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 113.0, 113.0, 114.0, 114.0, 115.0, 124.0, 173.0, 154.0, 114.0], "value": 127.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [191.0, 110.0, 111.0, 150.0, 108.0, 114.0, 109.0, 112.0, 148.0, 110.0], "value": 126.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 198.0, 219.0, 270.0, 251.0, 195.0, 198.0, 202.0, 198.0, 236.0], "value": 216.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 60.0, 61.0, 90.0, 63.0, 61.0, 72.0, 75.0, 82.0, 58.0], "value": 70.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 73.0, 106.0, 58.0, 73.0, 93.0, 106.0, 57.0, 91.0, 120.0], "value": 86.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 93.0, 92.0, 94.0, 98.0, 111.0, 92.0, 93.0, 119.0], "value": 97.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 99.0, 99.0, 108.0, 124.0, 98.0, 103.0, 153.0, 98.0, 98.0], "value": 107.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 90.0, 90.0, 90.0, 92.0, 97.0, 91.0, 91.0, 85.0, 91.0], "value": 92.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 51.0, 50.0, 51.0, 51.0, 54.0, 53.0, 52.0, 51.0], "value": 51.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 55.0, 63.0, 70.0, 64.0, 60.0, 58.0, 59.0, 59.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 83.0, 83.0, 85.0, 86.0, 84.0, 83.0, 90.0, 88.0], "value": 85.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 138.0, 148.0, 150.0, 137.0, 162.0, 160.0, 155.0, 208.0, 161.0], "value": 155.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 221.0, 187.0, 215.0, 173.0, 160.0, 159.0, 240.0, 239.0, 193.0], "value": 196.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 70.0, 60.0, 79.0, 93.0, 98.0, 79.0, 69.0, 71.0], "value": 75.3, "unit": "score"}]}]} 03:58:48 INFO - Return code: 0 03:58:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:58:48 ERROR - # TBPL SUCCESS # 03:58:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:58:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:58:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:58:48 INFO - 2017-05-01 03:58:48.709 screenresolution[2539:40976] starting screenresolution argv=screenresolution get 03:58:48 INFO - 2017-05-01 03:58:48.712 screenresolution[2539:40976] Display 0: 1600x1200x32@60 03:58:48 INFO - 2017-05-01 03:58:48.718 screenresolution[2540:40979] starting screenresolution argv=screenresolution list 03:58:48 INFO - Available Modes on Display 0 03:58:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:58:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:58:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:58:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:58:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:58:48 INFO - Intel Iris: 03:58:48 INFO - Chipset Model: Intel Iris 03:58:48 INFO - Type: GPU 03:58:48 INFO - Bus: Built-In 03:58:48 INFO - VRAM (Dynamic, Max): 1536 MB 03:58:48 INFO - Vendor: Intel (0x8086) 03:58:48 INFO - Device ID: 0x0a2e 03:58:48 INFO - Revision ID: 0x0009 03:58:48 INFO - Displays: 03:58:48 INFO - Display: 03:58:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:58:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:58:48 INFO - Display Serial Number: 1600x1200 60 03:58:48 INFO - Main Display: Yes 03:58:48 INFO - Mirror: Off 03:58:48 INFO - Online: Yes 03:58:48 INFO - Rotation: Supported 03:58:48 INFO - Return code: 0 03:58:48 INFO - Running post-action listener: _resource_record_post_action 03:58:48 INFO - [mozharness: 2017-05-01 10:58:48.969590Z] Finished run-tests step (success) 03:58:48 INFO - Running post-run listener: _resource_record_post_run 03:58:49 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 1643008; Write bytes: 514930688; Read time: 10; Write time: 1640 03:58:49 INFO - TinderboxPrint: CPU usage
54.0% 03:58:49 INFO - TinderboxPrint: I/O read bytes / time
1,643,008 / 10 03:58:49 INFO - TinderboxPrint: I/O write bytes / time
514,930,688 / 1,640 03:58:49 INFO - TinderboxPrint: CPU idle
2,207.1 (46.0%) 03:58:49 INFO - TinderboxPrint: CPU system
964.9 (20.1%) 03:58:49 INFO - TinderboxPrint: CPU user
1,625.7 (33.9%) 03:58:49 INFO - TinderboxPrint: Swap in / out
209,797,120 / 0 03:58:49 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 204694016; Write bytes: 205436928; Read time: 16109; Write time: 430 03:58:49 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 778752; Write bytes: 302632960; Read time: 8; Write time: 1180 03:58:49 INFO - Running post-run listener: _upload_blobber_files 03:58:49 INFO - Blob upload gear active. 03:58:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:58:49 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:58:49 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:58:49 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:58:49 INFO - (blobuploader) - INFO - Open directory for files ... 03:58:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:58:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:58:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:58:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:58:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:58:50 INFO - (blobuploader) - INFO - Done attempting. 03:58:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:58:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:58:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:58:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:58:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:58:52 INFO - (blobuploader) - INFO - Done attempting. 03:58:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:58:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:58:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:58:53 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:58:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:58:53 INFO - (blobuploader) - INFO - Done attempting. 03:58:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:58:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:58:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:58:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:58:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:58:55 INFO - (blobuploader) - INFO - Done attempting. 03:58:55 INFO - (blobuploader) - INFO - Iteration through files over. 03:58:55 INFO - Return code: 0 03:58:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:58:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:58:55 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/180250e33afbd244214189360ccd071fbe9619a60ddb4eeceb73f30ca0f1d3fc8559f1b180e33d8cb68abcf7b4810cc6ff7e5903b8d2e487ebbf189fb115645f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/badce8fd7cb9f3751f6733e0f8575b8d584028b7006bc188e9123a58c9f3bee962d2670b2488835e72caac238933294ef7f742c995bdc742e1a654d1c0145858", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b3231b41a88c1b2a76c1ca3f239caebe5f650ed8a1e0b3b4fa42aa0d767bbd2c765ac3e1177a5f76612113336cc3c9d179bc47d9493017fcd944053f239b4be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d6aa3f8b4e83600a51e3712a9e5d185a0ae7728cf6b85c654eab178a274f0fb72ee2c7e06a914ebf242198e130773ada2887e9dcce0ac18a88a8b71c6bd0108c"} 03:58:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:58:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:58:55 INFO - Contents: 03:58:55 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/180250e33afbd244214189360ccd071fbe9619a60ddb4eeceb73f30ca0f1d3fc8559f1b180e33d8cb68abcf7b4810cc6ff7e5903b8d2e487ebbf189fb115645f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/badce8fd7cb9f3751f6733e0f8575b8d584028b7006bc188e9123a58c9f3bee962d2670b2488835e72caac238933294ef7f742c995bdc742e1a654d1c0145858", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b3231b41a88c1b2a76c1ca3f239caebe5f650ed8a1e0b3b4fa42aa0d767bbd2c765ac3e1177a5f76612113336cc3c9d179bc47d9493017fcd944053f239b4be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d6aa3f8b4e83600a51e3712a9e5d185a0ae7728cf6b85c654eab178a274f0fb72ee2c7e06a914ebf242198e130773ada2887e9dcce0ac18a88a8b71c6bd0108c"} 03:58:55 INFO - Running post-run listener: copy_logs_to_upload_dir 03:58:55 INFO - Copying logs to upload dir... 03:58:55 INFO - mkdir: /builds/slave/test/build/upload/logs 03:58:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1280.303161 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2017-05-01 03:58:55.390703) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-01 03:58:55.393961) ========= 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.wyKO0rfjKU/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.XpYtnZXDis/Listeners TMPDIR=/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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/Firefox/sha512/180250e33afbd244214189360ccd071fbe9619a60ddb4eeceb73f30ca0f1d3fc8559f1b180e33d8cb68abcf7b4810cc6ff7e5903b8d2e487ebbf189fb115645f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/badce8fd7cb9f3751f6733e0f8575b8d584028b7006bc188e9123a58c9f3bee962d2670b2488835e72caac238933294ef7f742c995bdc742e1a654d1c0145858", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b3231b41a88c1b2a76c1ca3f239caebe5f650ed8a1e0b3b4fa42aa0d767bbd2c765ac3e1177a5f76612113336cc3c9d179bc47d9493017fcd944053f239b4be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d6aa3f8b4e83600a51e3712a9e5d185a0ae7728cf6b85c654eab178a274f0fb72ee2c7e06a914ebf242198e130773ada2887e9dcce0ac18a88a8b71c6bd0108c"} build_url:https://queue.taskcluster.net/v1/task/SFhZjpPLToGWLkXAhCWKyw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011175 build_url: 'https://queue.taskcluster.net/v1/task/SFhZjpPLToGWLkXAhCWKyw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/180250e33afbd244214189360ccd071fbe9619a60ddb4eeceb73f30ca0f1d3fc8559f1b180e33d8cb68abcf7b4810cc6ff7e5903b8d2e487ebbf189fb115645f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/badce8fd7cb9f3751f6733e0f8575b8d584028b7006bc188e9123a58c9f3bee962d2670b2488835e72caac238933294ef7f742c995bdc742e1a654d1c0145858", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b3231b41a88c1b2a76c1ca3f239caebe5f650ed8a1e0b3b4fa42aa0d767bbd2c765ac3e1177a5f76612113336cc3c9d179bc47d9493017fcd944053f239b4be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d6aa3f8b4e83600a51e3712a9e5d185a0ae7728cf6b85c654eab178a274f0fb72ee2c7e06a914ebf242198e130773ada2887e9dcce0ac18a88a8b71c6bd0108c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-01 03:58:55.429629) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 03:58:55.429946) ========= 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.wyKO0rfjKU/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.XpYtnZXDis/Listeners TMPDIR=/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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.004878 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 03:58:55.478255) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-01 03:58:55.478578) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-01 03:58:55.478893) ========= ========= Total master_lag: 0.17 =========