builder: mozilla-beta_yosemite_r7_devedition_test-dromaeojs-e10s slave: t-yosemite-r7-0131 starttime: 1495937374.28 results: success (0) buildid: 20170527181715 builduid: 9e6dfdffae994e5e8fef5e770aa83dda revision: 8856170020cf83c9cc8da98e187125ca6cdab66b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-27 19:09:34.281834) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-27 19:09:34.282539) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-27 19:09:34.282864) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-27 19:09:34.547723) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 19:09:34.548097) ========= 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.64v80QNhjZ/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.2SHmUekvYN/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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-27 19:09:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.26M=0.001s 2017-05-27 19:09:35 (8.26 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.497278 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 19:09:35.112684) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 19:09:35.112988) ========= 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.64v80QNhjZ/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.2SHmUekvYN/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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.023150 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 19:09:35.164447) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 19:09:35.164819) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 8856170020cf83c9cc8da98e187125ca6cdab66b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 8856170020cf83c9cc8da98e187125ca6cdab66b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.64v80QNhjZ/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.2SHmUekvYN/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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-27 19:09:35,215 truncating revision to first 12 chars 2017-05-27 19:09:35,216 Setting DEBUG logging. 2017-05-27 19:09:35,216 attempt 1/10 2017-05-27 19:09:35,216 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/8856170020cf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-27 19:09:35,514 unpacking tar archive at: mozilla-beta-8856170020cf/testing/mozharness/ program finished with exit code 0 elapsedTime=0.563862 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 19:09:35.750480) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-27 19:09:35.750764) ========= script_repo_revision: 8856170020cf83c9cc8da98e187125ca6cdab66b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-27 19:09:35.751136) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-27 19:09:35.751397) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-27 19:09:35.771634) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2017-05-27 19:09:35.771912) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.64v80QNhjZ/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.2SHmUekvYN/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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 19:09:35 INFO - MultiFileLogger online at 20170527 19:09:35 in /builds/slave/test 19:09:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 19:09:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:09:35 INFO - {'append_to_log': False, 19:09:35 INFO - 'base_work_dir': '/builds/slave/test', 19:09:35 INFO - 'blob_upload_branch': 'Mozilla-Beta', 19:09:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:09:35 INFO - 'branch': 'Mozilla-Beta', 19:09:35 INFO - 'buildbot_json_path': 'buildprops.json', 19:09:35 INFO - 'config_files': ('talos/mac_config.py',), 19:09:35 INFO - 'default_actions': ('clobber', 19:09:35 INFO - 'read-buildbot-config', 19:09:35 INFO - 'download-and-extract', 19:09:35 INFO - 'populate-webroot', 19:09:35 INFO - 'create-virtualenv', 19:09:35 INFO - 'install', 19:09:35 INFO - 'run-tests'), 19:09:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:09:35 INFO - 'download_minidump_stackwalk': True, 19:09:35 INFO - 'download_symbols': 'ondemand', 19:09:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:09:35 INFO - 'tooltool.py': '/tools/tooltool.py', 19:09:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:09:35 INFO - '/tools/misc-python/virtualenv.py')}, 19:09:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:09:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:09:35 INFO - 'gecko_profile': False, 19:09:35 INFO - 'gecko_profile_interval': 0, 19:09:35 INFO - 'installer_path': 'installer.exe', 19:09:35 INFO - 'log_level': 'info', 19:09:35 INFO - 'log_name': 'talos', 19:09:35 INFO - 'log_to_console': True, 19:09:35 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:09:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:09:35 INFO - 'opt_config_files': (), 19:09:35 INFO - 'pip_index': False, 19:09:35 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:09:35 INFO - 'cmd': ('bash', 19:09:35 INFO - '-c', 19:09:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:09:35 INFO - 'enabled': True, 19:09:35 INFO - 'halt_on_failure': False, 19:09:35 INFO - 'name': 'check_screen_resolution'},), 19:09:35 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:09:35 INFO - 'cmd': ('bash', 19:09:35 INFO - '-c', 19:09:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:09:35 INFO - 'enabled': True, 19:09:35 INFO - 'halt_on_failure': False, 19:09:35 INFO - 'name': 'check_screen_resolution'},), 19:09:35 INFO - 'run_cmd_checks_enabled': True, 19:09:35 INFO - 'suite': 'dromaeojs-e10s', 19:09:35 INFO - 'system_bits': '32', 19:09:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:09:35 INFO - 'title': 't-yosemite-r7-0131', 19:09:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:09:35 INFO - 'use_talos_json': True, 19:09:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:09:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:09:35 INFO - 'work_dir': 'build'} 19:09:35 INFO - [mozharness: 2017-05-28 02:09:35.956196Z] Running clobber step. 19:09:35 INFO - Running pre-action listener: _resource_record_pre_action 19:09:35 INFO - Running main action method: clobber 19:09:35 INFO - rmtree: /builds/slave/test/build 19:09:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:09:38 INFO - Running post-action listener: _resource_record_post_action 19:09:38 INFO - [mozharness: 2017-05-28 02:09:38.023025Z] Finished clobber step (success) 19:09:38 INFO - [mozharness: 2017-05-28 02:09:38.023266Z] Running read-buildbot-config step. 19:09:38 INFO - Running pre-action listener: _resource_record_pre_action 19:09:38 INFO - Running main action method: read_buildbot_config 19:09:38 INFO - Using buildbot properties: 19:09:38 INFO - { 19:09:38 INFO - "project": "", 19:09:38 INFO - "product": "firefox", 19:09:38 INFO - "script_repo_revision": "production", 19:09:38 INFO - "builddir": "mozilla-beta_yosemite_r7_devedition_test-dromaeojs-e10s", 19:09:38 INFO - "repository": "", 19:09:38 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 DevEdition mozilla-beta talos dromaeojs-e10s", 19:09:38 INFO - "buildid": "20170527181715", 19:09:38 INFO - "pgo_build": "False", 19:09:38 INFO - "basedir": "/builds/slave/test", 19:09:38 INFO - "buildnumber": 0, 19:09:38 INFO - "slavename": "t-yosemite-r7-0131", 19:09:38 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 19:09:38 INFO - "platform": "yosemite_r7_devedition", 19:09:38 INFO - "scheduler": "tests-mozilla-beta-macosx64-devedition-talos", 19:09:38 INFO - "branch": "mozilla-beta", 19:09:38 INFO - "repo_path": "releases/mozilla-beta", 19:09:38 INFO - "revision": "8856170020cf83c9cc8da98e187125ca6cdab66b", 19:09:38 INFO - "stage_platform": "macosx64-devedition", 19:09:38 INFO - "builduid": "9e6dfdffae994e5e8fef5e770aa83dda", 19:09:38 INFO - "slavebuilddir": "test" 19:09:38 INFO - } 19:09:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/f1cfklg2TBSHrfK3G7WepA/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 19:09:38 INFO - Running post-action listener: _resource_record_post_action 19:09:38 INFO - [mozharness: 2017-05-28 02:09:38.028660Z] Finished read-buildbot-config step (success) 19:09:38 INFO - [mozharness: 2017-05-28 02:09:38.028881Z] Running download-and-extract step. 19:09:38 INFO - Running pre-action listener: _resource_record_pre_action 19:09:38 INFO - Running main action method: download_and_extract 19:09:38 INFO - mkdir: /builds/slave/test/build/tests 19:09:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 19:09:38 INFO - trying https://queue.taskcluster.net/v1/task/f1cfklg2TBSHrfK3G7WepA/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 19:09:38 INFO - Downloading https://queue.taskcluster.net/v1/task/f1cfklg2TBSHrfK3G7WepA/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 19:09:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f1cfklg2TBSHrfK3G7WepA/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 19:09:39 INFO - Downloaded 1287 bytes. 19:09:39 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 19:09:39 INFO - Using the following test package requirements: 19:09:39 INFO - {u'awsy': [u'firefox-54.0.en-US.mac.common.tests.zip', 19:09:39 INFO - u'firefox-54.0.en-US.mac.awsy.tests.zip'], 19:09:39 INFO - u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 19:09:39 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 19:09:39 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 19:09:39 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 19:09:39 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 19:09:39 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 19:09:39 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 19:09:39 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 19:09:39 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 19:09:39 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 19:09:39 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 19:09:39 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 19:09:39 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 19:09:39 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 19:09:39 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 19:09:39 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 19:09:39 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 19:09:39 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 19:09:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/f1cfklg2TBSHrfK3G7WepA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 19:09:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f1cfklg2TBSHrfK3G7WepA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 19:09:39 INFO - Fetch https://queue.taskcluster.net/v1/task/f1cfklg2TBSHrfK3G7WepA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 19:09:42 INFO - Expected file size: 51968157 19:09:42 INFO - Obtained file size: 51968157 19:09:59 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 19:09:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/f1cfklg2TBSHrfK3G7WepA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 19:09:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f1cfklg2TBSHrfK3G7WepA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 19:09:59 INFO - Fetch https://queue.taskcluster.net/v1/task/f1cfklg2TBSHrfK3G7WepA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 19:10:01 INFO - Expected file size: 51968157 19:10:01 INFO - Obtained file size: 51968157 19:10:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/f1cfklg2TBSHrfK3G7WepA/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 19:10:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f1cfklg2TBSHrfK3G7WepA/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 19:10:16 INFO - Fetch https://queue.taskcluster.net/v1/task/f1cfklg2TBSHrfK3G7WepA/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 19:10:17 INFO - Expected file size: 14404461 19:10:17 INFO - Obtained file size: 14404461 19:10:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 19:10:18 INFO - trying https://queue.taskcluster.net/v1/task/f1cfklg2TBSHrfK3G7WepA/artifacts/public/build/firefox-54.0.en-US.mac.dmg 19:10:18 INFO - Downloading https://queue.taskcluster.net/v1/task/f1cfklg2TBSHrfK3G7WepA/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 19:10:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f1cfklg2TBSHrfK3G7WepA/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 19:10:20 INFO - Downloaded 74893376 bytes. 19:10:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/f1cfklg2TBSHrfK3G7WepA/artifacts/public/build/firefox-54.0.en-US.mac.dmg 19:10:20 INFO - mkdir: /builds/slave/test/properties 19:10:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:10:20 INFO - Writing to file /builds/slave/test/properties/build_url 19:10:20 INFO - Contents: 19:10:20 INFO - build_url:https://queue.taskcluster.net/v1/task/f1cfklg2TBSHrfK3G7WepA/artifacts/public/build/firefox-54.0.en-US.mac.dmg 19:10:20 INFO - Running post-action listener: _resource_record_post_action 19:10:20 INFO - Running post-action listener: set_extra_try_arguments 19:10:20 INFO - [mozharness: 2017-05-28 02:10:20.856288Z] Finished download-and-extract step (success) 19:10:20 INFO - [mozharness: 2017-05-28 02:10:20.856474Z] Running populate-webroot step. 19:10:20 INFO - Running pre-action listener: _resource_record_pre_action 19:10:20 INFO - Running main action method: populate_webroot 19:10:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:10:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:10:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:10:20 INFO - '--tppagecycles', 19:10:20 INFO - '7'], 19:10:20 INFO - 'tests': ['tsvgm']}}, 19:10:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:10:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:10:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:10:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:10:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:10:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:10:20 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:10:20 INFO - 'talos_options': ['--disable-e10s'], 19:10:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:10:20 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:10:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:10:20 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:10:20 INFO - 'talos_options': ['--disable-e10s'], 19:10:20 INFO - 'tests': ['damp', 'tps']}, 19:10:20 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:10:20 INFO - 'tests': ['damp', 'tps']}, 19:10:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:10:20 INFO - 'tests': ['dromaeo_dom']}, 19:10:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:10:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:10:20 INFO - 'tests': ['basic_compositor_video']}, 19:10:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:10:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:10:20 INFO - 'tests': ['a11yr', 19:10:20 INFO - 'ts_paint', 19:10:20 INFO - 'tpaint', 19:10:20 INFO - 'sessionrestore', 19:10:20 INFO - 'sessionrestore_no_auto_restore', 19:10:20 INFO - 'tabpaint']}, 19:10:20 INFO - 'other-e10s': {'tests': ['a11yr', 19:10:20 INFO - 'ts_paint', 19:10:20 INFO - 'tpaint', 19:10:20 INFO - 'sessionrestore', 19:10:20 INFO - 'sessionrestore_no_auto_restore', 19:10:20 INFO - 'tabpaint']}, 19:10:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:10:20 INFO - 'ts_paint', 19:10:20 INFO - 'tpaint', 19:10:20 INFO - 'sessionrestore', 19:10:20 INFO - 'sessionrestore_no_auto_restore', 19:10:20 INFO - 'tabpaint']}, 19:10:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:10:20 INFO - 'ts_paint', 19:10:20 INFO - 'tpaint', 19:10:20 INFO - 'sessionrestore', 19:10:20 INFO - 'sessionrestore_no_auto_restore', 19:10:20 INFO - 'tabpaint']}, 19:10:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:10:20 INFO - 'tests': ['a11yr', 19:10:20 INFO - 'ts_paint', 19:10:20 INFO - 'tpaint', 19:10:20 INFO - 'sessionrestore', 19:10:20 INFO - 'sessionrestore_no_auto_restore', 19:10:20 INFO - 'tabpaint']}, 19:10:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:10:20 INFO - 'tests': ['a11yr', 19:10:20 INFO - 'ts_paint', 19:10:20 INFO - 'tpaint', 19:10:20 INFO - 'sessionrestore', 19:10:20 INFO - 'sessionrestore_no_auto_restore', 19:10:20 INFO - 'tabpaint']}, 19:10:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:10:20 INFO - 'tests': ['tsvgx', 19:10:20 INFO - 'tsvgr_opacity', 19:10:20 INFO - 'tart', 19:10:20 INFO - 'tscrollx', 19:10:20 INFO - 'cart', 19:10:20 INFO - 'tsvg_static']}, 19:10:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:10:20 INFO - 'tsvgr_opacity', 19:10:20 INFO - 'tart', 19:10:20 INFO - 'tscrollx', 19:10:20 INFO - 'cart', 19:10:20 INFO - 'tsvg_static']}, 19:10:20 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:10:20 INFO - 'talos_options': ['--disable-e10s'], 19:10:20 INFO - 'tests': ['tp5o']}, 19:10:20 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:10:20 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:10:20 INFO - 'talos_options': ['--disable-e10s', 19:10:20 INFO - '--xperf_path', 19:10:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:10:20 INFO - 'tests': ['tp5n']}, 19:10:20 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:10:20 INFO - 'talos_options': ['--xperf_path', 19:10:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:10:20 INFO - 'tests': ['tp5n']}}, 19:10:20 INFO - 'talos.zip': {'path': '', 19:10:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:10:20 INFO - Running post-action listener: _resource_record_post_action 19:10:20 INFO - [mozharness: 2017-05-28 02:10:20.875207Z] Finished populate-webroot step (success) 19:10:20 INFO - [mozharness: 2017-05-28 02:10:20.875343Z] Running create-virtualenv step. 19:10:20 INFO - Running pre-action listener: _resource_record_pre_action 19:10:20 INFO - Running main action method: create_virtualenv 19:10:20 INFO - Creating virtualenv /builds/slave/test/build/venv 19:10:20 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 19:10:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:10:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:10:21 INFO - Using real prefix '/tools/python27' 19:10:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:10:21 INFO - Installing distribute.............................................................................................................................................................................................done. 19:10:24 INFO - Installing pip.................done. 19:10:24 INFO - Return code: 0 19:10:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:10:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:10:24 INFO - Reading from file tmpfile_stdout 19:10:24 INFO - Output received: 19:10:24 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) 19:10:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:10:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 19:10:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 19:10:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:24 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/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 0x108d5cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d5f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffab344a850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b3ad30>, '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 0x108a61db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108b2fbe8>, '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.64v80QNhjZ/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.2SHmUekvYN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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 19:10:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 19:10:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:10:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.64v80QNhjZ/Render', 19:10:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:10:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:10:24 INFO - 'HOME': '/Users/cltbld', 19:10:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:10:24 INFO - 'LOGNAME': 'cltbld', 19:10:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:24 INFO - 'MOZ_NO_REMOTE': '1', 19:10:24 INFO - 'NO_EM_RESTART': '1', 19:10:24 INFO - 'PAGER': '/bin/cat', 19:10:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:10:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:24 INFO - 'PWD': '/builds/slave/test', 19:10:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:10:24 INFO - 'SHELL': '/bin/bash', 19:10:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2SHmUekvYN/Listeners', 19:10:24 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 19:10:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:10:24 INFO - 'USER': 'cltbld', 19:10:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:10:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:10:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:24 INFO - 'XPC_FLAGS': '0x0', 19:10:24 INFO - 'XPC_SERVICE_NAME': '0', 19:10:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:10:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:25 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 19:10:25 INFO - Cleaning up... 19:10:25 INFO - Return code: 0 19:10:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:10:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 19:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 19:10:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:25 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/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 0x108d5cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d5f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffab344a850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b3ad30>, '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 0x108a61db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108b2fbe8>, '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.64v80QNhjZ/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.2SHmUekvYN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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 19:10:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 19:10:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:10:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.64v80QNhjZ/Render', 19:10:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:10:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:10:25 INFO - 'HOME': '/Users/cltbld', 19:10:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:10:25 INFO - 'LOGNAME': 'cltbld', 19:10:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:25 INFO - 'MOZ_NO_REMOTE': '1', 19:10:25 INFO - 'NO_EM_RESTART': '1', 19:10:25 INFO - 'PAGER': '/bin/cat', 19:10:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:10:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:25 INFO - 'PWD': '/builds/slave/test', 19:10:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:10:25 INFO - 'SHELL': '/bin/bash', 19:10:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2SHmUekvYN/Listeners', 19:10:25 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 19:10:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:10:25 INFO - 'USER': 'cltbld', 19:10:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:10:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:10:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:25 INFO - 'XPC_FLAGS': '0x0', 19:10:25 INFO - 'XPC_SERVICE_NAME': '0', 19:10:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:10:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:25 INFO - Downloading/unpacking psutil>=3.1.1 19:10:25 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 19:10:25 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 19:10:25 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 19:10:25 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 19:10:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:10:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:10:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:10:27 INFO - Installing collected packages: psutil 19:10:27 INFO - Running setup.py install for psutil 19:10:27 INFO - building 'psutil._psutil_osx' extension 19:10:27 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 19:10:28 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 19:10:28 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 19:10:28 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 19:10:28 INFO - building 'psutil._psutil_posix' extension 19:10:28 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 19:10:28 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:10:28 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:10:28 INFO - ^ 19:10:28 INFO - 1 warning generated. 19:10:28 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 19:10:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:10:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:10:28 INFO - Successfully installed psutil 19:10:28 INFO - Cleaning up... 19:10:28 INFO - Return code: 0 19:10:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:10:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 19:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 19:10:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:28 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/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 0x108d5cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d5f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffab344a850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b3ad30>, '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 0x108a61db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108b2fbe8>, '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.64v80QNhjZ/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.2SHmUekvYN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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 19:10:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 19:10:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:10:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.64v80QNhjZ/Render', 19:10:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:10:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:10:28 INFO - 'HOME': '/Users/cltbld', 19:10:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:10:28 INFO - 'LOGNAME': 'cltbld', 19:10:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:28 INFO - 'MOZ_NO_REMOTE': '1', 19:10:28 INFO - 'NO_EM_RESTART': '1', 19:10:28 INFO - 'PAGER': '/bin/cat', 19:10:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:10:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:28 INFO - 'PWD': '/builds/slave/test', 19:10:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:10:28 INFO - 'SHELL': '/bin/bash', 19:10:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2SHmUekvYN/Listeners', 19:10:28 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 19:10:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:10:28 INFO - 'USER': 'cltbld', 19:10:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:10:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:10:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:28 INFO - 'XPC_FLAGS': '0x0', 19:10:28 INFO - 'XPC_SERVICE_NAME': '0', 19:10:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:10:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:10:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:10:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:10:30 INFO - Installing collected packages: mozsystemmonitor 19:10:30 INFO - Running setup.py install for mozsystemmonitor 19:10:30 INFO - Successfully installed mozsystemmonitor 19:10:30 INFO - Cleaning up... 19:10:30 INFO - Return code: 0 19:10:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:10:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 19:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 19:10:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x108d5cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d5f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffab344a850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b3ad30>, '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 0x108a61db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108b2fbe8>, '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.64v80QNhjZ/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.2SHmUekvYN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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 19:10:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 19:10:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:10:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.64v80QNhjZ/Render', 19:10:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:10:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:10:30 INFO - 'HOME': '/Users/cltbld', 19:10:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:10:30 INFO - 'LOGNAME': 'cltbld', 19:10:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:30 INFO - 'MOZ_NO_REMOTE': '1', 19:10:30 INFO - 'NO_EM_RESTART': '1', 19:10:30 INFO - 'PAGER': '/bin/cat', 19:10:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:10:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:30 INFO - 'PWD': '/builds/slave/test', 19:10:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:10:30 INFO - 'SHELL': '/bin/bash', 19:10:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2SHmUekvYN/Listeners', 19:10:30 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 19:10:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:10:30 INFO - 'USER': 'cltbld', 19:10:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:10:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:10:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:30 INFO - 'XPC_FLAGS': '0x0', 19:10:30 INFO - 'XPC_SERVICE_NAME': '0', 19:10:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:10:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:30 INFO - Downloading/unpacking jsonschema==2.5.1 19:10: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 19:10: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 19:10: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 19:10: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 19:10:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:10:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:10: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 19:10: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 19:10: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 19:10: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 19:10:32 INFO - Downloading functools32-3.2.3-2.tar.gz 19:10:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:10:32 INFO - warning: no files found matching '*.txt' 19:10:32 INFO - no previously-included directories found matching 'build' 19:10:32 INFO - no previously-included directories found matching 'dist' 19:10:32 INFO - no previously-included directories found matching '.git*' 19:10:32 INFO - Installing collected packages: jsonschema, functools32 19:10:32 INFO - Running setup.py install for functools32 19:10:32 INFO - warning: no files found matching '*.txt' 19:10:32 INFO - no previously-included directories found matching 'build' 19:10:32 INFO - no previously-included directories found matching 'dist' 19:10:32 INFO - no previously-included directories found matching '.git*' 19:10:32 INFO - Successfully installed jsonschema functools32 19:10:32 INFO - Cleaning up... 19:10:33 INFO - Return code: 0 19:10:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:10:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 19:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 19:10:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10: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/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 0x108d5cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d5f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffab344a850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b3ad30>, '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 0x108a61db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108b2fbe8>, '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.64v80QNhjZ/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.2SHmUekvYN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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 19:10:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 19:10:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 19:10:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.64v80QNhjZ/Render', 19:10:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:10:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:10:33 INFO - 'HOME': '/Users/cltbld', 19:10:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:10:33 INFO - 'LOGNAME': 'cltbld', 19:10:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:33 INFO - 'MOZ_NO_REMOTE': '1', 19:10:33 INFO - 'NO_EM_RESTART': '1', 19:10:33 INFO - 'PAGER': '/bin/cat', 19:10:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:10:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:33 INFO - 'PWD': '/builds/slave/test', 19:10:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:10:33 INFO - 'SHELL': '/bin/bash', 19:10:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2SHmUekvYN/Listeners', 19:10:33 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 19:10:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:10:33 INFO - 'USER': 'cltbld', 19:10:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:10:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:10:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:33 INFO - 'XPC_FLAGS': '0x0', 19:10:33 INFO - 'XPC_SERVICE_NAME': '0', 19:10:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:10:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:10:33 INFO - Cleaning up... 19:10:33 INFO - Return code: 0 19:10:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:10:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 19:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 19:10:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10: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/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 0x108d5cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d5f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffab344a850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b3ad30>, '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 0x108a61db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108b2fbe8>, '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.64v80QNhjZ/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.2SHmUekvYN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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 19:10:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 19:10:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:10:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.64v80QNhjZ/Render', 19:10:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:10:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:10:33 INFO - 'HOME': '/Users/cltbld', 19:10:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:10:33 INFO - 'LOGNAME': 'cltbld', 19:10:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:33 INFO - 'MOZ_NO_REMOTE': '1', 19:10:33 INFO - 'NO_EM_RESTART': '1', 19:10:33 INFO - 'PAGER': '/bin/cat', 19:10:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:10:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:33 INFO - 'PWD': '/builds/slave/test', 19:10:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:10:33 INFO - 'SHELL': '/bin/bash', 19:10:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2SHmUekvYN/Listeners', 19:10:33 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 19:10:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:10:33 INFO - 'USER': 'cltbld', 19:10:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:10:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:10:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:33 INFO - 'XPC_FLAGS': '0x0', 19:10:33 INFO - 'XPC_SERVICE_NAME': '0', 19:10:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:10:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:33 INFO - Downloading/unpacking blobuploader==1.2.4 19:10: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 19:10: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 19:10: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 19:10: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 19:10:34 INFO - Downloading blobuploader-1.2.4.tar.gz 19:10:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:10:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:10:35 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 19:10:35 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 19:10:35 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 19:10:35 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 19:10:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:10:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:10:35 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 19:10:35 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 19:10:35 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 19:10:35 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 19:10:35 INFO - Downloading docopt-0.6.1.tar.gz 19:10:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:10:35 INFO - Installing collected packages: blobuploader, requests, docopt 19:10:35 INFO - Running setup.py install for blobuploader 19:10:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:10:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:10:36 INFO - Running setup.py install for requests 19:10:36 INFO - Running setup.py install for docopt 19:10:36 INFO - Successfully installed blobuploader requests docopt 19:10:36 INFO - Cleaning up... 19:10:36 INFO - Return code: 0 19:10:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:10:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 19:10:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 19:10:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:36 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/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 0x108d5cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d5f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffab344a850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b3ad30>, '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 0x108a61db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108b2fbe8>, '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.64v80QNhjZ/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.2SHmUekvYN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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 19:10:36 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:10:36 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:10:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.64v80QNhjZ/Render', 19:10:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:10:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:10:36 INFO - 'HOME': '/Users/cltbld', 19:10:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:10:36 INFO - 'LOGNAME': 'cltbld', 19:10:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:36 INFO - 'MOZ_NO_REMOTE': '1', 19:10:36 INFO - 'NO_EM_RESTART': '1', 19:10:36 INFO - 'PAGER': '/bin/cat', 19:10:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:10:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:36 INFO - 'PWD': '/builds/slave/test', 19:10:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:10:36 INFO - 'SHELL': '/bin/bash', 19:10:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2SHmUekvYN/Listeners', 19:10:36 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 19:10:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:10:36 INFO - 'USER': 'cltbld', 19:10:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:10:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:10:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:36 INFO - 'XPC_FLAGS': '0x0', 19:10:36 INFO - 'XPC_SERVICE_NAME': '0', 19:10:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:10:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:10:37 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-WjUaNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:10:37 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-Fy5ngS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:10:37 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-GT2unk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:10:37 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-dFJdTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:10:37 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-Y4uKmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:10:37 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-4VvBeW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:10:37 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-nlQJjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:10:37 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-h3nq4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:10:37 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-L18aSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:10:37 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-HythS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:10:38 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-VaizA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:10:38 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-fEEEvp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:10:38 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-cJoyjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:10:38 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-FuLHHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:10:38 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-Yja_bb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:10:38 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-_FQUVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:10:38 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-7K8RN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:10:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:10:38 INFO - Running setup.py install for manifestparser 19:10:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:10:38 INFO - Running setup.py install for mozcrash 19:10:39 INFO - Running setup.py install for mozdebug 19:10:39 INFO - Running setup.py install for mozdevice 19:10:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:10:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:10:39 INFO - Running setup.py install for mozfile 19:10:39 INFO - Running setup.py install for mozhttpd 19:10:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:10:39 INFO - Running setup.py install for mozinfo 19:10:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:10:39 INFO - Running setup.py install for mozInstall 19:10:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:10:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:10:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:10:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:10:40 INFO - Running setup.py install for mozleak 19:10:40 INFO - Running setup.py install for mozlog 19:10:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:10:40 INFO - Running setup.py install for moznetwork 19:10:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:10:40 INFO - Running setup.py install for mozprocess 19:10:40 INFO - Running setup.py install for mozprofile 19:10:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:10:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:10:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:10:40 INFO - Running setup.py install for mozrunner 19:10:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:10:40 INFO - Running setup.py install for mozscreenshot 19:10:41 INFO - Running setup.py install for moztest 19:10:41 INFO - Running setup.py install for mozversion 19:10:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:10:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:10:41 INFO - Cleaning up... 19:10:41 INFO - Return code: 0 19:10:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:10:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 19:10:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 19:10:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:41 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/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 0x108d5cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d5f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffab344a850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b3ad30>, '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 0x108a61db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108b2fbe8>, '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.64v80QNhjZ/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.2SHmUekvYN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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 19:10:41 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:10:41 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:10:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.64v80QNhjZ/Render', 19:10:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:10:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:10:41 INFO - 'HOME': '/Users/cltbld', 19:10:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:10:41 INFO - 'LOGNAME': 'cltbld', 19:10:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:41 INFO - 'MOZ_NO_REMOTE': '1', 19:10:41 INFO - 'NO_EM_RESTART': '1', 19:10:41 INFO - 'PAGER': '/bin/cat', 19:10:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:10:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:41 INFO - 'PWD': '/builds/slave/test', 19:10:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:10:41 INFO - 'SHELL': '/bin/bash', 19:10:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2SHmUekvYN/Listeners', 19:10:41 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 19:10:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:10:41 INFO - 'USER': 'cltbld', 19:10:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:10:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:10:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:41 INFO - 'XPC_FLAGS': '0x0', 19:10:41 INFO - 'XPC_SERVICE_NAME': '0', 19:10:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:10:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:10:41 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-sej0pa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:10:41 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)) 19:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:10:41 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-SIgj07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:10:41 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)) 19:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:10:41 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-0qYt9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:10:42 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)) 19:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:10:42 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-h_J_PD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:10:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 19:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:10:42 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-F_8S8X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:10:42 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)) 19:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:10:42 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-67yUIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:10:42 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)) 19:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:10:42 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-5TYxX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:10:42 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)) 19:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:10:42 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-ESsUl4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:10:42 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)) 19:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:10:42 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-MoPg8A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:10:42 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)) 19:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:10:42 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-7pT06q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:10:42 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)) 19:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:10:42 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-rvEPo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:10:42 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)) 19:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:10:42 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-mDM1Z1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:10:43 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)) 19:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:10:43 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-Ve5zop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:10:43 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)) 19:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:10:43 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-TtIIFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:10:43 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)) 19:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:10:43 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-QLnTIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:10:43 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)) 19:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:10:43 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-qjnPD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:10:43 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)) 19:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:10:43 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-HLnhjG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:10:43 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)) 19:10:43 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)) 19:10:43 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)) 19:10:43 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)) 19:10:43 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:10:43 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:10:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:10:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:44 INFO - Downloading blessings-1.6.tar.gz 19:10:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:10:45 INFO - Installing collected packages: blessings 19:10:45 INFO - Running setup.py install for blessings 19:10:45 INFO - Successfully installed blessings 19:10:45 INFO - Cleaning up... 19:10:45 INFO - Return code: 0 19:10:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:10:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:10:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:10:45 INFO - Reading from file tmpfile_stdout 19:10:45 INFO - Current package versions: 19:10:45 INFO - blessings == 1.6 19:10:45 INFO - blobuploader == 1.2.4 19:10:45 INFO - docopt == 0.6.1 19:10:45 INFO - functools32 == 3.2.3-2 19:10:45 INFO - jsonschema == 2.5.1 19:10:45 INFO - manifestparser == 1.1 19:10:45 INFO - mozInstall == 1.12 19:10:45 INFO - mozcrash == 1.0 19:10:45 INFO - mozdebug == 0.1 19:10:45 INFO - mozdevice == 0.49 19:10:45 INFO - mozfile == 1.2 19:10:45 INFO - mozhttpd == 0.7 19:10:45 INFO - mozinfo == 0.9 19:10:45 INFO - mozleak == 0.1 19:10:45 INFO - mozlog == 3.4 19:10:45 INFO - moznetwork == 0.27 19:10:45 INFO - mozprocess == 0.25 19:10:45 INFO - mozprofile == 0.28 19:10:45 INFO - mozrunner == 6.13 19:10:45 INFO - mozscreenshot == 0.1 19:10:45 INFO - mozsystemmonitor == 0.3 19:10:45 INFO - moztest == 0.8 19:10:45 INFO - mozversion == 1.4 19:10:45 INFO - psutil == 3.1.1 19:10:45 INFO - requests == 1.2.3 19:10:45 INFO - wsgiref == 0.1.2 19:10:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:10:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 19:10:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 19:10:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x108d5cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d5f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffab344a850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b3ad30>, '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 0x108a61db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108b2fbe8>, '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.64v80QNhjZ/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.2SHmUekvYN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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 19:10:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 19:10:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:10:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.64v80QNhjZ/Render', 19:10:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:10:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:10:45 INFO - 'HOME': '/Users/cltbld', 19:10:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:10:45 INFO - 'LOGNAME': 'cltbld', 19:10:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:45 INFO - 'MOZ_NO_REMOTE': '1', 19:10:45 INFO - 'NO_EM_RESTART': '1', 19:10:45 INFO - 'PAGER': '/bin/cat', 19:10:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:10:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:45 INFO - 'PWD': '/builds/slave/test', 19:10:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:10:45 INFO - 'SHELL': '/bin/bash', 19:10:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2SHmUekvYN/Listeners', 19:10:45 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 19:10:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:10:45 INFO - 'USER': 'cltbld', 19:10:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:10:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:10:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:45 INFO - 'XPC_FLAGS': '0x0', 19:10:45 INFO - 'XPC_SERVICE_NAME': '0', 19:10:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:10:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:10:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 19:10:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 19:10:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:10:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 19:10:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 19:10:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 19:10:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 19:10:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 19:10:45 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:10:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:10:45 INFO - Cleaning up... 19:10:45 INFO - Return code: 0 19:10:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:10:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 19:10:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 19:10:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x108d5cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d5f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffab344a850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b3ad30>, '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 0x108a61db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108b2fbe8>, '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.64v80QNhjZ/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.2SHmUekvYN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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 19:10:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:10:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:10:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.64v80QNhjZ/Render', 19:10:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:10:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:10:45 INFO - 'HOME': '/Users/cltbld', 19:10:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:10:45 INFO - 'LOGNAME': 'cltbld', 19:10:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:45 INFO - 'MOZ_NO_REMOTE': '1', 19:10:45 INFO - 'NO_EM_RESTART': '1', 19:10:45 INFO - 'PAGER': '/bin/cat', 19:10:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:10:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:45 INFO - 'PWD': '/builds/slave/test', 19:10:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:10:45 INFO - 'SHELL': '/bin/bash', 19:10:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2SHmUekvYN/Listeners', 19:10:45 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 19:10:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:10:45 INFO - 'USER': 'cltbld', 19:10:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:10:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:10:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:45 INFO - 'XPC_FLAGS': '0x0', 19:10:45 INFO - 'XPC_SERVICE_NAME': '0', 19:10:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:10:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:10:46 INFO - Cleaning up... 19:10:46 INFO - Return code: 0 19:10:46 INFO - Running post-action listener: _resource_record_post_action 19:10:46 INFO - Running post-action listener: _start_resource_monitoring 19:10:46 INFO - Starting resource monitoring. 19:10:46 INFO - [mozharness: 2017-05-28 02:10:46.208049Z] Finished create-virtualenv step (success) 19:10:46 INFO - [mozharness: 2017-05-28 02:10:46.209062Z] Running install step. 19:10:46 INFO - Running pre-action listener: _resource_record_pre_action 19:10:46 INFO - Running main action method: install 19:10:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:10:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:10:46 INFO - Reading from file tmpfile_stdout 19:10:46 INFO - Detecting whether we're running mozinstall >=1.0... 19:10:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:10:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:10:46 INFO - Reading from file tmpfile_stdout 19:10:46 INFO - Output received: 19:10:46 INFO - Usage: mozinstall [options] installer 19:10:46 INFO - Options: 19:10:46 INFO - -h, --help show this help message and exit 19:10:46 INFO - -d DEST, --destination=DEST 19:10:46 INFO - Directory to install application into. [default: 19:10:46 INFO - "/builds/slave/test"] 19:10:46 INFO - --app=APP Application being installed. [default: firefox] 19:10:46 INFO - mkdir: /builds/slave/test/build/application 19:10:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 19:10:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 19:11:06 INFO - Reading from file tmpfile_stdout 19:11:06 INFO - Output received: 19:11:06 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 19:11:06 INFO - Running post-action listener: _resource_record_post_action 19:11:06 INFO - [mozharness: 2017-05-28 02:11:06.703739Z] Finished install step (success) 19:11:06 INFO - [mozharness: 2017-05-28 02:11:06.703892Z] Running run-tests step. 19:11:06 INFO - Running pre-action listener: _resource_record_pre_action 19:11:06 INFO - Running main action method: run_tests 19:11:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:11:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:11:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:11:06 INFO - 2017-05-27 19:11:06.719 screenresolution[3237:69453] starting screenresolution argv=screenresolution get 19:11:06 INFO - 2017-05-27 19:11:06.721 screenresolution[3237:69453] Display 0: 1600x1200x32@60 19:11:06 INFO - 2017-05-27 19:11:06.728 screenresolution[3238:69455] starting screenresolution argv=screenresolution list 19:11:06 INFO - Available Modes on Display 0 19:11:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:11:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:11:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:11:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:11:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:11:06 INFO - Intel Iris: 19:11:06 INFO - Chipset Model: Intel Iris 19:11:06 INFO - Type: GPU 19:11:06 INFO - Bus: Built-In 19:11:06 INFO - VRAM (Dynamic, Max): 1536 MB 19:11:06 INFO - Vendor: Intel (0x8086) 19:11:06 INFO - Device ID: 0x0a2e 19:11:06 INFO - Revision ID: 0x0009 19:11:06 INFO - Displays: 19:11:06 INFO - Display: 19:11:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:11:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:11:06 INFO - Display Serial Number: 1600x1200 60 19:11:06 INFO - Main Display: Yes 19:11:06 INFO - Mirror: Off 19:11:06 INFO - Online: Yes 19:11:06 INFO - Rotation: Supported 19:11:06 INFO - Return code: 0 19:11:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:11:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:11:06 INFO - Python 2.7.3 19:11:06 INFO - Return code: 0 19:11:06 INFO - grabbing minidump binary from tooltool 19:11:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 19:11:06 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 0x108b3ad30>, '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 0x108a61db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108b2fbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:11:06 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 19:11:06 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 19:11:06 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 19:11:07 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:11:07 INFO - Return code: 0 19:11:07 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:11:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:11:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:11:07 INFO - ENV: RUST_BACKTRACE is now 1 19:11:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:11:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:11:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f1cfklg2TBSHrfK3G7WepA/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0131', '--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 19:11:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/f1cfklg2TBSHrfK3G7WepA/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0131 --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 19:11:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.64v80QNhjZ/Render', 19:11:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:11:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:11:07 INFO - 'HOME': '/Users/cltbld', 19:11:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:11:07 INFO - 'LOGNAME': 'cltbld', 19:11:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:11:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:11:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:07 INFO - 'MOZ_NO_REMOTE': '1', 19:11:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:11:07 INFO - 'NO_EM_RESTART': '1', 19:11:07 INFO - 'PAGER': '/bin/cat', 19:11:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:11:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:07 INFO - 'PWD': '/builds/slave/test', 19:11:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:11:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:11:07 INFO - 'RUST_BACKTRACE': '1', 19:11:07 INFO - 'SHELL': '/bin/bash', 19:11:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2SHmUekvYN/Listeners', 19:11:07 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 19:11:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:11:07 INFO - 'USER': 'cltbld', 19:11:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:11:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:11:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:07 INFO - 'XPC_FLAGS': '0x0', 19:11:07 INFO - 'XPC_SERVICE_NAME': '0', 19:11:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:11:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f1cfklg2TBSHrfK3G7WepA/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0131', '--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 19:11:07 INFO - mozversion application_buildid: 20170527181715 19:11:07 INFO - mozversion application_changeset: 8856170020cf83c9cc8da98e187125ca6cdab66b 19:11:07 INFO - mozversion application_display_name: FirefoxDeveloperEdition 19:11:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:11:07 INFO - mozversion application_name: Firefox 19:11:07 INFO - mozversion application_remotingname: firefox-dev 19:11:07 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 19:11:07 INFO - mozversion application_vendor: Mozilla 19:11:07 INFO - mozversion application_version: 54.0 19:11:07 INFO - mozversion platform_buildid: 20170527181715 19:11:07 INFO - mozversion platform_changeset: 8856170020cf83c9cc8da98e187125ca6cdab66b 19:11:07 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 19:11:07 INFO - mozversion platform_version: 54.0 19:11:07 INFO - using testdate: 1495937467 19:11:07 INFO - actual date: 1495937467 19:11:07 INFO - starting webserver on 'localhost:49420' 19:11:07 INFO - SUITE-START | Running 2 tests 19:11:07 INFO - TEST-START | dromaeo_css 19:11:07 INFO - operating with platform_type : mac_ 19:11:07 INFO - Initialising browser for dromaeo_css test... 19:11:07 INFO - TEST-INFO | started process 3248 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/tmpmEHYF5/profile http://localhost:49420/getInfo.html) 19:11:10 INFO - PROCESS | 3248 | 2017-05-27 19:11:10.155 plugin-container[3252:69633] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4a4f, name = 'com.apple.tsm.portname' 19:11:10 INFO - PROCESS | 3248 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:11:10 INFO - PROCESS | 3248 | 2017-05-27 19:11:10.156 plugin-container[3252:69633] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x940b, name = 'com.apple.CFPasteboardClient' 19:11:10 INFO - PROCESS | 3248 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:11:10 INFO - PROCESS | 3248 | 2017-05-27 19:11:10.156 plugin-container[3252:69633] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:11:10 INFO - PROCESS | 3248 | __metrics Screen width/height:1600/1200 19:11:10 INFO - PROCESS | 3248 | colorDepth:24 19:11:10 INFO - PROCESS | 3248 | Browser inner width/height: 1024/689 19:11:10 INFO - PROCESS | 3248 | __metrics 19:11:10 ERROR - PROCESS | 3248 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3371: TypeError: this.tabs is undefined 19:11:10 INFO - TEST-INFO | 3248: exit 0 19:11:10 INFO - Browser initialized. 19:11:10 INFO - Running cycle 1/1 for dromaeo_css test... 19:11:10 INFO - TEST-INFO | started process 3253 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/tmpmEHYF5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:11:13 INFO - PROCESS | 3253 | 2017-05-27 19:11:13.380 plugin-container[3254:69758] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 19:11:13 INFO - PROCESS | 3253 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:11:13 INFO - PROCESS | 3253 | 2017-05-27 19:11:13.380 plugin-container[3254:69758] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4717, name = 'com.apple.CFPasteboardClient' 19:11:13 INFO - PROCESS | 3253 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:11:13 INFO - PROCESS | 3253 | 2017-05-27 19:11:13.380 plugin-container[3254:69758] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:11:23 INFO - PROCESS | 3253 | RSS: Main: 203235328 19:11:23 INFO - PROCESS | 3253 | 19:14:25 INFO - PROCESS | 3253 | Cycle 1(1): loaded http://localhost:49420/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49420/tests/dromaeo/cssquery-ext.html) 19:14:27 INFO - PROCESS | 3253 | RSS: Main: 216576000 19:14:27 INFO - PROCESS | 3253 | 19:17:30 INFO - PROCESS | 3253 | Cycle 1(1): loaded http://localhost:49420/tests/dromaeo/cssquery-ext.html (next: http://localhost:49420/tests/dromaeo/cssquery-jquery.html) 19:17:30 INFO - PROCESS | 3253 | RSS: Main: 229949440 19:17:30 INFO - PROCESS | 3253 | 19:20:32 INFO - PROCESS | 3253 | Cycle 1(1): loaded http://localhost:49420/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49420/tests/dromaeo/cssquery-mootools.html) 19:20:33 INFO - PROCESS | 3253 | RSS: Main: 231297024 19:20:33 INFO - PROCESS | 3253 | 19:23:35 INFO - PROCESS | 3253 | Cycle 1(1): loaded http://localhost:49420/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49420/tests/dromaeo/cssquery-prototype.html) 19:23:35 INFO - PROCESS | 3253 | RSS: Main: 235298816 19:23:35 INFO - PROCESS | 3253 | 19:26:38 INFO - PROCESS | 3253 | Cycle 1(1): loaded http://localhost:49420/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49420/tests/dromaeo/cssquery-yui.html) 19:26:39 INFO - PROCESS | 3253 | RSS: Main: 237461504 19:26:39 INFO - PROCESS | 3253 | 19:29:41 INFO - PROCESS | 3253 | Cycle 1(1): loaded http://localhost:49420/tests/dromaeo/cssquery-yui.html (next: http://localhost:49420/tests/dromaeo/cssquery-dojo.html) 19:29:41 INFO - PROCESS | 3253 | RSS: Main: 234885120 19:29:41 INFO - PROCESS | 3253 | 19:29:41 INFO - PROCESS | 3253 | __start_tp_report 19:29:41 INFO - PROCESS | 3253 | _x_x_mozilla_page_load 19:29:41 INFO - PROCESS | 3253 | _x_x_mozilla_page_load_details 19:29:41 INFO - PROCESS | 3253 | |i|pagename|runs| 19:29:41 INFO - PROCESS | 3253 | |0;dojo.html;3447.5173475713395;3452.9654703452957;3515.2442224921638;3528.7706299090555;3537.0626783902253;5929.407059294073;5933.228680271564;5951.523878089753;6016.699165041752;6048.637081775086;5977.491913187384;6013.969930150354;6042;6060.636361818294;6062.181605483259;5387.568994480442;5394.136938089907;5447.700376479292;5491.423400542925;5556.777728890839;5473.917891231615;5502.642328248651;5505.449455054502;5515.586331025189;5515.862103447426;4840.443349014856;4868.513148685139;5404.567634589243;5472.2338872557875;5482.314710661168;5486.753096110685;5507.311586051744;5513.807016754415;5525.557955363582;5561.277033985596;5292.788288468457;5423.484768946943;5447.346318441812;5467.261919640838;5476.616636835423;5111.926495435963;5754.625949313281;5793.188953546507;5980.940190598082;6022.6687532185715;6258.78094266703;6288.622682639057;6305.0857625644485;6312.905306420407;6333.588316759396;6432.678366081724;6441.710123044474;6456.741730330781;6459.612423254573;6462.903056454157;5853.765849366063;6146.385361463817;6162.938370616282;6174.44430001302;6174.845628859224;5729.369769325371;6340.302566717657;6355.777547785805;6473.126127972663;6492.967535162294;5811.128330750421;5817.331006934257;6357.841053973688;6374.458171055419;6396.552241343062;6349.365063493706;6451.806445806634;6464.159659244268;6468.935310646927;6470.773522926675;6247.09417134522;6266.154069200691;6290.465310448663;6317.747290108436;6350.333215012357;6248.9062664060075;6314.684265786692;6319.55763096588;6342.778002769881;6344.143540621957;4925.852224433273;4930.975345123252;4935.358403407534;4943.2585112233455;4944.035912996931;3951.565327813938;4281.657467402601;4365;4417.558244175621;4428.579284967923;5859.267591551056;5896.086106653475;5932.080527518242;5942.64344139353;5945.821625351246;6259.123722678829;6411.447872010831;6424.903626445607;6438.195225596801;6448.161738973903;5789.218455508452;5804.245448091806;5824.912626310609;5953.880922381528;5961.940380596226;5591.720413979285;5596.720163991784;5603.635763675348;5607;5613.887722245532;6623.4701223901975;6640.402363787089;6649.368310010541;6650.135482387453;6650.3349665034075;6262.968685156545;6313.779017734358;6314.62112273265;6328.525360597881;6341.682915854281;6592.736290548324;6616.603003819786;6633.1045308882685;6636.104125943129;6655.101561289164;6362.840928976628;6379.872402552016;6383.968080159755;6386.425221730066;6392.616443013434;6265.686715664107;6296.622202667854;6321.083442900662;6336.524760643062;6433.2601750797385;5929.288485381781;5976.133460648095;6228.937710622836;6328.177336946167;6342.334054924167;6319.146915166394;6328.398802113792;6335.873282534416;6339.302676705651;6358.395952384516;6044.093385992136;6110.663913484801;6166.105914642441;6168.414000670109;6232.158658581034;6253.687315634109;6325.905111423241;6335.303116657256;6339.397757213057;6353.205849268841;6190.1952746142715;6221.160143380585;6258.280297765815;6259.874802504016;6272.278687950944 19:29:41 INFO - PROCESS | 3253 | |1;ext.html;678.6911955060448;851.9403641745079;866.9913300866989;869.904310525842;871.7254064969534;40351.79824100879;41032.7690169295;41206.58793412069;42554.574454255446;42740.358894616606;33606.823761168365;39402.605973940255;40336.798316008455;40347.79826100873;40406.39390409139;9102.499362535042;9419.576119074623;9502.192313653348;9503.14471697547;9505.762355941122;9317.81364372712;9374.390664606814;9380.202682771973;9398.0132086131;9426.387284826498;9345.57944892478;9390.577424015935;9418.340716149873;9425.38734982224;9425.905740942571;7983.960080199562;9367.76580585484;9373.906260937372;9380.812383752322;9436.245100391952;7831.882521762178;8457.238848503664;8461.66153353865;9159.267258619295;9178.311626627963;35604.28791424183;35870.28259434823;35894;35898.820505897565;36093.27813443742;3827.4641550182996;3850.9229815403537;3853.903652408684;3911.9608803911883;3960.8019599019935;26101.477970440486;27562.724372756216;27565.31086722828;27600.309992250153;27605.723942760516;2606.7262937391492;2955.157780032702;3024.4404785114825;3115.517094850302;3158.510430883217;372081.99999999726;373887;373889;374387;374811;45611.54388456139;45688.543114569096;45973.54026459759;46044;46135.76932115318;39218.60781392206;48089;48157.75921120442;48533.5146648536;48614;14105.73048425626;14244.430222790972;14352.354144063542;14352.641183970276;14358.210298433478;11281.266717663326;12080.395980200954;12349.444275007647;12385.318807465675;12392;10807.83788243177;11894.583689570996;11968;11999.760004799855;12076.939615302043;5655;5660.8867822643315;5679.062954612443;5683.60214784961;5723.7996670116345;1146.873843877173;1147.8450409194652;1179.722765150189;1186.4186548591128;1187.1511869013525;26994.460110797674;27464.862675686494;27518.587221191698;27553.724462755516;27632.309192269953;971.2763990826738;1047.9528421221064;1263.0044529643142;1310.4904108632054;1313.2776972664997;10849.45037916105;12674.176178548365;13733.176009439267;13868.583942481742;13871.167729936034;496408;506499;510349;613855;615102;50960.72598185075;51308.48691513037;51394.48605513972;51575;51588.742056290226;1231.482777233564;1260.357217818919;1341.8926485881302;1444.2056868722161;1465.8387577366482;26382.472350553264;28096.85951570229;28368.85815570909;28976.69604867828;29101;40609.984750381474;41723.582764171966;42193.36709949415;42204;42220;413081;413581;416381;416494;417486;24414.80266775999;29314.796226660485;30413.239669007566;30426.54360184643;30518.237044074074;35742;37542.812285938395;38285;39067.41398879076;39099;22638.773612264325;23504;27530.17409477719;28158;28767.856160719064;28145;28541.857290713415;28908.71091289144;29184;29229.7077029227;32498.67501325051;33241.83379083089;33501.66498334985;33578.3284334307;33978.98063058112;26844.865775671777;27657.86171069132;27984.72015279821;28259;29089.563656545593;20231.898840505703;21252.256171034558;22344.882755862465;23368.76631233734;23486.295411137693 19:29:41 INFO - PROCESS | 3253 | |2;jquery.html;377.1890435563538;415.36034506859454;419.71669123341735;426.96370808481265;455.2942938445409;19899.204031838726;20788.48028799279;22185;22324.776752232472;22422.990965406556;21335.466613334673;21480.89979224858;21548.461288467795;21853.907304634744;22009.22967696131;6684.5989240645595;6953.79138625842;6997.615131167784;7002.054722612458;7077.469189810759;6485.902711459332;6876.7593134240315;6908.1364829396325;6935.237123916365;6941.167059952788;6548.27968923418;6860.142482189726;6917.7578784742545;6947.79156625302;6962.547434416772;6896.48276379271;6911.7926462206215;6965;6967.8606427871155;6969.756058537952;6416.967915160394;6732.764353247613;6793.932060679379;6802.319768023208;6812.897806532906;26077.60883586748;26256.343591410176;26273.73726262732;26524;26536.86731566349;3070.186400603842;3073.8770449182007;3101.720845123927;3103.1311232854837;3111.5643809866638;15784.368625254976;16431.671366572722;16481.587960300967;16572.75140872888;16846.24191911367;1706.2492503298508;2082.739657542807;2090.2304446608155;2103.05362586835;2106.894655267246;111861.44069279682;125248;129622;131185;132049.33975330158;17497.912510437367;21350.252741153985;22345.882705864966;22586.435339116324;22785.658215126787;36264.456033159;36289.72985945479;36820.81589592035;37076.62923370732;37084.62915370866;10630.627928022483;11144.442777861075;11259.268147570545;11317.49071291794;11340.376279304717;7276.854462910712;8918.910810891808;8958.552072396484;9007.864882026775;9064.546772661472;8727.60725767342;10309.556662067167;10767.461626918623;10980.066694331072;11031.558737650405;3593.6406359363855;3605.2789442111684;3755.4366844973474;3783.640554147407;4054.270231358325;1119.8376235445814;1120.9551617935192;1134.5064896769932;1149.0922171484601;1157.6295585412756;18267.451976440727;21882.796446195294;22373.888130559568;22383.888080559493;22439;1114.136544178252;1128.5542210826677;1154.08827026648;1160.9377419661084;1162.8197629367462;11129.387883666475;11869.674882326195;11917.64247072572;11972.521099155936;12015.639530814089;761870;783364;790304;795011;804136;116524;122149.38925305316;126356;129195;162271;1074.462768615692;1229.557359350633;1302.2121616421928;1307.7384523095418;1308.2804457548311;19788.40634780959;19919.402417927486;20295.391138265877;20592;20599.38201853947;67375;67685;67713;68629.62740745058;68781.3121868795;96126.55810162993;96623.51688241796;97228.54157187506;97475.51262243644;98800;8938.86591701138;10447.902970188325;11609.825852612048;11676.70808229801;12016.579419720269;12529.624111276677;12801.935990320362;12832.55086071983;13207.207567545978;13250;11140.442977851237;11163.609273675382;11319.264247824194;11366.261193022427;11587.768244635228;7425.888611670721;10206.234532410248;10335.276530643083;10352.223583231438;10566.682999510027;10856.077233434931;10996.890031099587;11288;11496.712582185512;11952.282863028246;11796.52813887435;11846.763064738485;11854.762904741685;12079.335636539723;12172.513099476277;10141.442220677933;11219.158563107963;11425.542978280775;11476.598319058792;11585 19:29:41 INFO - PROCESS | 3253 | |3;mootools.html;1557.1280083153442;1582.9947983030772;1591.6896205239982;1598.4964736108127;1610.991945040275;10892.673219803408;11152.888471115286;11468.025217856471;11544.942275288611;11547.538098476061;11086.833697494543;11195.888041119586;11238.606648767294;11251.324920504776;11289.435528223576;2070.9792902071013;2359.8702071386065;2393.9521209575796;2415.879206039691;2418.056957786465;1980.2079168332639;2327.3716096653893;2380.7619238076227;2416.5529377065213;2421.092090466075;1971.7239586457908;2373.9406514837096;2392.724836643782;2402.987985060081;2410.927672169838;2018.7685511837767;2256.3569382725846;2357.799587035104;2369.5379401016808;2371.5019845832394;2374.03851440167;2386.140989243871;2386.7971222446113;2391.8564886106888;2395.2215529952837;11429.885701142965;11454.94272528632;11532.192746507748;11539.365334906577;11615.6515304541;5688.800891968761;5762.855928601776;5839.124131380285;5840.386759390245;5848.444397782204;3331.766776325658;3398.9660103398896;3461.7749846259912;3592.497050412944;3604.6936010439144;1047.7223535763028;1155.3703231738723;1191.3864359854595;1221.7312191317897;1249.6063739921985;13753.79369309461;14057.226852523107;14773.335199915922;15247.542573722805;15261;4199.538050814408;4225.4506914101585;4606.170889239969;4722;4730.597899178609;11568.421578921021;11594.304341739522;11602.825957610643;11606;11610.593629222936;5706.172604972256;5716.371199168088;5720.056190728566;5725.456081672234;5729.083346664514;5137.640365174477;5228.163493841043;5270.631055826056;5286.180642000496;5298.708571028554;3842.9231415372096;3900.278448487039;3923.1761330120994;3972.3644216925154;3999.6000399960353;1016.11090295991;1018.4398580780542;1022.437659287389;1033.379972016799;1033.7725700345911;717.2146499582948;770.3452065744073;815.8286759780513;843.4854738609444;844.6368061733514;6804.489663275274;6816.807058764696;6852.828679283058;6879.837698192621;6970.268121847234;963.8410259729246;977.7457860956202;980.4901451245455;986.3440811860032;1016.0753714120116;4179.9791001045405;4194.727342722713;4206.8737937861915;4329.069250111241;4352.7823608819435;13252.469901203844;13759.17444953306;13765.105268157538;13800.654983625289;13854.445822167001;13485.393157307944;13503.932480337731;13683.863161368457;13700.040997130105;13712.3829427676;8788.692395766118;10283.794324113625;10362.481875906175;10378.792424151474;10391.896081039093;6047.909281360695;6905.827354316182;6938.27148149437;7094.11323584552;7116.323949224816;11959.222650527689;12024.579139730067;12081.456334464794;12184.390780460764;12188.085893557842;12078.33569153705;12294.938525307316;12316.630501084981;12410.069244806857;12559.87440125587;8354.665813367397;8524.829503410021;8537.615807288563;8539.060703322506;8546.059933407445;10141.49292535385;10168.898311016796;10178.796424071328;10241.283110182514;10348.844767328346;8717.171868672465;8815.294776417742;8845.203931646183;8954.015058343708;8974.41666291689;7246.673899674422;8517.48895066298;8561.48631082137;8667.349948753996;8808.383413161017;7538.924610754042;7743.303102720557;7771.145174030739;7833.569153696373;7927.60361981887;5555.694436805853;5615.298087739033;5700.315962084576;5737.196792449144;5893.5874488785375;5933.436323549256;6018.969905150446;6107.450329470369;6153.630782153085;6253.062040693932 19:29:41 INFO - PROCESS | 3253 | |4;prototype.html;331.6882130797051;383.80425982748824;385.2180074448868;396.3796658229872;401.97387169833956;4642.651801114917;4867.9269810952865;4945.727984960826;5355.536453231513;5360.571154307656;4271.231178387889;4415.801288941997;4702.929456058153;4734.839964208773;5264.921026184601;3883.252536358636;4213.431186789775;4369;4431.401760762296;4434.733915965036;3970.622790834866;4075.8004966101616;4400.183882315321;4406.730533775109;4415.337699345092;3762.7930463824478;4368.453943257093;4374.934375984363;4394.252976993918;4405.405270288502;3947.4868267125375;4015.337469317559;4235.661147108255;4346.130773845212;4409.626635623735;3801.543814742221;3996.680265578747;4016.0763024504236;4034.7088931541916;4049.0564529025937;4396.746407658342;4404.656579743177;4424.535423780521;4491.73049617024;5169.974150129263;4317.071829556629;4672.345871577982;4806.591439727627;4906.803727850882;5086.821961231339;5329.733513324319;5461.863453413656;5567.916481252784;5690.317161940552;5698.6580805151825;3709.703223742094;3766.6798322142376;3891;4473.628976642385;4531.77341132942;5374.119058329593;5413.323334583177;5641.830745077655;5927.199828023205;6031.37152968696;3966.2067586482817;4162.8353256307155;4490.416245888014;4630.282306242538;4650.395448591661;4235.755049823599;4245.705059956743;4711.010687755541;4754.97767979886;4761.285807128958;4154.729942553724;4155.8753237402325;4908.705477671279;5069.9746501267255;5129.281900533928;4686.343911852344;5619.943800561942;5624.493795558419;5680.7727690892725;5691.260136182353;1365.6654119740726;1466.4574107580263;1531.923403829804;1597.7922870026823;1613.6687233032794;1094.2395035450286;1137.6587023892964;1174.0724827386268;1208.800547909585;1218.7440637466054;4539.977300113478;4960.131976904099;5042.848219862586;5084.6440749147205;5105.821296254613;5316.893662126736;5411.323584551931;5712.571557133231;5853.765849366063;5883.588148829541;4414.381986521889;4862.513748625109;4971.37857767779;5001.7499125043605;5141.331626888481;2758.1725482355214;2861.3275880168144;2868.182567968119;3045.9847700761356;3062.11679816911;5886.529077673776;6105.45050945417;6113.23584551931;6141.539384546177;6146.938530614726;5130.30740849988;5597.832065038056;5622.891415719106;5699.686517241592;5993.61041532299;5170.37955445349;5189.4032186299055;5567.944320556742;5872.678647304322;6067.7876274331065;5519.862003449946;5858.3596592954045;5860.267466566679;5902.675352855634;5942.376050514634;4898.228364159649;5048.495150484922;5195.76619052136;5746.42535746422;5806.303243610625;5483.698396588226;5505.642133261325;6075.210222671025;6090.015892212872;6114.908276375947;3982.820773065277;4140.171965606831;4179.749215047107;4371.1039236956985;4606.539346065367;5166.2508936203285;5176.4047134580005;5213.869653258699;5397.277382290496;5541.556675466034;4933.827316043921;5318.883034562785;5353.705546194997;5355.902040081696;5488.341399032141;4762.738049407316;4860.091307779239;4987.900241995212;5246.717677810165;5669.603127781016;4849.248366503198;4984.501549844987;5426.879544262144;5460.116259890331;5558.861028474321;4969.428515720739;5212.713300768342;5683.232763576864;5701.572382071278;5820.912686309624;5245.763940622757;5443.872073438649;5489.011977844027;5497.39528651856;5542.7782888684005 19:29:41 INFO - PROCESS | 3253 | |5;yui.html;644.9903251451229;729.9781006569798;781.4842204145261;789.9921000789991;870.5560164316199;15568.53294401167;16628.66742665146;16784.49646510605;16793.412230571932;16836.410725624606;14755.336009879555;15576.53270401887;15794.210289485538;15856;15862.3655053798;973.7662960889388;975.4098770244007;991.8363470027437;993.696922438656;999.2405771613553;958.3866325551653;983.9570055740937;984.1388784813288;986.2603047714215;986.378581493658;1014.3052009373566;1027.1064174168484;1028.8713910761155;1044.958201671932;1047.565260416926;1030.5723124903157;1038.5222797513154;1039.3504059962524;1039.6932904793105;1040.9063184313372;762.0969151555424;769.0002996105042;770.4106358635648;770.5569297653872;774.403709143956;16867.578310542212;17309.913450432792;17428.825711742847;17438;17596.912015439968;14214.360353784;14293.928530357281;14383.928080359532;14456.566303010926;14508.637284067878;11804.645860624196;11813.1140164488;11858.229215100991;11961.282323060645;12104.910558049729;3654.634536546351;3759.1166075972124;3797.677197438221;3903.1022864741267;3913.3542965410675;111267;116904;116955;117044;117427.41286293513;10824.512896919658;11120;11318.037966772916;11404.771904562029;11610.941945290388;18576.907115464608;23030.424239393815;23220.88389558075;23341.416464588183;23570.882145589505;7488.962555187298;7754.5734984575265;7765.378769698524;7823.2567906048835;7851;4384.934225986613;4410.669199810027;4475.507694153641;4506.662000349921;4558;3573.821308934595;3635.109398197406;3663.9740872555726;3679.0618392310325;3681.6686498214754;646.0664340028613;646.9610636277273;653.6731634182909;655.5968079630993;664.3987191591617;661.216458496683;664.441868830185;686.2862622872157;689.8240948558085;718.392957950531;10293;10476.83476426875;10571.36571805694;10704.625338113285;10848.511816968097;668.1070962731361;702.5222848463094;708.4544900426642;710.8400609862842;718.5904034700171;4448.1942627779545;4921.302150757982;5102.438731739506;5110.310108135429;5145.614078944094;65495.67252163708;85787.13702903753;103730;107945.92054079515;110719;71124.64437677778;74282;93710;94062;95298.0470195303;79438.6028069856;79565;81648.18351816524;82869;83209.58395207985;9898.406095634286;9907;9956.20350371954;9974.850377244493;9998.450085245091;48015;50079;50443;50956;51525.7423712879;56370.02704905309;65091.67454162699;65829.35426614372;68875;71289;10884.61903833362;11545.769084618092;12885.871141288842;13137.868621313664;13173.407196676364;11833.408329583659;12515.687107822014;14011.649708757363;14578.562643120724;15309.923450382677;13741.656458588615;13833.239171845646;14195.432182712575;14402.783958240845;14645;13374.799378009144;13732.862671373558;13791.862081379059;13865.445382185004;14039.929800350932;13429.529966451128;13739.175649461064;13904.30478476052;14116.435342586181;14372.425102996182;7713.344365728976;9213.815723685622;9304;9667.274954378308;9948.253880959102;7313.062038559679;9619.663311784054;10530.842037369292;10582.629607963685;11166.330020198815 19:29:41 INFO - PROCESS | 3253 | __end_tp_report 19:29:41 INFO - PROCESS | 3253 | __start_cc_report 19:29:41 INFO - PROCESS | 3253 | _x_x_mozilla_cycle_collect,377 19:29:41 INFO - PROCESS | 3253 | __end_cc_report 19:29:41 INFO - PROCESS | 3253 | __startTimestamp1495938581964__endTimestamp 19:29:41 INFO - PROCESS | 3253 | 19:29:41 INFO - PROCESS | 3253 | ------- Summary: start ------- 19:29:41 INFO - PROCESS | 3253 | Number of tests: 6 19:29:41 INFO - PROCESS | 3253 | 19:29:41 INFO - PROCESS | 3253 | [#0] dojo.html Cycles:165 Average:5914.64 Median:6174.44 stddev:675.36 (10.9%) stddev-sans-first:649.11 19:29:41 INFO - PROCESS | 3253 | Values: 3447.5 3453.0 3515.2 3528.8 3537.1 5929.4 5933.2 5951.5 6016.7 6048.6 5977.5 6014.0 6042.0 6060.6 6062.2 5387.6 5394.1 5447.7 5491.4 5556.8 5473.9 5502.6 5505.4 5515.6 5515.9 4840.4 4868.5 5404.6 5472.2 5482.3 5486.8 5507.3 5513.8 5525.6 5561.3 5292.8 5423.5 5447.3 5467.3 5476.6 5111.9 5754.6 5793.2 5980.9 6022.7 6258.8 6288.6 6305.1 6312.9 6333.6 6432.7 6441.7 6456.7 6459.6 6462.9 5853.8 6146.4 6162.9 6174.4 6174.8 5729.4 6340.3 6355.8 6473.1 6493.0 5811.1 5817.3 6357.8 6374.5 6396.6 6349.4 6451.8 6464.2 6468.9 6470.8 6247.1 6266.2 6290.5 6317.7 6350.3 6248.9 6314.7 6319.6 6342.8 6344.1 4925.9 4931.0 4935.4 4943.3 4944.0 3951.6 4281.7 4365.0 4417.6 4428.6 5859.3 5896.1 5932.1 5942.6 5945.8 6259.1 6411.4 6424.9 6438.2 6448.2 5789.2 5804.2 5824.9 5953.9 5961.9 5591.7 5596.7 5603.6 5607.0 5613.9 6623.5 6640.4 6649.4 6650.1 6650.3 6263.0 6313.8 6314.6 6328.5 6341.7 6592.7 6616.6 6633.1 6636.1 6655.1 6362.8 6379.9 6384.0 6386.4 6392.6 6265.7 6296.6 6321.1 6336.5 6433.3 5929.3 5976.1 6228.9 6328.2 6342.3 6319.1 6328.4 6335.9 6339.3 6358.4 6044.1 6110.7 6166.1 6168.4 6232.2 6253.7 6325.9 6335.3 6339.4 6353.2 6190.2 6221.2 6258.3 6259.9 6272.3 19:29:41 INFO - PROCESS | 3253 | 19:29:41 INFO - PROCESS | 3253 | [#1] ext.html Cycles:180 Average:56718.21 Median:204087.64 stddev:120871.72 (59.2%) stddev-sans-first:121137.56 19:29:41 INFO - PROCESS | 3253 | Values: 678.7 851.9 867.0 869.9 871.7 40351.8 41032.8 41206.6 42554.6 42740.4 33606.8 39402.6 40336.8 40347.8 40406.4 9102.5 9419.6 9502.2 9503.1 9505.8 9317.8 9374.4 9380.2 9398.0 9426.4 9345.6 9390.6 9418.3 9425.4 9425.9 7984.0 9367.8 9373.9 9380.8 9436.2 7831.9 8457.2 8461.7 9159.3 9178.3 35604.3 35870.3 35894.0 35898.8 36093.3 3827.5 3850.9 3853.9 3912.0 3960.8 26101.5 27562.7 27565.3 27600.3 27605.7 2606.7 2955.2 3024.4 3115.5 3158.5 372082.0 373887.0 373889.0 374387.0 374811.0 45611.5 45688.5 45973.5 46044.0 46135.8 39218.6 48089.0 48157.8 48533.5 48614.0 14105.7 14244.4 14352.4 14352.6 14358.2 11281.3 12080.4 12349.4 12385.3 12392.0 10807.8 11894.6 11968.0 11999.8 12076.9 5655.0 5660.9 5679.1 5683.6 5723.8 1146.9 1147.8 1179.7 1186.4 1187.2 26994.5 27464.9 27518.6 27553.7 27632.3 971.3 1048.0 1263.0 1310.5 1313.3 10849.5 12674.2 13733.2 13868.6 13871.2 496408.0 506499.0 510349.0 613855.0 615102.0 50960.7 51308.5 51394.5 51575.0 51588.7 1231.5 1260.4 1341.9 1444.2 1465.8 26382.5 28096.9 28368.9 28976.7 29101.0 40610.0 41723.6 42193.4 42204.0 42220.0 413081.0 413581.0 416381.0 416494.0 417486.0 24414.8 29314.8 30413.2 30426.5 30518.2 35742.0 37542.8 38285.0 39067.4 39099.0 22638.8 23504.0 27530.2 28158.0 28767.9 28145.0 28541.9 28908.7 29184.0 29229.7 32498.7 33241.8 33501.7 33578.3 33979.0 26844.9 27657.9 27984.7 28259.0 29089.6 20231.9 21252.3 22344.9 23368.8 23486.3 19:29:41 INFO - PROCESS | 3253 | 19:29:41 INFO - PROCESS | 3253 | [#2] jquery.html Cycles:180 Average:43432.75 Median:11721.18 stddev:130027.39 (1109.3%) stddev-sans-first:130351.96 19:29:41 INFO - PROCESS | 3253 | Values: 377.2 415.4 419.7 427.0 455.3 19899.2 20788.5 22185.0 22324.8 22423.0 21335.5 21480.9 21548.5 21853.9 22009.2 6684.6 6953.8 6997.6 7002.1 7077.5 6485.9 6876.8 6908.1 6935.2 6941.2 6548.3 6860.1 6917.8 6947.8 6962.5 6896.5 6911.8 6965.0 6967.9 6969.8 6417.0 6732.8 6793.9 6802.3 6812.9 26077.6 26256.3 26273.7 26524.0 26536.9 3070.2 3073.9 3101.7 3103.1 3111.6 15784.4 16431.7 16481.6 16572.8 16846.2 1706.2 2082.7 2090.2 2103.1 2106.9 111861.4 125248.0 129622.0 131185.0 132049.3 17497.9 21350.3 22345.9 22586.4 22785.7 36264.5 36289.7 36820.8 37076.6 37084.6 10630.6 11144.4 11259.3 11317.5 11340.4 7276.9 8918.9 8958.6 9007.9 9064.5 8727.6 10309.6 10767.5 10980.1 11031.6 3593.6 3605.3 3755.4 3783.6 4054.3 1119.8 1121.0 1134.5 1149.1 1157.6 18267.5 21882.8 22373.9 22383.9 22439.0 1114.1 1128.6 1154.1 1160.9 1162.8 11129.4 11869.7 11917.6 11972.5 12015.6 761870.0 783364.0 790304.0 795011.0 804136.0 116524.0 122149.4 126356.0 129195.0 162271.0 1074.5 1229.6 1302.2 1307.7 1308.3 19788.4 19919.4 20295.4 20592.0 20599.4 67375.0 67685.0 67713.0 68629.6 68781.3 96126.6 96623.5 97228.5 97475.5 98800.0 8938.9 10447.9 11609.8 11676.7 12016.6 12529.6 12801.9 12832.6 13207.2 13250.0 11140.4 11163.6 11319.3 11366.3 11587.8 7425.9 10206.2 10335.3 10352.2 10566.7 10856.1 10996.9 11288.0 11496.7 11952.3 11796.5 11846.8 11854.8 12079.3 12172.5 10141.4 11219.2 11425.5 11476.6 11585.0 19:29:41 INFO - PROCESS | 3253 | 19:29:41 INFO - PROCESS | 3253 | [#3] mootools.html Cycles:180 Average:6702.78 Median:2413.40 stddev:4202.98 (174.2%) stddev-sans-first:4196.98 19:29:41 INFO - PROCESS | 3253 | Values: 1557.1 1583.0 1591.7 1598.5 1611.0 10892.7 11152.9 11468.0 11544.9 11547.5 11086.8 11195.9 11238.6 11251.3 11289.4 2071.0 2359.9 2394.0 2415.9 2418.1 1980.2 2327.4 2380.8 2416.6 2421.1 1971.7 2373.9 2392.7 2403.0 2410.9 2018.8 2256.4 2357.8 2369.5 2371.5 2374.0 2386.1 2386.8 2391.9 2395.2 11429.9 11454.9 11532.2 11539.4 11615.7 5688.8 5762.9 5839.1 5840.4 5848.4 3331.8 3399.0 3461.8 3592.5 3604.7 1047.7 1155.4 1191.4 1221.7 1249.6 13753.8 14057.2 14773.3 15247.5 15261.0 4199.5 4225.5 4606.2 4722.0 4730.6 11568.4 11594.3 11602.8 11606.0 11610.6 5706.2 5716.4 5720.1 5725.5 5729.1 5137.6 5228.2 5270.6 5286.2 5298.7 3842.9 3900.3 3923.2 3972.4 3999.6 1016.1 1018.4 1022.4 1033.4 1033.8 717.2 770.3 815.8 843.5 844.6 6804.5 6816.8 6852.8 6879.8 6970.3 963.8 977.7 980.5 986.3 1016.1 4180.0 4194.7 4206.9 4329.1 4352.8 13252.5 13759.2 13765.1 13800.7 13854.4 13485.4 13503.9 13683.9 13700.0 13712.4 8788.7 10283.8 10362.5 10378.8 10391.9 6047.9 6905.8 6938.3 7094.1 7116.3 11959.2 12024.6 12081.5 12184.4 12188.1 12078.3 12294.9 12316.6 12410.1 12559.9 8354.7 8524.8 8537.6 8539.1 8546.1 10141.5 10168.9 10178.8 10241.3 10348.8 8717.2 8815.3 8845.2 8954.0 8974.4 7246.7 8517.5 8561.5 8667.3 8808.4 7538.9 7743.3 7771.1 7833.6 7927.6 5555.7 5615.3 5700.3 5737.2 5893.6 5933.4 6019.0 6107.5 6153.6 6253.1 19:29:41 INFO - PROCESS | 3253 | 19:29:41 INFO - PROCESS | 3253 | [#4] prototype.html Cycles:180 Average:4616.88 Median:4939.78 stddev:1302.53 (26.4%) stddev-sans-first:1265.85 19:29:41 INFO - PROCESS | 3253 | Values: 331.7 383.8 385.2 396.4 402.0 4642.7 4867.9 4945.7 5355.5 5360.6 4271.2 4415.8 4702.9 4734.8 5264.9 3883.3 4213.4 4369.0 4431.4 4434.7 3970.6 4075.8 4400.2 4406.7 4415.3 3762.8 4368.5 4374.9 4394.3 4405.4 3947.5 4015.3 4235.7 4346.1 4409.6 3801.5 3996.7 4016.1 4034.7 4049.1 4396.7 4404.7 4424.5 4491.7 5170.0 4317.1 4672.3 4806.6 4906.8 5086.8 5329.7 5461.9 5567.9 5690.3 5698.7 3709.7 3766.7 3891.0 4473.6 4531.8 5374.1 5413.3 5641.8 5927.2 6031.4 3966.2 4162.8 4490.4 4630.3 4650.4 4235.8 4245.7 4711.0 4755.0 4761.3 4154.7 4155.9 4908.7 5070.0 5129.3 4686.3 5619.9 5624.5 5680.8 5691.3 1365.7 1466.5 1531.9 1597.8 1613.7 1094.2 1137.7 1174.1 1208.8 1218.7 4540.0 4960.1 5042.8 5084.6 5105.8 5316.9 5411.3 5712.6 5853.8 5883.6 4414.4 4862.5 4971.4 5001.7 5141.3 2758.2 2861.3 2868.2 3046.0 3062.1 5886.5 6105.5 6113.2 6141.5 6146.9 5130.3 5597.8 5622.9 5699.7 5993.6 5170.4 5189.4 5567.9 5872.7 6067.8 5519.9 5858.4 5860.3 5902.7 5942.4 4898.2 5048.5 5195.8 5746.4 5806.3 5483.7 5505.6 6075.2 6090.0 6114.9 3982.8 4140.2 4179.7 4371.1 4606.5 5166.3 5176.4 5213.9 5397.3 5541.6 4933.8 5318.9 5353.7 5355.9 5488.3 4762.7 4860.1 4987.9 5246.7 5669.6 4849.2 4984.5 5426.9 5460.1 5558.9 4969.4 5212.7 5683.2 5701.6 5820.9 5245.8 5443.9 5489.0 5497.4 5542.8 19:29:41 INFO - PROCESS | 3253 | 19:29:41 INFO - PROCESS | 3253 | [#5] yui.html Cycles:180 Average:20618.19 Median:3680.37 stddev:29695.20 (806.9%) stddev-sans-first:29740.63 19:29:41 INFO - PROCESS | 3253 | Values: 645.0 730.0 781.5 790.0 870.6 15568.5 16628.7 16784.5 16793.4 16836.4 14755.3 15576.5 15794.2 15856.0 15862.4 973.8 975.4 991.8 993.7 999.2 958.4 984.0 984.1 986.3 986.4 1014.3 1027.1 1028.9 1045.0 1047.6 1030.6 1038.5 1039.4 1039.7 1040.9 762.1 769.0 770.4 770.6 774.4 16867.6 17309.9 17428.8 17438.0 17596.9 14214.4 14293.9 14383.9 14456.6 14508.6 11804.6 11813.1 11858.2 11961.3 12104.9 3654.6 3759.1 3797.7 3903.1 3913.4 111267.0 116904.0 116955.0 117044.0 117427.4 10824.5 11120.0 11318.0 11404.8 11610.9 18576.9 23030.4 23220.9 23341.4 23570.9 7489.0 7754.6 7765.4 7823.3 7851.0 4384.9 4410.7 4475.5 4506.7 4558.0 3573.8 3635.1 3664.0 3679.1 3681.7 646.1 647.0 653.7 655.6 664.4 661.2 664.4 686.3 689.8 718.4 10293.0 10476.8 10571.4 10704.6 10848.5 668.1 702.5 708.5 710.8 718.6 4448.2 4921.3 5102.4 5110.3 5145.6 65495.7 85787.1 103730.0 107945.9 110719.0 71124.6 74282.0 93710.0 94062.0 95298.0 79438.6 79565.0 81648.2 82869.0 83209.6 9898.4 9907.0 9956.2 9974.9 9998.5 48015.0 50079.0 50443.0 50956.0 51525.7 56370.0 65091.7 65829.4 68875.0 71289.0 10884.6 11545.8 12885.9 13137.9 13173.4 11833.4 12515.7 14011.6 14578.6 15309.9 13741.7 13833.2 14195.4 14402.8 14645.0 13374.8 13732.9 13791.9 13865.4 14039.9 13429.5 13739.2 13904.3 14116.4 14372.4 7713.3 9213.8 9304.0 9667.3 9948.3 7313.1 9619.7 10530.8 10582.6 11166.3 19:29:41 INFO - PROCESS | 3253 | -------- Summary: end -------- 19:29:41 INFO - PROCESS | 3253 | 19:29:42 INFO - TEST-INFO | 3253: exit 0 19:29:42 INFO - TEST-OK | dromaeo_css | took 1115122ms 19:29:42 INFO - TEST-START | kraken 19:29:42 INFO - operating with platform_type : mac_ 19:29:42 INFO - Initialising browser for kraken test... 19:29:42 INFO - TEST-INFO | started process 3258 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/tmpmVmhly/profile http://localhost:49420/getInfo.html) 19:29:45 INFO - PROCESS | 3258 | 2017-05-27 19:29:45.029 plugin-container[3260:71864] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x863f, name = 'com.apple.tsm.portname' 19:29:45 INFO - PROCESS | 3258 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:29:45 INFO - PROCESS | 3258 | 2017-05-27 19:29:45.030 plugin-container[3260:71864] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4607, name = 'com.apple.CFPasteboardClient' 19:29:45 INFO - PROCESS | 3258 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:29:45 INFO - PROCESS | 3258 | 2017-05-27 19:29:45.030 plugin-container[3260:71864] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:29:45 INFO - PROCESS | 3258 | __metrics Screen width/height:1600/1200 19:29:45 INFO - PROCESS | 3258 | colorDepth:24 19:29:45 INFO - PROCESS | 3258 | Browser inner width/height: 1024/689 19:29:45 INFO - PROCESS | 3258 | __metrics 19:29:45 ERROR - PROCESS | 3258 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3371: TypeError: this.tabs is undefined 19:29:45 INFO - TEST-INFO | 3258: exit 0 19:29:45 INFO - Browser initialized. 19:29:45 INFO - Running cycle 1/1 for kraken test... 19:29:45 INFO - TEST-INFO | started process 3261 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/tmpmVmhly/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:29:48 INFO - PROCESS | 3261 | 2017-05-27 19:29:48.070 plugin-container[3262:71984] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434f, name = 'com.apple.tsm.portname' 19:29:48 INFO - PROCESS | 3261 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:29:48 INFO - PROCESS | 3261 | 2017-05-27 19:29:48.071 plugin-container[3262:71984] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4517, name = 'com.apple.CFPasteboardClient' 19:29:48 INFO - PROCESS | 3261 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:29:48 INFO - PROCESS | 3261 | 2017-05-27 19:29:48.071 plugin-container[3262:71984] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:29:57 INFO - PROCESS | 3261 | RSS: Main: 203091968 19:29:57 INFO - PROCESS | 3261 | 19:30:00 INFO - PROCESS | 3261 | Cycle 1(1): loaded http://localhost:49420/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49420/tests/kraken/driver.html?testName=audio-beat-detection) 19:30:01 INFO - PROCESS | 3261 | RSS: Main: 216707072 19:30:01 INFO - PROCESS | 3261 | 19:30:04 INFO - PROCESS | 3261 | Cycle 1(1): loaded http://localhost:49420/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49420/tests/kraken/driver.html?testName=audio-dft) 19:30:04 INFO - PROCESS | 3261 | RSS: Main: 224579584 19:30:04 INFO - PROCESS | 3261 | 19:30:08 INFO - PROCESS | 3261 | Cycle 1(1): loaded http://localhost:49420/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49420/tests/kraken/driver.html?testName=audio-fft) 19:30:09 INFO - PROCESS | 3261 | RSS: Main: 226222080 19:30:09 INFO - PROCESS | 3261 | 19:30:11 INFO - PROCESS | 3261 | Cycle 1(1): loaded http://localhost:49420/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49420/tests/kraken/driver.html?testName=audio-oscillator) 19:30:11 INFO - PROCESS | 3261 | RSS: Main: 228925440 19:30:11 INFO - PROCESS | 3261 | 19:30:13 INFO - PROCESS | 3261 | Cycle 1(1): loaded http://localhost:49420/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49420/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:30:14 INFO - PROCESS | 3261 | RSS: Main: 229294080 19:30:14 INFO - PROCESS | 3261 | 19:30:17 INFO - PROCESS | 3261 | Cycle 1(1): loaded http://localhost:49420/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49420/tests/kraken/driver.html?testName=imaging-darkroom) 19:30:17 INFO - PROCESS | 3261 | RSS: Main: 233459712 19:30:17 INFO - PROCESS | 3261 | 19:30:20 INFO - PROCESS | 3261 | Cycle 1(1): loaded http://localhost:49420/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49420/tests/kraken/driver.html?testName=imaging-desaturate) 19:30:21 INFO - PROCESS | 3261 | RSS: Main: 233672704 19:30:21 INFO - PROCESS | 3261 | 19:30:24 INFO - PROCESS | 3261 | Cycle 1(1): loaded http://localhost:49420/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49420/tests/kraken/driver.html?testName=json-parse-financial) 19:30:25 INFO - PROCESS | 3261 | RSS: Main: 233529344 19:30:25 INFO - PROCESS | 3261 | 19:30:27 INFO - PROCESS | 3261 | Cycle 1(1): loaded http://localhost:49420/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49420/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:30:27 INFO - PROCESS | 3261 | RSS: Main: 233295872 19:30:27 INFO - PROCESS | 3261 | 19:30:29 INFO - PROCESS | 3261 | Cycle 1(1): loaded http://localhost:49420/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49420/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:30:30 INFO - PROCESS | 3261 | RSS: Main: 233275392 19:30:30 INFO - PROCESS | 3261 | 19:30:32 INFO - PROCESS | 3261 | Cycle 1(1): loaded http://localhost:49420/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49420/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:30:33 INFO - PROCESS | 3261 | RSS: Main: 233324544 19:30:33 INFO - PROCESS | 3261 | 19:30:36 INFO - PROCESS | 3261 | Cycle 1(1): loaded http://localhost:49420/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49420/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:30:37 INFO - PROCESS | 3261 | RSS: Main: 233689088 19:30:37 INFO - PROCESS | 3261 | 19:30:40 INFO - PROCESS | 3261 | Cycle 1(1): loaded http://localhost:49420/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49420/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:30:40 INFO - PROCESS | 3261 | RSS: Main: 233406464 19:30:40 INFO - PROCESS | 3261 | 19:30:42 INFO - PROCESS | 3261 | Cycle 1(1): loaded http://localhost:49420/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49420/tests/kraken/driver.html?testName=ai-astar) 19:30:42 INFO - PROCESS | 3261 | RSS: Main: 235409408 19:30:42 INFO - PROCESS | 3261 | 19:30:42 INFO - PROCESS | 3261 | __start_tp_report 19:30:42 INFO - PROCESS | 3261 | _x_x_mozilla_page_load 19:30:42 INFO - PROCESS | 3261 | _x_x_mozilla_page_load_details 19:30:42 INFO - PROCESS | 3261 | |i|pagename|runs| 19:30:42 INFO - PROCESS | 3261 | |0;ai-astar;106;120;120;119;120;122;123;119;120;123 19:30:42 INFO - PROCESS | 3261 | |1;audio-beat-detection;135;114;113;149;135;115;111;112;131;113 19:30:42 INFO - PROCESS | 3261 | |2;audio-dft;204;197;198;208;273;285;199;242;253;200 19:30:42 INFO - PROCESS | 3261 | |3;audio-fft;80;62;61;106;55;53;57;79;97;85 19:30:42 INFO - PROCESS | 3261 | |4;audio-oscillator;94;72;85;72;70;69;79;70;73;82 19:30:42 INFO - PROCESS | 3261 | |5;imaging-gaussian-blur;88;91;98;89;93;98;93;90;90;90 19:30:42 INFO - PROCESS | 3261 | |6;imaging-darkroom;97;107;97;97;99;99;97;98;97;100 19:30:42 INFO - PROCESS | 3261 | |7;imaging-desaturate;90;94;89;109;132;86;145;95;145;142 19:30:42 INFO - PROCESS | 3261 | |8;json-parse-financial;67;66;64;69;69;79;70;69;70;69 19:30:42 INFO - PROCESS | 3261 | |9;json-stringify-tinderbox;60;67;75;64;84;95;88;50;80;89 19:30:42 INFO - PROCESS | 3261 | |10;stanford-crypto-aes;96;97;78;106;102;101;73;95;101;104 19:30:42 INFO - PROCESS | 3261 | |11;stanford-crypto-ccm;142;151;130;135;170;146;156;160;203;160 19:30:42 INFO - PROCESS | 3261 | |12;stanford-crypto-pbkdf2;171;207;170;167;174;168;166;167;162;169 19:30:42 INFO - PROCESS | 3261 | |13;stanford-crypto-sha256-iterative;66;70;85;87;72;58;78;85;84;64 19:30:42 INFO - PROCESS | 3261 | __end_tp_report 19:30:42 INFO - PROCESS | 3261 | __start_cc_report 19:30:42 INFO - PROCESS | 3261 | _x_x_mozilla_cycle_collect,996 19:30:42 INFO - PROCESS | 3261 | __end_cc_report 19:30:42 INFO - PROCESS | 3261 | __startTimestamp1495938642744__endTimestamp 19:30:42 INFO - PROCESS | 3261 | 19:30:42 INFO - PROCESS | 3261 | ------- Summary: start ------- 19:30:42 INFO - PROCESS | 3261 | Number of tests: 14 19:30:42 INFO - PROCESS | 3261 | 19:30:42 INFO - PROCESS | 3261 | [#0] ai-astar Cycles:10 Average:119.20 Median:120.00 stddev:4.87 (4.1%) stddev-sans-first:1.58 19:30:42 INFO - PROCESS | 3261 | Values: 106.0 120.0 120.0 119.0 120.0 122.0 123.0 119.0 120.0 123.0 19:30:42 INFO - PROCESS | 3261 | 19:30:42 INFO - PROCESS | 3261 | [#1] audio-beat-detection Cycles:10 Average:122.80 Median:123.00 stddev:13.49 (11.0%) stddev-sans-first:13.57 19:30:42 INFO - PROCESS | 3261 | Values: 135.0 114.0 113.0 149.0 135.0 115.0 111.0 112.0 131.0 113.0 19:30:42 INFO - PROCESS | 3261 | 19:30:42 INFO - PROCESS | 3261 | [#2] audio-dft Cycles:10 Average:225.90 Median:225.00 stddev:34.18 (15.2%) stddev-sans-first:35.32 19:30:42 INFO - PROCESS | 3261 | Values: 204.0 197.0 198.0 208.0 273.0 285.0 199.0 242.0 253.0 200.0 19:30:42 INFO - PROCESS | 3261 | 19:30:42 INFO - PROCESS | 3261 | [#3] audio-fft Cycles:10 Average:73.50 Median:70.50 stddev:18.67 (26.5%) stddev-sans-first:19.65 19:30:42 INFO - PROCESS | 3261 | Values: 80.0 62.0 61.0 106.0 55.0 53.0 57.0 79.0 97.0 85.0 19:30:42 INFO - PROCESS | 3261 | 19:30:42 INFO - PROCESS | 3261 | [#4] audio-oscillator Cycles:10 Average:76.60 Median:76.00 stddev:8.22 (10.8%) stddev-sans-first:5.83 19:30:42 INFO - PROCESS | 3261 | Values: 94.0 72.0 85.0 72.0 70.0 69.0 79.0 70.0 73.0 82.0 19:30:42 INFO - PROCESS | 3261 | 19:30:42 INFO - PROCESS | 3261 | [#5] imaging-gaussian-blur Cycles:10 Average:92.00 Median:92.00 stddev:3.53 (3.8%) stddev-sans-first:3.43 19:30:42 INFO - PROCESS | 3261 | Values: 88.0 91.0 98.0 89.0 93.0 98.0 93.0 90.0 90.0 90.0 19:30:42 INFO - PROCESS | 3261 | 19:30:42 INFO - PROCESS | 3261 | [#6] imaging-darkroom Cycles:10 Average:98.80 Median:97.00 stddev:3.08 (3.2%) stddev-sans-first:3.20 19:30:42 INFO - PROCESS | 3261 | Values: 97.0 107.0 97.0 97.0 99.0 99.0 97.0 98.0 97.0 100.0 19:30:42 INFO - PROCESS | 3261 | 19:30:42 INFO - PROCESS | 3261 | [#7] imaging-desaturate Cycles:10 Average:112.70 Median:87.50 stddev:25.35 (29.0%) stddev-sans-first:25.52 19:30:42 INFO - PROCESS | 3261 | Values: 90.0 94.0 89.0 109.0 132.0 86.0 145.0 95.0 145.0 142.0 19:30:42 INFO - PROCESS | 3261 | 19:30:42 INFO - PROCESS | 3261 | [#8] json-parse-financial Cycles:10 Average:69.20 Median:69.00 stddev:3.94 (5.7%) stddev-sans-first:4.10 19:30:42 INFO - PROCESS | 3261 | Values: 67.0 66.0 64.0 69.0 69.0 79.0 70.0 69.0 70.0 69.0 19:30:42 INFO - PROCESS | 3261 | 19:30:42 INFO - PROCESS | 3261 | [#9] json-stringify-tinderbox Cycles:10 Average:75.20 Median:82.00 stddev:14.55 (17.7%) stddev-sans-first:14.36 19:30:42 INFO - PROCESS | 3261 | Values: 60.0 67.0 75.0 64.0 84.0 95.0 88.0 50.0 80.0 89.0 19:30:42 INFO - PROCESS | 3261 | 19:30:42 INFO - PROCESS | 3261 | [#10] stanford-crypto-aes Cycles:10 Average:95.30 Median:75.50 stddev:11.06 (14.6%) stddev-sans-first:11.72 19:30:42 INFO - PROCESS | 3261 | Values: 96.0 97.0 78.0 106.0 102.0 101.0 73.0 95.0 101.0 104.0 19:30:42 INFO - PROCESS | 3261 | 19:30:42 INFO - PROCESS | 3261 | [#11] stanford-crypto-ccm Cycles:10 Average:155.30 Median:158.00 stddev:20.74 (13.1%) stddev-sans-first:21.43 19:30:42 INFO - PROCESS | 3261 | Values: 142.0 151.0 130.0 135.0 170.0 146.0 156.0 160.0 203.0 160.0 19:30:42 INFO - PROCESS | 3261 | 19:30:42 INFO - PROCESS | 3261 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.10 Median:169.50 stddev:12.67 (7.5%) stddev-sans-first:13.43 19:30:42 INFO - PROCESS | 3261 | Values: 171.0 207.0 170.0 167.0 174.0 168.0 166.0 167.0 162.0 169.0 19:30:42 INFO - PROCESS | 3261 | 19:30:42 INFO - PROCESS | 3261 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.90 Median:81.00 stddev:10.32 (12.7%) stddev-sans-first:10.43 19:30:42 INFO - PROCESS | 3261 | Values: 66.0 70.0 85.0 87.0 72.0 58.0 78.0 85.0 84.0 64.0 19:30:42 INFO - PROCESS | 3261 | -------- Summary: end -------- 19:30:42 INFO - PROCESS | 3261 | 19:30:43 INFO - TEST-INFO | 3261: exit 0 19:30:43 INFO - TEST-OK | kraken | took 60982ms 19:30:43 INFO - SUITE-END | took 1176s 19:30:43 INFO - Completed test suite (00:19:36) 19:30:43 INFO - javascript benchmark 19:30:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7693.073074397497, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3447.5173475713395, 3452.9654703452957, 3515.2442224921638, 3528.7706299090555, 3537.0626783902253, 5929.407059294073, 5933.228680271564, 5951.523878089753, 6016.699165041752, 6048.637081775086, 5977.491913187384, 6013.969930150354, 6042.0, 6060.636361818294, 6062.181605483259, 5387.568994480442, 5394.136938089907, 5447.700376479292, 5491.423400542925, 5556.777728890839, 5473.917891231615, 5502.642328248651, 5505.449455054502, 5515.586331025189, 5515.862103447426, 4840.443349014856, 4868.513148685139, 5404.567634589243, 5472.2338872557875, 5482.314710661168, 5486.753096110685, 5507.311586051744, 5513.807016754415, 5525.557955363582, 5561.277033985596, 5292.788288468457, 5423.484768946943, 5447.346318441812, 5467.261919640838, 5476.616636835423, 5111.926495435963, 5754.625949313281, 5793.188953546507, 5980.940190598082, 6022.6687532185715, 6258.78094266703, 6288.622682639057, 6305.0857625644485, 6312.905306420407, 6333.588316759396, 6432.678366081724, 6441.710123044474, 6456.741730330781, 6459.612423254573, 6462.903056454157, 5853.765849366063, 6146.385361463817, 6162.938370616282, 6174.44430001302, 6174.845628859224, 5729.369769325371, 6340.302566717657, 6355.777547785805, 6473.126127972663, 6492.967535162294, 5811.128330750421, 5817.331006934257, 6357.841053973688, 6374.458171055419, 6396.552241343062, 6349.365063493706, 6451.806445806634, 6464.159659244268, 6468.935310646927, 6470.773522926675, 6247.09417134522, 6266.154069200691, 6290.465310448663, 6317.747290108436, 6350.333215012357, 6248.9062664060075, 6314.684265786692, 6319.55763096588, 6342.778002769881, 6344.143540621957, 4925.852224433273, 4930.975345123252, 4935.358403407534, 4943.2585112233455, 4944.035912996931, 3951.565327813938, 4281.657467402601, 4365.0, 4417.558244175621, 4428.579284967923, 5859.267591551056, 5896.086106653475, 5932.080527518242, 5942.64344139353, 5945.821625351246, 6259.123722678829, 6411.447872010831, 6424.903626445607, 6438.195225596801, 6448.161738973903, 5789.218455508452, 5804.245448091806, 5824.912626310609, 5953.880922381528, 5961.940380596226, 5591.720413979285, 5596.720163991784, 5603.635763675348, 5607.0, 5613.887722245532, 6623.4701223901975, 6640.402363787089, 6649.368310010541, 6650.135482387453, 6650.3349665034075, 6262.968685156545, 6313.779017734358, 6314.62112273265, 6328.525360597881, 6341.682915854281, 6592.736290548324, 6616.603003819786, 6633.1045308882685, 6636.104125943129, 6655.101561289164, 6362.840928976628, 6379.872402552016, 6383.968080159755, 6386.425221730066, 6392.616443013434, 6265.686715664107, 6296.622202667854, 6321.083442900662, 6336.524760643062, 6433.2601750797385, 5929.288485381781, 5976.133460648095, 6228.937710622836, 6328.177336946167, 6342.334054924167, 6319.146915166394, 6328.398802113792, 6335.873282534416, 6339.302676705651, 6358.395952384516, 6044.093385992136, 6110.663913484801, 6166.105914642441, 6168.414000670109, 6232.158658581034, 6253.687315634109, 6325.905111423241, 6335.303116657256, 6339.397757213057, 6353.205849268841, 6190.1952746142715, 6221.160143380585, 6258.280297765815, 6259.874802504016, 6272.278687950944], "value": 5870.126288916935, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [678.6911955060448, 851.9403641745079, 866.9913300866989, 869.904310525842, 871.7254064969534, 40351.79824100879, 41032.7690169295, 41206.58793412069, 42554.574454255446, 42740.358894616606, 33606.823761168365, 39402.605973940255, 40336.798316008455, 40347.79826100873, 40406.39390409139, 9102.499362535042, 9419.576119074623, 9502.192313653348, 9503.14471697547, 9505.762355941122, 9317.81364372712, 9374.390664606814, 9380.202682771973, 9398.0132086131, 9426.387284826498, 9345.57944892478, 9390.577424015935, 9418.340716149873, 9425.38734982224, 9425.905740942571, 7983.960080199562, 9367.76580585484, 9373.906260937372, 9380.812383752322, 9436.245100391952, 7831.882521762178, 8457.238848503664, 8461.66153353865, 9159.267258619295, 9178.311626627963, 35604.28791424183, 35870.28259434823, 35894.0, 35898.820505897565, 36093.27813443742, 3827.4641550182996, 3850.9229815403537, 3853.903652408684, 3911.9608803911883, 3960.8019599019935, 26101.477970440486, 27562.724372756216, 27565.31086722828, 27600.309992250153, 27605.723942760516, 2606.7262937391492, 2955.157780032702, 3024.4404785114825, 3115.517094850302, 3158.510430883217, 372081.99999999726, 373887.0, 373889.0, 374387.0, 374811.0, 45611.54388456139, 45688.543114569096, 45973.54026459759, 46044.0, 46135.76932115318, 39218.60781392206, 48089.0, 48157.75921120442, 48533.5146648536, 48614.0, 14105.73048425626, 14244.430222790972, 14352.354144063542, 14352.641183970276, 14358.210298433478, 11281.266717663326, 12080.395980200954, 12349.444275007647, 12385.318807465675, 12392.0, 10807.83788243177, 11894.583689570996, 11968.0, 11999.760004799855, 12076.939615302043, 5655.0, 5660.8867822643315, 5679.062954612443, 5683.60214784961, 5723.7996670116345, 1146.873843877173, 1147.8450409194652, 1179.722765150189, 1186.4186548591128, 1187.1511869013525, 26994.460110797674, 27464.862675686494, 27518.587221191698, 27553.724462755516, 27632.309192269953, 971.2763990826738, 1047.9528421221064, 1263.0044529643142, 1310.4904108632054, 1313.2776972664997, 10849.45037916105, 12674.176178548365, 13733.176009439267, 13868.583942481742, 13871.167729936034, 496408.0, 506499.0, 510349.0, 613855.0, 615102.0, 50960.72598185075, 51308.48691513037, 51394.48605513972, 51575.0, 51588.742056290226, 1231.482777233564, 1260.357217818919, 1341.8926485881302, 1444.2056868722161, 1465.8387577366482, 26382.472350553264, 28096.85951570229, 28368.85815570909, 28976.69604867828, 29101.0, 40609.984750381474, 41723.582764171966, 42193.36709949415, 42204.0, 42220.0, 413081.0, 413581.0, 416381.0, 416494.0, 417486.0, 24414.80266775999, 29314.796226660485, 30413.239669007566, 30426.54360184643, 30518.237044074074, 35742.0, 37542.812285938395, 38285.0, 39067.41398879076, 39099.0, 22638.773612264325, 23504.0, 27530.17409477719, 28158.0, 28767.856160719064, 28145.0, 28541.857290713415, 28908.71091289144, 29184.0, 29229.7077029227, 32498.67501325051, 33241.83379083089, 33501.66498334985, 33578.3284334307, 33978.98063058112, 26844.865775671777, 27657.86171069132, 27984.72015279821, 28259.0, 29089.563656545593, 20231.898840505703, 21252.256171034558, 22344.882755862465, 23368.76631233734, 23486.295411137693], "value": 17957.540359000897, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.1890435563538, 415.36034506859454, 419.71669123341735, 426.96370808481265, 455.2942938445409, 19899.204031838726, 20788.48028799279, 22185.0, 22324.776752232472, 22422.990965406556, 21335.466613334673, 21480.89979224858, 21548.461288467795, 21853.907304634744, 22009.22967696131, 6684.5989240645595, 6953.79138625842, 6997.615131167784, 7002.054722612458, 7077.469189810759, 6485.902711459332, 6876.7593134240315, 6908.1364829396325, 6935.237123916365, 6941.167059952788, 6548.27968923418, 6860.142482189726, 6917.7578784742545, 6947.79156625302, 6962.547434416772, 6896.48276379271, 6911.7926462206215, 6965.0, 6967.8606427871155, 6969.756058537952, 6416.967915160394, 6732.764353247613, 6793.932060679379, 6802.319768023208, 6812.897806532906, 26077.60883586748, 26256.343591410176, 26273.73726262732, 26524.0, 26536.86731566349, 3070.186400603842, 3073.8770449182007, 3101.720845123927, 3103.1311232854837, 3111.5643809866638, 15784.368625254976, 16431.671366572722, 16481.587960300967, 16572.75140872888, 16846.24191911367, 1706.2492503298508, 2082.739657542807, 2090.2304446608155, 2103.05362586835, 2106.894655267246, 111861.44069279682, 125248.0, 129622.0, 131185.0, 132049.33975330158, 17497.912510437367, 21350.252741153985, 22345.882705864966, 22586.435339116324, 22785.658215126787, 36264.456033159, 36289.72985945479, 36820.81589592035, 37076.62923370732, 37084.62915370866, 10630.627928022483, 11144.442777861075, 11259.268147570545, 11317.49071291794, 11340.376279304717, 7276.854462910712, 8918.910810891808, 8958.552072396484, 9007.864882026775, 9064.546772661472, 8727.60725767342, 10309.556662067167, 10767.461626918623, 10980.066694331072, 11031.558737650405, 3593.6406359363855, 3605.2789442111684, 3755.4366844973474, 3783.640554147407, 4054.270231358325, 1119.8376235445814, 1120.9551617935192, 1134.5064896769932, 1149.0922171484601, 1157.6295585412756, 18267.451976440727, 21882.796446195294, 22373.888130559568, 22383.888080559493, 22439.0, 1114.136544178252, 1128.5542210826677, 1154.08827026648, 1160.9377419661084, 1162.8197629367462, 11129.387883666475, 11869.674882326195, 11917.64247072572, 11972.521099155936, 12015.639530814089, 761870.0, 783364.0, 790304.0, 795011.0, 804136.0, 116524.0, 122149.38925305316, 126356.0, 129195.0, 162271.0, 1074.462768615692, 1229.557359350633, 1302.2121616421928, 1307.7384523095418, 1308.2804457548311, 19788.40634780959, 19919.402417927486, 20295.391138265877, 20592.0, 20599.38201853947, 67375.0, 67685.0, 67713.0, 68629.62740745058, 68781.3121868795, 96126.55810162993, 96623.51688241796, 97228.54157187506, 97475.51262243644, 98800.0, 8938.86591701138, 10447.902970188325, 11609.825852612048, 11676.70808229801, 12016.579419720269, 12529.624111276677, 12801.935990320362, 12832.55086071983, 13207.207567545978, 13250.0, 11140.442977851237, 11163.609273675382, 11319.264247824194, 11366.261193022427, 11587.768244635228, 7425.888611670721, 10206.234532410248, 10335.276530643083, 10352.223583231438, 10566.682999510027, 10856.077233434931, 10996.890031099587, 11288.0, 11496.712582185512, 11952.282863028246, 11796.52813887435, 11846.763064738485, 11854.762904741685, 12079.335636539723, 12172.513099476277, 10141.442220677933, 11219.158563107963, 11425.542978280775, 11476.598319058792, 11585.0], "value": 11807.589240403391, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1557.1280083153442, 1582.9947983030772, 1591.6896205239982, 1598.4964736108127, 1610.991945040275, 10892.673219803408, 11152.888471115286, 11468.025217856471, 11544.942275288611, 11547.538098476061, 11086.833697494543, 11195.888041119586, 11238.606648767294, 11251.324920504776, 11289.435528223576, 2070.9792902071013, 2359.8702071386065, 2393.9521209575796, 2415.879206039691, 2418.056957786465, 1980.2079168332639, 2327.3716096653893, 2380.7619238076227, 2416.5529377065213, 2421.092090466075, 1971.7239586457908, 2373.9406514837096, 2392.724836643782, 2402.987985060081, 2410.927672169838, 2018.7685511837767, 2256.3569382725846, 2357.799587035104, 2369.5379401016808, 2371.5019845832394, 2374.03851440167, 2386.140989243871, 2386.7971222446113, 2391.8564886106888, 2395.2215529952837, 11429.885701142965, 11454.94272528632, 11532.192746507748, 11539.365334906577, 11615.6515304541, 5688.800891968761, 5762.855928601776, 5839.124131380285, 5840.386759390245, 5848.444397782204, 3331.766776325658, 3398.9660103398896, 3461.7749846259912, 3592.497050412944, 3604.6936010439144, 1047.7223535763028, 1155.3703231738723, 1191.3864359854595, 1221.7312191317897, 1249.6063739921985, 13753.79369309461, 14057.226852523107, 14773.335199915922, 15247.542573722805, 15261.0, 4199.538050814408, 4225.4506914101585, 4606.170889239969, 4722.0, 4730.597899178609, 11568.421578921021, 11594.304341739522, 11602.825957610643, 11606.0, 11610.593629222936, 5706.172604972256, 5716.371199168088, 5720.056190728566, 5725.456081672234, 5729.083346664514, 5137.640365174477, 5228.163493841043, 5270.631055826056, 5286.180642000496, 5298.708571028554, 3842.9231415372096, 3900.278448487039, 3923.1761330120994, 3972.3644216925154, 3999.6000399960353, 1016.11090295991, 1018.4398580780542, 1022.437659287389, 1033.379972016799, 1033.7725700345911, 717.2146499582948, 770.3452065744073, 815.8286759780513, 843.4854738609444, 844.6368061733514, 6804.489663275274, 6816.807058764696, 6852.828679283058, 6879.837698192621, 6970.268121847234, 963.8410259729246, 977.7457860956202, 980.4901451245455, 986.3440811860032, 1016.0753714120116, 4179.9791001045405, 4194.727342722713, 4206.8737937861915, 4329.069250111241, 4352.7823608819435, 13252.469901203844, 13759.17444953306, 13765.105268157538, 13800.654983625289, 13854.445822167001, 13485.393157307944, 13503.932480337731, 13683.863161368457, 13700.040997130105, 13712.3829427676, 8788.692395766118, 10283.794324113625, 10362.481875906175, 10378.792424151474, 10391.896081039093, 6047.909281360695, 6905.827354316182, 6938.27148149437, 7094.11323584552, 7116.323949224816, 11959.222650527689, 12024.579139730067, 12081.456334464794, 12184.390780460764, 12188.085893557842, 12078.33569153705, 12294.938525307316, 12316.630501084981, 12410.069244806857, 12559.87440125587, 8354.665813367397, 8524.829503410021, 8537.615807288563, 8539.060703322506, 8546.059933407445, 10141.49292535385, 10168.898311016796, 10178.796424071328, 10241.283110182514, 10348.844767328346, 8717.171868672465, 8815.294776417742, 8845.203931646183, 8954.015058343708, 8974.41666291689, 7246.673899674422, 8517.48895066298, 8561.48631082137, 8667.349948753996, 8808.383413161017, 7538.924610754042, 7743.303102720557, 7771.145174030739, 7833.569153696373, 7927.60361981887, 5555.694436805853, 5615.298087739033, 5700.315962084576, 5737.196792449144, 5893.5874488785375, 5933.436323549256, 6018.969905150446, 6107.450329470369, 6153.630782153085, 6253.062040693932], "value": 5080.694744761021, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.6882130797051, 383.80425982748824, 385.2180074448868, 396.3796658229872, 401.97387169833956, 4642.651801114917, 4867.9269810952865, 4945.727984960826, 5355.536453231513, 5360.571154307656, 4271.231178387889, 4415.801288941997, 4702.929456058153, 4734.839964208773, 5264.921026184601, 3883.252536358636, 4213.431186789775, 4369.0, 4431.401760762296, 4434.733915965036, 3970.622790834866, 4075.8004966101616, 4400.183882315321, 4406.730533775109, 4415.337699345092, 3762.7930463824478, 4368.453943257093, 4374.934375984363, 4394.252976993918, 4405.405270288502, 3947.4868267125375, 4015.337469317559, 4235.661147108255, 4346.130773845212, 4409.626635623735, 3801.543814742221, 3996.680265578747, 4016.0763024504236, 4034.7088931541916, 4049.0564529025937, 4396.746407658342, 4404.656579743177, 4424.535423780521, 4491.73049617024, 5169.974150129263, 4317.071829556629, 4672.345871577982, 4806.591439727627, 4906.803727850882, 5086.821961231339, 5329.733513324319, 5461.863453413656, 5567.916481252784, 5690.317161940552, 5698.6580805151825, 3709.703223742094, 3766.6798322142376, 3891.0, 4473.628976642385, 4531.77341132942, 5374.119058329593, 5413.323334583177, 5641.830745077655, 5927.199828023205, 6031.37152968696, 3966.2067586482817, 4162.8353256307155, 4490.416245888014, 4630.282306242538, 4650.395448591661, 4235.755049823599, 4245.705059956743, 4711.010687755541, 4754.97767979886, 4761.285807128958, 4154.729942553724, 4155.8753237402325, 4908.705477671279, 5069.9746501267255, 5129.281900533928, 4686.343911852344, 5619.943800561942, 5624.493795558419, 5680.7727690892725, 5691.260136182353, 1365.6654119740726, 1466.4574107580263, 1531.923403829804, 1597.7922870026823, 1613.6687233032794, 1094.2395035450286, 1137.6587023892964, 1174.0724827386268, 1208.800547909585, 1218.7440637466054, 4539.977300113478, 4960.131976904099, 5042.848219862586, 5084.6440749147205, 5105.821296254613, 5316.893662126736, 5411.323584551931, 5712.571557133231, 5853.765849366063, 5883.588148829541, 4414.381986521889, 4862.513748625109, 4971.37857767779, 5001.7499125043605, 5141.331626888481, 2758.1725482355214, 2861.3275880168144, 2868.182567968119, 3045.9847700761356, 3062.11679816911, 5886.529077673776, 6105.45050945417, 6113.23584551931, 6141.539384546177, 6146.938530614726, 5130.30740849988, 5597.832065038056, 5622.891415719106, 5699.686517241592, 5993.61041532299, 5170.37955445349, 5189.4032186299055, 5567.944320556742, 5872.678647304322, 6067.7876274331065, 5519.862003449946, 5858.3596592954045, 5860.267466566679, 5902.675352855634, 5942.376050514634, 4898.228364159649, 5048.495150484922, 5195.76619052136, 5746.42535746422, 5806.303243610625, 5483.698396588226, 5505.642133261325, 6075.210222671025, 6090.015892212872, 6114.908276375947, 3982.820773065277, 4140.171965606831, 4179.749215047107, 4371.1039236956985, 4606.539346065367, 5166.2508936203285, 5176.4047134580005, 5213.869653258699, 5397.277382290496, 5541.556675466034, 4933.827316043921, 5318.883034562785, 5353.705546194997, 5355.902040081696, 5488.341399032141, 4762.738049407316, 4860.091307779239, 4987.900241995212, 5246.717677810165, 5669.603127781016, 4849.248366503198, 4984.501549844987, 5426.879544262144, 5460.116259890331, 5558.861028474321, 4969.428515720739, 5212.713300768342, 5683.232763576864, 5701.572382071278, 5820.912686309624, 5245.763940622757, 5443.872073438649, 5489.011977844027, 5497.39528651856, 5542.7782888684005], "value": 4238.7829373491, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [644.9903251451229, 729.9781006569798, 781.4842204145261, 789.9921000789991, 870.5560164316199, 15568.53294401167, 16628.66742665146, 16784.49646510605, 16793.412230571932, 16836.410725624606, 14755.336009879555, 15576.53270401887, 15794.210289485538, 15856.0, 15862.3655053798, 973.7662960889388, 975.4098770244007, 991.8363470027437, 993.696922438656, 999.2405771613553, 958.3866325551653, 983.9570055740937, 984.1388784813288, 986.2603047714215, 986.378581493658, 1014.3052009373566, 1027.1064174168484, 1028.8713910761155, 1044.958201671932, 1047.565260416926, 1030.5723124903157, 1038.5222797513154, 1039.3504059962524, 1039.6932904793105, 1040.9063184313372, 762.0969151555424, 769.0002996105042, 770.4106358635648, 770.5569297653872, 774.403709143956, 16867.578310542212, 17309.913450432792, 17428.825711742847, 17438.0, 17596.912015439968, 14214.360353784, 14293.928530357281, 14383.928080359532, 14456.566303010926, 14508.637284067878, 11804.645860624196, 11813.1140164488, 11858.229215100991, 11961.282323060645, 12104.910558049729, 3654.634536546351, 3759.1166075972124, 3797.677197438221, 3903.1022864741267, 3913.3542965410675, 111267.0, 116904.0, 116955.0, 117044.0, 117427.41286293513, 10824.512896919658, 11120.0, 11318.037966772916, 11404.771904562029, 11610.941945290388, 18576.907115464608, 23030.424239393815, 23220.88389558075, 23341.416464588183, 23570.882145589505, 7488.962555187298, 7754.5734984575265, 7765.378769698524, 7823.2567906048835, 7851.0, 4384.934225986613, 4410.669199810027, 4475.507694153641, 4506.662000349921, 4558.0, 3573.821308934595, 3635.109398197406, 3663.9740872555726, 3679.0618392310325, 3681.6686498214754, 646.0664340028613, 646.9610636277273, 653.6731634182909, 655.5968079630993, 664.3987191591617, 661.216458496683, 664.441868830185, 686.2862622872157, 689.8240948558085, 718.392957950531, 10293.0, 10476.83476426875, 10571.36571805694, 10704.625338113285, 10848.511816968097, 668.1070962731361, 702.5222848463094, 708.4544900426642, 710.8400609862842, 718.5904034700171, 4448.1942627779545, 4921.302150757982, 5102.438731739506, 5110.310108135429, 5145.614078944094, 65495.67252163708, 85787.13702903753, 103730.0, 107945.92054079515, 110719.0, 71124.64437677778, 74282.0, 93710.0, 94062.0, 95298.0470195303, 79438.6028069856, 79565.0, 81648.18351816524, 82869.0, 83209.58395207985, 9898.406095634286, 9907.0, 9956.20350371954, 9974.850377244493, 9998.450085245091, 48015.0, 50079.0, 50443.0, 50956.0, 51525.7423712879, 56370.02704905309, 65091.67454162699, 65829.35426614372, 68875.0, 71289.0, 10884.61903833362, 11545.769084618092, 12885.871141288842, 13137.868621313664, 13173.407196676364, 11833.408329583659, 12515.687107822014, 14011.649708757363, 14578.562643120724, 15309.923450382677, 13741.656458588615, 13833.239171845646, 14195.432182712575, 14402.783958240845, 14645.0, 13374.799378009144, 13732.862671373558, 13791.862081379059, 13865.445382185004, 14039.929800350932, 13429.529966451128, 13739.175649461064, 13904.30478476052, 14116.435342586181, 14372.425102996182, 7713.344365728976, 9213.815723685622, 9304.0, 9667.274954378308, 9948.253880959102, 7313.062038559679, 9619.663311784054, 10530.842037369292, 10582.629607963685, 11166.330020198815], "value": 7732.839778598044, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1563.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 120.0, 120.0, 119.0, 120.0, 122.0, 123.0, 119.0, 120.0, 123.0], "value": 119.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 114.0, 113.0, 149.0, 135.0, 115.0, 111.0, 112.0, 131.0, 113.0], "value": 122.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [204.0, 197.0, 198.0, 208.0, 273.0, 285.0, 199.0, 242.0, 253.0, 200.0], "value": 225.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 62.0, 61.0, 106.0, 55.0, 53.0, 57.0, 79.0, 97.0, 85.0], "value": 73.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 72.0, 85.0, 72.0, 70.0, 69.0, 79.0, 70.0, 73.0, 82.0], "value": 76.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 91.0, 98.0, 89.0, 93.0, 98.0, 93.0, 90.0, 90.0, 90.0], "value": 92.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 107.0, 97.0, 97.0, 99.0, 99.0, 97.0, 98.0, 97.0, 100.0], "value": 98.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 94.0, 89.0, 109.0, 132.0, 86.0, 145.0, 95.0, 145.0, 142.0], "value": 112.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 64.0, 69.0, 69.0, 79.0, 70.0, 69.0, 70.0, 69.0], "value": 69.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 67.0, 75.0, 64.0, 84.0, 95.0, 88.0, 50.0, 80.0, 89.0], "value": 75.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 78.0, 106.0, 102.0, 101.0, 73.0, 95.0, 101.0, 104.0], "value": 95.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 151.0, 130.0, 135.0, 170.0, 146.0, 156.0, 160.0, 203.0, 160.0], "value": 155.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 207.0, 170.0, 167.0, 174.0, 168.0, 166.0, 167.0, 162.0, 169.0], "value": 172.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 70.0, 85.0, 87.0, 72.0, 58.0, 78.0, 85.0, 84.0, 64.0], "value": 74.9, "unit": "score"}]}]} 19:30:44 INFO - Return code: 0 19:30:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:30:44 ERROR - # TBPL SUCCESS # 19:30:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:30:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:30:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:30:44 INFO - 2017-05-27 19:30:44.095 screenresolution[3267:72385] starting screenresolution argv=screenresolution get 19:30:44 INFO - 2017-05-27 19:30:44.098 screenresolution[3267:72385] Display 0: 1600x1200x32@60 19:30:44 INFO - 2017-05-27 19:30:44.104 screenresolution[3268:72388] starting screenresolution argv=screenresolution list 19:30:44 INFO - Available Modes on Display 0 19:30:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:30:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:30:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:30:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:30:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:30:44 INFO - Intel Iris: 19:30:44 INFO - Chipset Model: Intel Iris 19:30:44 INFO - Type: GPU 19:30:44 INFO - Bus: Built-In 19:30:44 INFO - VRAM (Dynamic, Max): 1536 MB 19:30:44 INFO - Vendor: Intel (0x8086) 19:30:44 INFO - Device ID: 0x0a2e 19:30:44 INFO - Revision ID: 0x0009 19:30:44 INFO - Displays: 19:30:44 INFO - Display: 19:30:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:30:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:30:44 INFO - Display Serial Number: 1600x1200 60 19:30:44 INFO - Main Display: Yes 19:30:44 INFO - Mirror: Off 19:30:44 INFO - Online: Yes 19:30:44 INFO - Rotation: Supported 19:30:44 INFO - Return code: 0 19:30:44 INFO - Running post-action listener: _resource_record_post_action 19:30:44 INFO - [mozharness: 2017-05-28 02:30:44.341382Z] Finished run-tests step (success) 19:30:44 INFO - Running post-run listener: _resource_record_post_run 19:30:44 INFO - Total resource usage - Wall time: 1197s; CPU: 55.0%; Read bytes: 1118720; Write bytes: 514573312; Read time: 12; Write time: 1647 19:30:44 INFO - TinderboxPrint: CPU usage
54.6% 19:30:44 INFO - TinderboxPrint: I/O read bytes / time
1,118,720 / 12 19:30:44 INFO - TinderboxPrint: I/O write bytes / time
514,573,312 / 1,647 19:30:44 INFO - TinderboxPrint: CPU idle
2,174.6 (45.4%) 19:30:44 INFO - TinderboxPrint: CPU system
967.7 (20.2%) 19:30:44 INFO - TinderboxPrint: CPU user
1,647.5 (34.4%) 19:30:44 INFO - TinderboxPrint: Swap in / out
209,420,288 / 0 19:30:44 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 203969024; Write bytes: 202893312; Read time: 15541; Write time: 479 19:30:44 INFO - run-tests - Wall time: 1178s; CPU: 55.0%; Read bytes: 1118208; Write bytes: 300878848; Read time: 12; Write time: 1136 19:30:44 INFO - Running post-run listener: _upload_blobber_files 19:30:44 INFO - Blob upload gear active. 19:30:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:30:44 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 19:30:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:30:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:30:45 INFO - (blobuploader) - INFO - Open directory for files ... 19:30:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:30:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:30:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:30:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:30:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:30:45 INFO - (blobuploader) - INFO - Done attempting. 19:30:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:30:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:30:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:30:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:30:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:30:46 INFO - (blobuploader) - INFO - Done attempting. 19:30:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:30:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:30:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:30:47 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:30:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:30:47 INFO - (blobuploader) - INFO - Done attempting. 19:30:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:30:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:30:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:30:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:30:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:30:50 INFO - (blobuploader) - INFO - Done attempting. 19:30:50 INFO - (blobuploader) - INFO - Iteration through files over. 19:30:50 INFO - Return code: 0 19:30:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:30:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:30:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e4404d6ea09bb219a0425ff7367f138f709a2af76f17e38ea795ad9d0612b7576c0a9720dcec3203239085e43ab3581175af1baca2edfe2b10ee63101e0852da", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0abb0e57a49ad27c72e19372baff7228e667f5d5a9baf29a57381cd1012b5560e84b470d6d811e9acfdd66aa091f9a2f083cc28ba4eafbb98d7d8f1823bd2a99", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/99e387f5cfcd8c143b2a3e2b82773fda5f24393986f3c821df6b8ba76d4f0ecce7d6817326c6591b2932e4cdd4f0e16e98a58d88f48e2cd79b3d369fb0f084c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/239a2fecbad797626914858157bd6cda028eb65ace96d9d1a9dc99339b30db8ccc5554d8065c48b44e34cc1bc0a3bed5d9c69468bb873bb50df17706430defd7"} 19:30:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:30:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:30:50 INFO - Contents: 19:30:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e4404d6ea09bb219a0425ff7367f138f709a2af76f17e38ea795ad9d0612b7576c0a9720dcec3203239085e43ab3581175af1baca2edfe2b10ee63101e0852da", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0abb0e57a49ad27c72e19372baff7228e667f5d5a9baf29a57381cd1012b5560e84b470d6d811e9acfdd66aa091f9a2f083cc28ba4eafbb98d7d8f1823bd2a99", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/99e387f5cfcd8c143b2a3e2b82773fda5f24393986f3c821df6b8ba76d4f0ecce7d6817326c6591b2932e4cdd4f0e16e98a58d88f48e2cd79b3d369fb0f084c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/239a2fecbad797626914858157bd6cda028eb65ace96d9d1a9dc99339b30db8ccc5554d8065c48b44e34cc1bc0a3bed5d9c69468bb873bb50df17706430defd7"} 19:30:50 INFO - Running post-run listener: copy_logs_to_upload_dir 19:30:50 INFO - Copying logs to upload dir... 19:30:50 INFO - mkdir: /builds/slave/test/build/upload/logs 19:30:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.854281 ========= master_lag: 0.68 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2017-05-27 19:30:51.304374) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-27 19:30:51.309020) ========= 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.64v80QNhjZ/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.2SHmUekvYN/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e4404d6ea09bb219a0425ff7367f138f709a2af76f17e38ea795ad9d0612b7576c0a9720dcec3203239085e43ab3581175af1baca2edfe2b10ee63101e0852da", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0abb0e57a49ad27c72e19372baff7228e667f5d5a9baf29a57381cd1012b5560e84b470d6d811e9acfdd66aa091f9a2f083cc28ba4eafbb98d7d8f1823bd2a99", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/99e387f5cfcd8c143b2a3e2b82773fda5f24393986f3c821df6b8ba76d4f0ecce7d6817326c6591b2932e4cdd4f0e16e98a58d88f48e2cd79b3d369fb0f084c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/239a2fecbad797626914858157bd6cda028eb65ace96d9d1a9dc99339b30db8ccc5554d8065c48b44e34cc1bc0a3bed5d9c69468bb873bb50df17706430defd7"} build_url:https://queue.taskcluster.net/v1/task/f1cfklg2TBSHrfK3G7WepA/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011347 build_url: 'https://queue.taskcluster.net/v1/task/f1cfklg2TBSHrfK3G7WepA/artifacts/public/build/firefox-54.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e4404d6ea09bb219a0425ff7367f138f709a2af76f17e38ea795ad9d0612b7576c0a9720dcec3203239085e43ab3581175af1baca2edfe2b10ee63101e0852da", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0abb0e57a49ad27c72e19372baff7228e667f5d5a9baf29a57381cd1012b5560e84b470d6d811e9acfdd66aa091f9a2f083cc28ba4eafbb98d7d8f1823bd2a99", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/99e387f5cfcd8c143b2a3e2b82773fda5f24393986f3c821df6b8ba76d4f0ecce7d6817326c6591b2932e4cdd4f0e16e98a58d88f48e2cd79b3d369fb0f084c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/239a2fecbad797626914858157bd6cda028eb65ace96d9d1a9dc99339b30db8ccc5554d8065c48b44e34cc1bc0a3bed5d9c69468bb873bb50df17706430defd7"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-27 19:30:51.350962) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 19:30:51.351324) ========= 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.64v80QNhjZ/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.2SHmUekvYN/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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.005386 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 19:30:51.400409) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-27 19:30:51.402353) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-27 19:30:51.402712) ========= ========= Total master_lag: 0.87 =========