builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0181 starttime: 1496658450.27 results: success (0) revision: 275588f4d852d7dc183a9dcc70a311413dc7a063 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-05 03:27:30.273032) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-05 03:27:30.273505) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-05 03:27:30.273784) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-05 03:27:30.302300) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 03:27:30.302697) ========= 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.FD1Cpq8uDe/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.uvtzJQ11Cj/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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-06-05 03:27:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.4M=0.001s 2017-06-05 03:27:30 (14.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.127133 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 03:27:30.452852) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 03:27:30.453192) ========= 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.FD1Cpq8uDe/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.uvtzJQ11Cj/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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.028375 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 03:27:30.502275) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-05 03:27:30.502617) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 275588f4d852d7dc183a9dcc70a311413dc7a063 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 275588f4d852d7dc183a9dcc70a311413dc7a063 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FD1Cpq8uDe/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.uvtzJQ11Cj/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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-06-05 03:27:30,583 truncating revision to first 12 chars 2017-06-05 03:27:30,583 Setting DEBUG logging. 2017-06-05 03:27:30,583 attempt 1/10 2017-06-05 03:27:30,583 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/275588f4d852?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-05 03:27:31,845 unpacking tar archive at: mozilla-central-275588f4d852/testing/mozharness/ program finished with exit code 0 elapsedTime=1.529775 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-05 03:27:32.053935) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-05 03:27:32.054251) ========= script_repo_revision: 275588f4d852d7dc183a9dcc70a311413dc7a063 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-05 03:27:32.054635) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-05 03:27:32.054900) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-05 03:27:32.073370) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 22 mins, 21 secs) (at 2017-06-05 03:27:32.073752) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FD1Cpq8uDe/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.uvtzJQ11Cj/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 03:27:32 INFO - MultiFileLogger online at 20170605 03:27:32 in /builds/slave/test 03:27:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:27:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:27:32 INFO - {'append_to_log': False, 03:27:32 INFO - 'base_work_dir': '/builds/slave/test', 03:27:32 INFO - 'blob_upload_branch': 'Firefox', 03:27:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:27:32 INFO - 'branch': 'Firefox', 03:27:32 INFO - 'buildbot_json_path': 'buildprops.json', 03:27:32 INFO - 'config_files': ('talos/mac_config.py',), 03:27:32 INFO - 'default_actions': ('clobber', 03:27:32 INFO - 'read-buildbot-config', 03:27:32 INFO - 'download-and-extract', 03:27:32 INFO - 'populate-webroot', 03:27:32 INFO - 'create-virtualenv', 03:27:32 INFO - 'install', 03:27:32 INFO - 'setup-mitmproxy', 03:27:32 INFO - 'run-tests'), 03:27:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:27:32 INFO - 'download_minidump_stackwalk': True, 03:27:32 INFO - 'download_symbols': 'ondemand', 03:27:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:27:32 INFO - 'tooltool.py': '/tools/tooltool.py', 03:27:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:27:32 INFO - '/tools/misc-python/virtualenv.py')}, 03:27:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:27:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:27:32 INFO - 'gecko_profile': False, 03:27:32 INFO - 'gecko_profile_interval': 0, 03:27:32 INFO - 'installer_path': 'installer.exe', 03:27:32 INFO - 'log_level': 'info', 03:27:32 INFO - 'log_name': 'talos', 03:27:32 INFO - 'log_to_console': True, 03:27:32 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:27:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:27:32 INFO - 'opt_config_files': (), 03:27:32 INFO - 'pip_index': False, 03:27:32 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:27:32 INFO - 'cmd': ('bash', 03:27:32 INFO - '-c', 03:27:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:27:32 INFO - 'enabled': True, 03:27:32 INFO - 'halt_on_failure': False, 03:27:32 INFO - 'name': 'check_screen_resolution'},), 03:27:32 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:27:32 INFO - 'cmd': ('bash', 03:27:32 INFO - '-c', 03:27:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:27:32 INFO - 'enabled': True, 03:27:32 INFO - 'halt_on_failure': False, 03:27:32 INFO - 'name': 'check_screen_resolution'},), 03:27:32 INFO - 'run_cmd_checks_enabled': True, 03:27:32 INFO - 'suite': 'dromaeojs-e10s', 03:27:32 INFO - 'system_bits': '32', 03:27:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:27:32 INFO - 'title': 't-yosemite-r7-0181', 03:27:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:27:32 INFO - 'use_talos_json': True, 03:27:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:27:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:27:32 INFO - 'work_dir': 'build'} 03:27:32 INFO - [mozharness: 2017-06-05 10:27:32.268262Z] Running clobber step. 03:27:32 INFO - Running pre-action listener: _resource_record_pre_action 03:27:32 INFO - Running main action method: clobber 03:27:32 INFO - rmtree: /builds/slave/test/build 03:27:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:27:34 INFO - Running post-action listener: _resource_record_post_action 03:27:34 INFO - [mozharness: 2017-06-05 10:27:34.831295Z] Finished clobber step (success) 03:27:34 INFO - [mozharness: 2017-06-05 10:27:34.831516Z] Running read-buildbot-config step. 03:27:34 INFO - Running pre-action listener: _resource_record_pre_action 03:27:34 INFO - Running main action method: read_buildbot_config 03:27:34 INFO - Using buildbot properties: 03:27:34 INFO - { 03:27:34 INFO - "project": "", 03:27:34 INFO - "product": "firefox", 03:27:34 INFO - "who": "archaeopteryx@coole-files.de", 03:27:34 INFO - "installer_path": "public/build/firefox-55.0a1.en-US.mac.dmg", 03:27:34 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 03:27:34 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 03:27:34 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 03:27:34 INFO - "stage_platform": "macosx64", 03:27:34 INFO - "basedir": "/builds/slave/test", 03:27:34 INFO - "buildnumber": 76, 03:27:34 INFO - "platform": "yosemite_r7", 03:27:34 INFO - "parent_task_id": "RSAMZbYIQaCZN1SHK5W3ew", 03:27:34 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 03:27:34 INFO - "slavebuilddir": "test", 03:27:34 INFO - "taskId": "aDWA08YLSTq-ms5EASzB5Q", 03:27:34 INFO - "branch": "mozilla-central", 03:27:34 INFO - "script_repo_revision": "production", 03:27:34 INFO - "revision": "275588f4d852d7dc183a9dcc70a311413dc7a063", 03:27:34 INFO - "slavename": "t-yosemite-r7-0181", 03:27:34 INFO - "repo_path": "mozilla-central" 03:27:34 INFO - } 03:27:34 INFO - Finding installer, test and symbols from parent task. 03:27:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aDWA08YLSTq-ms5EASzB5Q'}, attempt #1 03:27:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aDWA08YLSTq-ms5EASzB5Q'}, attempt #1 03:27:36 INFO - Task dependencies: PPEr4K2ZRbOx5LcB7UkZaw RSAMZbYIQaCZN1SHK5W3ew 03:27:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RSAMZbYIQaCZN1SHK5W3ew'}, attempt #1 03:27:36 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/RSAMZbYIQaCZN1SHK5W3ew/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:27:36 INFO - Set test_url: https://queue.taskcluster.net/v1/task/RSAMZbYIQaCZN1SHK5W3ew/artifacts/public/build/test_packages.json 03:27:36 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/RSAMZbYIQaCZN1SHK5W3ew/artifacts/public/build/target.crashreporter-symbols.zip 03:27:36 INFO - Running post-action listener: _resource_record_post_action 03:27:36 INFO - [mozharness: 2017-06-05 10:27:36.534899Z] Finished read-buildbot-config step (success) 03:27:36 INFO - [mozharness: 2017-06-05 10:27:36.535041Z] Running download-and-extract step. 03:27:36 INFO - Running pre-action listener: _resource_record_pre_action 03:27:36 INFO - Running main action method: download_and_extract 03:27:36 INFO - mkdir: /builds/slave/test/build/tests 03:27: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')]} 03:27:36 INFO - trying https://queue.taskcluster.net/v1/task/RSAMZbYIQaCZN1SHK5W3ew/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 03:27:36 INFO - Downloading https://queue.taskcluster.net/v1/task/RSAMZbYIQaCZN1SHK5W3ew/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 03:27:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RSAMZbYIQaCZN1SHK5W3ew/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 03:27:37 INFO - Downloaded 1328 bytes. 03:27:37 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 03:27:37 INFO - Using the following test package requirements: 03:27:37 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:27:37 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 03:27:37 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 03:27:37 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:27:37 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 03:27:37 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:27:37 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 03:27:37 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:27:37 INFO - u'jsshell-mac.zip'], 03:27:37 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:27:37 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 03:27:37 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 03:27:37 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:27:37 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 03:27:37 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:27:37 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 03:27:37 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:27:37 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.tar.gz'], 03:27:37 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:27:37 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 03:27:37 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:27:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RSAMZbYIQaCZN1SHK5W3ew/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 03:27:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RSAMZbYIQaCZN1SHK5W3ew/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:27:37 INFO - Fetch https://queue.taskcluster.net/v1/task/RSAMZbYIQaCZN1SHK5W3ew/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 03:27:39 INFO - Content-Length response header: 57631633 03:27:39 INFO - Bytes received: 57631633 03:27:57 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 03:27:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RSAMZbYIQaCZN1SHK5W3ew/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 03:27:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RSAMZbYIQaCZN1SHK5W3ew/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:27:57 INFO - Fetch https://queue.taskcluster.net/v1/task/RSAMZbYIQaCZN1SHK5W3ew/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 03:27:59 INFO - Content-Length response header: 57631633 03:27:59 INFO - Bytes received: 57631633 03:28:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RSAMZbYIQaCZN1SHK5W3ew/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 03:28:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RSAMZbYIQaCZN1SHK5W3ew/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 03:28:17 INFO - Fetch https://queue.taskcluster.net/v1/task/RSAMZbYIQaCZN1SHK5W3ew/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 03:28:18 INFO - Content-Length response header: 14447425 03:28:18 INFO - Bytes received: 14447425 03:28: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')]} 03:28:18 INFO - trying https://queue.taskcluster.net/v1/task/RSAMZbYIQaCZN1SHK5W3ew/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:28:18 INFO - Downloading https://queue.taskcluster.net/v1/task/RSAMZbYIQaCZN1SHK5W3ew/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 03:28:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RSAMZbYIQaCZN1SHK5W3ew/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 03:28:20 INFO - Downloaded 67887199 bytes. 03:28:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RSAMZbYIQaCZN1SHK5W3ew/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:28:20 INFO - mkdir: /builds/slave/test/properties 03:28:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:28:20 INFO - Writing to file /builds/slave/test/properties/build_url 03:28:20 INFO - Contents: 03:28:20 INFO - build_url:https://queue.taskcluster.net/v1/task/RSAMZbYIQaCZN1SHK5W3ew/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:28:20 INFO - Running post-action listener: _resource_record_post_action 03:28:20 INFO - Running post-action listener: set_extra_try_arguments 03:28:20 INFO - [mozharness: 2017-06-05 10:28:20.724815Z] Finished download-and-extract step (success) 03:28:20 INFO - [mozharness: 2017-06-05 10:28:20.724963Z] Running populate-webroot step. 03:28:20 INFO - Running pre-action listener: _resource_record_pre_action 03:28:20 INFO - Running main action method: populate_webroot 03:28:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:28:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:28:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:28:20 INFO - '--tppagecycles', 03:28:20 INFO - '7'], 03:28:20 INFO - 'tests': ['tsvgm']}}, 03:28:20 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:28:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:28:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:28:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:28:20 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:28:20 INFO - 'talos_options': ['--disable-e10s'], 03:28:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:28:20 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:28:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:28:20 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:28:20 INFO - 'talos_options': ['--disable-e10s'], 03:28:20 INFO - 'tests': ['damp', 'tps']}, 03:28:20 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:28:20 INFO - 'tests': ['damp', 'tps']}, 03:28:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:28:20 INFO - 'tests': ['dromaeo_dom']}, 03:28:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:28:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:28:20 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 03:28:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:28:20 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:28:20 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:28:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:28:20 INFO - 'tests': ['a11yr', 03:28:20 INFO - 'ts_paint', 03:28:20 INFO - 'tpaint', 03:28:20 INFO - 'sessionrestore', 03:28:20 INFO - 'sessionrestore_no_auto_restore', 03:28:20 INFO - 'tabpaint']}, 03:28:20 INFO - 'other-e10s': {'tests': ['a11yr', 03:28:20 INFO - 'ts_paint', 03:28:20 INFO - 'tpaint', 03:28:20 INFO - 'sessionrestore', 03:28:20 INFO - 'sessionrestore_no_auto_restore', 03:28:20 INFO - 'tabpaint']}, 03:28:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:28:20 INFO - 'ts_paint', 03:28:20 INFO - 'tpaint', 03:28:20 INFO - 'sessionrestore', 03:28:20 INFO - 'sessionrestore_no_auto_restore', 03:28:20 INFO - 'tabpaint']}, 03:28:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:28:20 INFO - 'ts_paint', 03:28:20 INFO - 'tpaint', 03:28:20 INFO - 'sessionrestore', 03:28:20 INFO - 'sessionrestore_no_auto_restore', 03:28:20 INFO - 'tabpaint']}, 03:28:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:28:20 INFO - 'tests': ['a11yr', 03:28:20 INFO - 'ts_paint', 03:28:20 INFO - 'tpaint', 03:28:20 INFO - 'sessionrestore', 03:28:20 INFO - 'sessionrestore_no_auto_restore', 03:28:20 INFO - 'tabpaint']}, 03:28:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:28:20 INFO - 'tests': ['a11yr', 03:28:20 INFO - 'ts_paint', 03:28:20 INFO - 'tpaint', 03:28:20 INFO - 'sessionrestore', 03:28:20 INFO - 'sessionrestore_no_auto_restore', 03:28:20 INFO - 'tabpaint']}, 03:28:20 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 03:28:20 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 03:28:20 INFO - 'bloom_basic_ref']}, 03:28:20 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 03:28:20 INFO - 'talos_options': ['--mitmproxy', 03:28:20 INFO - 'mitmproxy-recording-1.mp', 03:28:20 INFO - '--firstNonBlankPaint'], 03:28:20 INFO - 'tests': ['Quantum_1']}, 03:28:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:28:20 INFO - 'tests': ['tsvgx', 03:28:20 INFO - 'tsvgr_opacity', 03:28:20 INFO - 'tart', 03:28:20 INFO - 'tscrollx', 03:28:20 INFO - 'cart', 03:28:20 INFO - 'tsvg_static']}, 03:28:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:28:20 INFO - 'tsvgr_opacity', 03:28:20 INFO - 'tart', 03:28:20 INFO - 'tscrollx', 03:28:20 INFO - 'cart', 03:28:20 INFO - 'tsvg_static']}, 03:28:20 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:28:20 INFO - 'talos_options': ['--disable-e10s'], 03:28:20 INFO - 'tests': ['tp5o']}, 03:28:20 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:28:20 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:28:20 INFO - 'talos_options': ['--disable-e10s', 03:28:20 INFO - '--xperf_path', 03:28:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:28:20 INFO - 'tests': ['tp5n']}, 03:28:20 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:28:20 INFO - 'talos_options': ['--xperf_path', 03:28:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:28:20 INFO - 'tests': ['tp5n']}}, 03:28:20 INFO - 'talos.zip': {'path': '', 03:28:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:28:20 INFO - Running post-action listener: _resource_record_post_action 03:28:20 INFO - [mozharness: 2017-06-05 10:28:20.747578Z] Finished populate-webroot step (success) 03:28:20 INFO - [mozharness: 2017-06-05 10:28:20.747724Z] Running create-virtualenv step. 03:28:20 INFO - Running pre-action listener: _resource_record_pre_action 03:28:20 INFO - Running main action method: create_virtualenv 03:28:20 INFO - Creating virtualenv /builds/slave/test/build/venv 03:28: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 03:28:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:28:20 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:28:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:28:20 INFO - Using real prefix '/tools/python27' 03:28:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:28:21 INFO - Installing distribute.............................................................................................................................................................................................done. 03:28:24 INFO - Installing pip.................done. 03:28:24 INFO - Return code: 0 03:28:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:28:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:28:24 INFO - Reading from file tmpfile_stdout 03:28:24 INFO - Output received: 03:28: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) 03:28:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:28: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')]} 03:28:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28: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')]} 03:28:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28: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 0x109211c10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109215768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84605c45e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10919ac60>, '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 0x108f2fcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f58be8>, '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.FD1Cpq8uDe/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.uvtzJQ11Cj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:28: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 03:28: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 03:28:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FD1Cpq8uDe/Render', 03:28:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:28:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:28:24 INFO - 'HOME': '/Users/cltbld', 03:28:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:28:24 INFO - 'LOGNAME': 'cltbld', 03:28:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:24 INFO - 'MOZ_NO_REMOTE': '1', 03:28:24 INFO - 'NO_EM_RESTART': '1', 03:28:24 INFO - 'PAGER': '/bin/cat', 03:28:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:28:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:24 INFO - 'PWD': '/builds/slave/test', 03:28:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:28:24 INFO - 'SHELL': '/bin/bash', 03:28:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uvtzJQ11Cj/Listeners', 03:28:24 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 03:28:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:28:24 INFO - 'USER': 'cltbld', 03:28:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:28:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:28:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:24 INFO - 'XPC_FLAGS': '0x0', 03:28:24 INFO - 'XPC_SERVICE_NAME': '0', 03:28:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:28:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28: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 03:28:25 INFO - Cleaning up... 03:28:25 INFO - Return code: 0 03:28:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:28: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')]} 03:28:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28: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')]} 03:28:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28: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 0x109211c10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109215768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84605c45e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10919ac60>, '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 0x108f2fcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f58be8>, '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.FD1Cpq8uDe/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.uvtzJQ11Cj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:28: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 03:28: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 03:28:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FD1Cpq8uDe/Render', 03:28:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:28:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:28:25 INFO - 'HOME': '/Users/cltbld', 03:28:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:28:25 INFO - 'LOGNAME': 'cltbld', 03:28:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:25 INFO - 'MOZ_NO_REMOTE': '1', 03:28:25 INFO - 'NO_EM_RESTART': '1', 03:28:25 INFO - 'PAGER': '/bin/cat', 03:28:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:28:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:25 INFO - 'PWD': '/builds/slave/test', 03:28:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:28:25 INFO - 'SHELL': '/bin/bash', 03:28:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uvtzJQ11Cj/Listeners', 03:28:25 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 03:28:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:28:25 INFO - 'USER': 'cltbld', 03:28:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:28:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:28:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:25 INFO - 'XPC_FLAGS': '0x0', 03:28:25 INFO - 'XPC_SERVICE_NAME': '0', 03:28:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:28:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:25 INFO - Downloading/unpacking psutil>=3.1.1 03:28: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 03:28: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 03:28: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 03:28: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 03:28:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:28:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:28:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:28:27 INFO - Installing collected packages: psutil 03:28:27 INFO - Running setup.py install for psutil 03:28:27 INFO - building 'psutil._psutil_osx' extension 03:28: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 03:28: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_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 03:28: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 03:28: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 03:28:28 INFO - building 'psutil._psutil_posix' extension 03:28: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 03:28:28 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:28:28 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:28:28 INFO - ^ 03:28:28 INFO - 1 warning generated. 03:28: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 03:28:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:28:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:28:28 INFO - Successfully installed psutil 03:28:28 INFO - Cleaning up... 03:28:28 INFO - Return code: 0 03:28:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:28: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')]} 03:28:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28: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')]} 03:28:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x109211c10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109215768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84605c45e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10919ac60>, '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 0x108f2fcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f58be8>, '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.FD1Cpq8uDe/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.uvtzJQ11Cj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:28:29 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 03:28:29 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 03:28:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FD1Cpq8uDe/Render', 03:28:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:28:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:28:29 INFO - 'HOME': '/Users/cltbld', 03:28:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:28:29 INFO - 'LOGNAME': 'cltbld', 03:28:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:29 INFO - 'MOZ_NO_REMOTE': '1', 03:28:29 INFO - 'NO_EM_RESTART': '1', 03:28:29 INFO - 'PAGER': '/bin/cat', 03:28:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:28:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:29 INFO - 'PWD': '/builds/slave/test', 03:28:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:28:29 INFO - 'SHELL': '/bin/bash', 03:28:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uvtzJQ11Cj/Listeners', 03:28:29 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 03:28:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:28:29 INFO - 'USER': 'cltbld', 03:28:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:28:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:28:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:29 INFO - 'XPC_FLAGS': '0x0', 03:28:29 INFO - 'XPC_SERVICE_NAME': '0', 03:28:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:28:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:28: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 03:28: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 03:28: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 03:28: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 03:28:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:28:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:28:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:28:31 INFO - Installing collected packages: mozsystemmonitor 03:28:31 INFO - Running setup.py install for mozsystemmonitor 03:28:31 INFO - Successfully installed mozsystemmonitor 03:28:31 INFO - Cleaning up... 03:28:31 INFO - Return code: 0 03:28:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:28:31 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')]} 03:28:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:31 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')]} 03:28:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:31 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 0x109211c10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109215768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84605c45e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10919ac60>, '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 0x108f2fcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f58be8>, '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.FD1Cpq8uDe/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.uvtzJQ11Cj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:28:31 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 03:28:31 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 03:28:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FD1Cpq8uDe/Render', 03:28:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:28:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:28:31 INFO - 'HOME': '/Users/cltbld', 03:28:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:28:31 INFO - 'LOGNAME': 'cltbld', 03:28:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:31 INFO - 'MOZ_NO_REMOTE': '1', 03:28:31 INFO - 'NO_EM_RESTART': '1', 03:28:31 INFO - 'PAGER': '/bin/cat', 03:28:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:28:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:31 INFO - 'PWD': '/builds/slave/test', 03:28:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:28:31 INFO - 'SHELL': '/bin/bash', 03:28:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uvtzJQ11Cj/Listeners', 03:28:31 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 03:28:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:28:31 INFO - 'USER': 'cltbld', 03:28:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:28:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:28:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:31 INFO - 'XPC_FLAGS': '0x0', 03:28:31 INFO - 'XPC_SERVICE_NAME': '0', 03:28:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:28:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:31 INFO - Downloading/unpacking jsonschema==2.5.1 03:28:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:28:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:28:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:33 INFO - Downloading functools32-3.2.3-2.tar.gz 03:28:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:28:33 INFO - warning: no files found matching '*.txt' 03:28:33 INFO - no previously-included directories found matching 'build' 03:28:33 INFO - no previously-included directories found matching 'dist' 03:28:33 INFO - no previously-included directories found matching '.git*' 03:28:33 INFO - Installing collected packages: jsonschema, functools32 03:28:33 INFO - Running setup.py install for functools32 03:28:33 INFO - warning: no files found matching '*.txt' 03:28:33 INFO - no previously-included directories found matching 'build' 03:28:33 INFO - no previously-included directories found matching 'dist' 03:28:33 INFO - no previously-included directories found matching '.git*' 03:28:33 INFO - Successfully installed jsonschema functools32 03:28:33 INFO - Cleaning up... 03:28:33 INFO - Return code: 0 03:28:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:28: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')]} 03:28:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28: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')]} 03:28:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28: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 0x109211c10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109215768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84605c45e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10919ac60>, '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 0x108f2fcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f58be8>, '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.FD1Cpq8uDe/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.uvtzJQ11Cj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:28: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 03:28: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 03:28:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FD1Cpq8uDe/Render', 03:28:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:28:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:28:33 INFO - 'HOME': '/Users/cltbld', 03:28:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:28:33 INFO - 'LOGNAME': 'cltbld', 03:28:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:33 INFO - 'MOZ_NO_REMOTE': '1', 03:28:33 INFO - 'NO_EM_RESTART': '1', 03:28:33 INFO - 'PAGER': '/bin/cat', 03:28:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:28:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:33 INFO - 'PWD': '/builds/slave/test', 03:28:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:28:33 INFO - 'SHELL': '/bin/bash', 03:28:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uvtzJQ11Cj/Listeners', 03:28:33 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 03:28:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:28:33 INFO - 'USER': 'cltbld', 03:28:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:28:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:28:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:33 INFO - 'XPC_FLAGS': '0x0', 03:28:33 INFO - 'XPC_SERVICE_NAME': '0', 03:28:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:28:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:28:34 INFO - Cleaning up... 03:28:34 INFO - Return code: 0 03:28:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:28:34 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')]} 03:28:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:34 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')]} 03:28:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:34 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 0x109211c10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109215768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84605c45e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10919ac60>, '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 0x108f2fcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f58be8>, '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.FD1Cpq8uDe/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.uvtzJQ11Cj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:28:34 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 03:28:34 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 03:28:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FD1Cpq8uDe/Render', 03:28:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:28:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:28:34 INFO - 'HOME': '/Users/cltbld', 03:28:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:28:34 INFO - 'LOGNAME': 'cltbld', 03:28:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:34 INFO - 'MOZ_NO_REMOTE': '1', 03:28:34 INFO - 'NO_EM_RESTART': '1', 03:28:34 INFO - 'PAGER': '/bin/cat', 03:28:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:28:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:34 INFO - 'PWD': '/builds/slave/test', 03:28:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:28:34 INFO - 'SHELL': '/bin/bash', 03:28:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uvtzJQ11Cj/Listeners', 03:28:34 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 03:28:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:28:34 INFO - 'USER': 'cltbld', 03:28:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:28:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:28:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:34 INFO - 'XPC_FLAGS': '0x0', 03:28:34 INFO - 'XPC_SERVICE_NAME': '0', 03:28:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:28:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:34 INFO - Downloading/unpacking blobuploader==1.2.4 03:28:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:35 INFO - Downloading blobuploader-1.2.4.tar.gz 03:28:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:28:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:28: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 03:28: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 03:28: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 03:28: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 03:28:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:28:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:28:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:36 INFO - Downloading docopt-0.6.1.tar.gz 03:28:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:28:36 INFO - Installing collected packages: blobuploader, requests, docopt 03:28:36 INFO - Running setup.py install for blobuploader 03:28:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:28:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:28:36 INFO - Running setup.py install for requests 03:28:37 INFO - Running setup.py install for docopt 03:28:37 INFO - Successfully installed blobuploader requests docopt 03:28:37 INFO - Cleaning up... 03:28:37 INFO - Return code: 0 03:28:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:28:37 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')]} 03:28:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:37 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')]} 03:28:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:37 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 0x109211c10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109215768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84605c45e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10919ac60>, '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 0x108f2fcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f58be8>, '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.FD1Cpq8uDe/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.uvtzJQ11Cj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:28:37 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 03:28:37 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 03:28:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FD1Cpq8uDe/Render', 03:28:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:28:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:28:37 INFO - 'HOME': '/Users/cltbld', 03:28:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:28:37 INFO - 'LOGNAME': 'cltbld', 03:28:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:37 INFO - 'MOZ_NO_REMOTE': '1', 03:28:37 INFO - 'NO_EM_RESTART': '1', 03:28:37 INFO - 'PAGER': '/bin/cat', 03:28:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:28:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:37 INFO - 'PWD': '/builds/slave/test', 03:28:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:28:37 INFO - 'SHELL': '/bin/bash', 03:28:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uvtzJQ11Cj/Listeners', 03:28:37 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 03:28:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:28:37 INFO - 'USER': 'cltbld', 03:28:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:28:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:28:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:37 INFO - 'XPC_FLAGS': '0x0', 03:28:37 INFO - 'XPC_SERVICE_NAME': '0', 03:28:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:28:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:28:37 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-3WjV9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:28:38 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-LojPOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:28:38 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-CiSZm3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:28:38 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-Bi3P_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:28:38 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-npt4PX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:28:38 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-FiPRHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:28:38 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-YEhpau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:28:38 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-tnz530-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:28:38 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-2ikuu8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:28:38 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-QLrMGg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:28:38 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-WPEF4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:28:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:28:39 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-4XiT7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:28:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:28:39 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-G9mdAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:28:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:28:39 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-I8B49W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:28:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:39 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-YACdcw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:28:39 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-PipkyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:28:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:28:39 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-bBv8lN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:28:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:28:39 INFO - Running setup.py install for manifestparser 03:28:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:28:39 INFO - Running setup.py install for mozcrash 03:28:40 INFO - Running setup.py install for mozdebug 03:28:40 INFO - Running setup.py install for mozdevice 03:28:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:28:40 INFO - Running setup.py install for mozfile 03:28:40 INFO - Running setup.py install for mozhttpd 03:28:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:28:40 INFO - Running setup.py install for mozinfo 03:28:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:28:40 INFO - Running setup.py install for mozInstall 03:28:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:28:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:28:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:28:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:28:40 INFO - Running setup.py install for mozleak 03:28:41 INFO - Running setup.py install for mozlog 03:28:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:28:41 INFO - Running setup.py install for moznetwork 03:28:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:28:41 INFO - Running setup.py install for mozprocess 03:28:41 INFO - Running setup.py install for mozprofile 03:28:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:28:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:28:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:28:41 INFO - Running setup.py install for mozrunner 03:28:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:28:41 INFO - Running setup.py install for mozscreenshot 03:28:41 INFO - Running setup.py install for moztest 03:28:42 INFO - Running setup.py install for mozversion 03:28:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:28:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:28:42 INFO - Cleaning up... 03:28:42 INFO - Return code: 0 03:28:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:28:42 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')]} 03:28:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:42 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')]} 03:28:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:42 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 0x109211c10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109215768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84605c45e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10919ac60>, '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 0x108f2fcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f58be8>, '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.FD1Cpq8uDe/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.uvtzJQ11Cj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:28:42 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 03:28:42 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 03:28:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FD1Cpq8uDe/Render', 03:28:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:28:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:28:42 INFO - 'HOME': '/Users/cltbld', 03:28:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:28:42 INFO - 'LOGNAME': 'cltbld', 03:28:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:42 INFO - 'MOZ_NO_REMOTE': '1', 03:28:42 INFO - 'NO_EM_RESTART': '1', 03:28:42 INFO - 'PAGER': '/bin/cat', 03:28:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:28:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:42 INFO - 'PWD': '/builds/slave/test', 03:28:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:28:42 INFO - 'SHELL': '/bin/bash', 03:28:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uvtzJQ11Cj/Listeners', 03:28:42 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 03:28:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:28:42 INFO - 'USER': 'cltbld', 03:28:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:28:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:28:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:42 INFO - 'XPC_FLAGS': '0x0', 03:28:42 INFO - 'XPC_SERVICE_NAME': '0', 03:28:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:28:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:28:42 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-tW4RTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:28:42 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:28:42 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-ZjPoiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:28:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:28:42 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-wmR0fM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:28: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)) 03:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:28:42 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-CMMAJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:28:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:28:42 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-RlPRBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:28:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:28:43 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-Q0_q2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:28:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:28:43 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-cCf4l4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:28:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:28:43 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-jjaurL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:28:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:28:43 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-ZfZOAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:28:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:28:43 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-Vhb92Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:28:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:28:43 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-4Z2Dob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:28:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:28:43 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-Pc1Y4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:28: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)) 03:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:28:43 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-qKrWmp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:28: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)) 03:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:28:43 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-9o9oNC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:28:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:28:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:44 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-RUOoja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:28:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:28:44 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-Uojldz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:28:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:28:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:28:44 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-PDp_6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:28:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:28:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:28:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:28:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:28:44 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:28:44 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:28:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:28:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:45 INFO - Downloading blessings-1.6.tar.gz 03:28:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:28:45 INFO - Installing collected packages: blessings 03:28:45 INFO - Running setup.py install for blessings 03:28:46 INFO - Successfully installed blessings 03:28:46 INFO - Cleaning up... 03:28:46 INFO - Return code: 0 03:28:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:28:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:28:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:28:46 INFO - Reading from file tmpfile_stdout 03:28:46 INFO - Current package versions: 03:28:46 INFO - blessings == 1.6 03:28:46 INFO - blobuploader == 1.2.4 03:28:46 INFO - docopt == 0.6.1 03:28:46 INFO - functools32 == 3.2.3-2 03:28:46 INFO - jsonschema == 2.5.1 03:28:46 INFO - manifestparser == 1.1 03:28:46 INFO - mozInstall == 1.12 03:28:46 INFO - mozcrash == 1.0 03:28:46 INFO - mozdebug == 0.1 03:28:46 INFO - mozdevice == 0.51 03:28:46 INFO - mozfile == 1.2 03:28:46 INFO - mozhttpd == 0.7 03:28:46 INFO - mozinfo == 0.9 03:28:46 INFO - mozleak == 0.1 03:28:46 INFO - mozlog == 3.4 03:28:46 INFO - moznetwork == 0.27 03:28:46 INFO - mozprocess == 0.25 03:28:46 INFO - mozprofile == 0.28 03:28:46 INFO - mozrunner == 6.13 03:28:46 INFO - mozscreenshot == 0.1 03:28:46 INFO - mozsystemmonitor == 0.3 03:28:46 INFO - moztest == 0.8 03:28:46 INFO - mozversion == 1.4 03:28:46 INFO - psutil == 3.1.1 03:28:46 INFO - requests == 1.2.3 03:28:46 INFO - wsgiref == 0.1.2 03:28:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:28:46 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')]} 03:28:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:46 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')]} 03:28:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:46 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 0x109211c10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109215768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84605c45e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10919ac60>, '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 0x108f2fcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f58be8>, '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.FD1Cpq8uDe/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.uvtzJQ11Cj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:28:46 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 03:28:46 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 03:28:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FD1Cpq8uDe/Render', 03:28:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:28:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:28:46 INFO - 'HOME': '/Users/cltbld', 03:28:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:28:46 INFO - 'LOGNAME': 'cltbld', 03:28:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:46 INFO - 'MOZ_NO_REMOTE': '1', 03:28:46 INFO - 'NO_EM_RESTART': '1', 03:28:46 INFO - 'PAGER': '/bin/cat', 03:28:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:28:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:46 INFO - 'PWD': '/builds/slave/test', 03:28:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:28:46 INFO - 'SHELL': '/bin/bash', 03:28:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uvtzJQ11Cj/Listeners', 03:28:46 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 03:28:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:28:46 INFO - 'USER': 'cltbld', 03:28:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:28:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:28:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:46 INFO - 'XPC_FLAGS': '0x0', 03:28:46 INFO - 'XPC_SERVICE_NAME': '0', 03:28:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:28:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:28:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:28:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:28:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:28:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:28:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:28:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:28:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:28:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:28:46 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:28:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:48 INFO - Downloading marionette_driver-1.4.0.tar.gz 03:28:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 03:28:48 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:28:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:28:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:28:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:28:48 INFO - Installing collected packages: marionette-driver 03:28:48 INFO - Running setup.py install for marionette-driver 03:28:48 INFO - Successfully installed marionette-driver 03:28:48 INFO - Cleaning up... 03:28:48 INFO - Return code: 0 03:28:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:28:48 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')]} 03:28:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:48 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')]} 03:28:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:48 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 0x109211c10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109215768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84605c45e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10919ac60>, '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 0x108f2fcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f58be8>, '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.FD1Cpq8uDe/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.uvtzJQ11Cj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:28:48 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 03:28:48 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 03:28:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FD1Cpq8uDe/Render', 03:28:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:28:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:28:48 INFO - 'HOME': '/Users/cltbld', 03:28:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:28:48 INFO - 'LOGNAME': 'cltbld', 03:28:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:48 INFO - 'MOZ_NO_REMOTE': '1', 03:28:48 INFO - 'NO_EM_RESTART': '1', 03:28:48 INFO - 'PAGER': '/bin/cat', 03:28:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:28:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:48 INFO - 'PWD': '/builds/slave/test', 03:28:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:28:48 INFO - 'SHELL': '/bin/bash', 03:28:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uvtzJQ11Cj/Listeners', 03:28:48 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 03:28:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:28:48 INFO - 'USER': 'cltbld', 03:28:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:28:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:28:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:48 INFO - 'XPC_FLAGS': '0x0', 03:28:48 INFO - 'XPC_SERVICE_NAME': '0', 03:28:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:28:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:28:48 INFO - Cleaning up... 03:28:48 INFO - Return code: 0 03:28:48 INFO - Running post-action listener: _resource_record_post_action 03:28:48 INFO - Running post-action listener: _start_resource_monitoring 03:28:48 INFO - Starting resource monitoring. 03:28:48 INFO - [mozharness: 2017-06-05 10:28:48.737875Z] Finished create-virtualenv step (success) 03:28:48 INFO - [mozharness: 2017-06-05 10:28:48.738830Z] Running install step. 03:28:48 INFO - Running pre-action listener: _resource_record_pre_action 03:28:48 INFO - Running main action method: install 03:28:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:28:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:28:48 INFO - Reading from file tmpfile_stdout 03:28:49 INFO - Detecting whether we're running mozinstall >=1.0... 03:28:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:28:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:28:49 INFO - Reading from file tmpfile_stdout 03:28:49 INFO - Output received: 03:28:49 INFO - Usage: mozinstall [options] installer 03:28:49 INFO - Options: 03:28:49 INFO - -h, --help show this help message and exit 03:28:49 INFO - -d DEST, --destination=DEST 03:28:49 INFO - Directory to install application into. [default: 03:28:49 INFO - "/builds/slave/test"] 03:28:49 INFO - --app=APP Application being installed. [default: firefox] 03:28:49 INFO - mkdir: /builds/slave/test/build/application 03:28:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:28:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 03:29:10 INFO - Reading from file tmpfile_stdout 03:29:10 INFO - Output received: 03:29:10 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:29:10 INFO - Running post-action listener: _resource_record_post_action 03:29:10 INFO - [mozharness: 2017-06-05 10:29:10.532576Z] Finished install step (success) 03:29:10 INFO - [mozharness: 2017-06-05 10:29:10.532724Z] Running setup-mitmproxy step. 03:29:10 INFO - Running pre-action listener: _resource_record_pre_action 03:29:10 INFO - Running main action method: setup_mitmproxy 03:29:10 INFO - Skipping: mitmproxy is not required 03:29:10 INFO - Running post-action listener: _resource_record_post_action 03:29:10 INFO - [mozharness: 2017-06-05 10:29:10.533370Z] Finished setup-mitmproxy step (success) 03:29:10 INFO - [mozharness: 2017-06-05 10:29:10.533517Z] Running run-tests step. 03:29:10 INFO - Running pre-action listener: _resource_record_pre_action 03:29:10 INFO - Running main action method: run_tests 03:29:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:29:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:29:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:29:10 INFO - 2017-06-05 03:29:10.548 screenresolution[1645:7683] starting screenresolution argv=screenresolution get 03:29:10 INFO - 2017-06-05 03:29:10.550 screenresolution[1645:7683] Display 0: 1600x1200x32@60 03:29:10 INFO - 2017-06-05 03:29:10.556 screenresolution[1646:7685] starting screenresolution argv=screenresolution list 03:29:10 INFO - Available Modes on Display 0 03:29:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:29:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:29:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:29:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:29:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:29:10 INFO - Intel Iris: 03:29:10 INFO - Chipset Model: Intel Iris 03:29:10 INFO - Type: GPU 03:29:10 INFO - Bus: Built-In 03:29:10 INFO - VRAM (Dynamic, Max): 1536 MB 03:29:10 INFO - Vendor: Intel (0x8086) 03:29:10 INFO - Device ID: 0x0a2e 03:29:10 INFO - Revision ID: 0x0009 03:29:10 INFO - Displays: 03:29:10 INFO - Display: 03:29:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:29:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:29:10 INFO - Display Serial Number: 1600x1200 60 03:29:10 INFO - Main Display: Yes 03:29:10 INFO - Mirror: Off 03:29:10 INFO - Online: Yes 03:29:10 INFO - Rotation: Supported 03:29:10 INFO - Return code: 0 03:29:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:29:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:29:10 INFO - Python 2.7.3 03:29:10 INFO - Return code: 0 03:29:10 INFO - grabbing minidump binary from tooltool 03:29:10 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')]} 03:29:10 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10919ac60>, '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 0x108f2fcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f58be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:29:10 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:29:10 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 03:29:10 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:29:10 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:29:10 INFO - Return code: 0 03:29:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:29:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:29:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:29:10 INFO - ENV: RUST_BACKTRACE is now 1 03:29:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:29:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:29:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RSAMZbYIQaCZN1SHK5W3ew/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0181', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:29:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RSAMZbYIQaCZN1SHK5W3ew/artifacts/public/build/target.crashreporter-symbols.zip --title t-yosemite-r7-0181 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:29:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FD1Cpq8uDe/Render', 03:29:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:29:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:29:10 INFO - 'HOME': '/Users/cltbld', 03:29:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:29:10 INFO - 'LOGNAME': 'cltbld', 03:29:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:29:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:29:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:10 INFO - 'MOZ_NO_REMOTE': '1', 03:29:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:29:10 INFO - 'NO_EM_RESTART': '1', 03:29:10 INFO - 'PAGER': '/bin/cat', 03:29:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:29:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:10 INFO - 'PWD': '/builds/slave/test', 03:29:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:29:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:29:10 INFO - 'RUST_BACKTRACE': '1', 03:29:10 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:29:10 INFO - 'SHELL': '/bin/bash', 03:29:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uvtzJQ11Cj/Listeners', 03:29:10 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 03:29:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:29:10 INFO - 'USER': 'cltbld', 03:29:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:29:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:29:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:10 INFO - 'XPC_FLAGS': '0x0', 03:29:10 INFO - 'XPC_SERVICE_NAME': '0', 03:29:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:29:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RSAMZbYIQaCZN1SHK5W3ew/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0181', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:29:11 INFO - mozversion application_buildid: 20170605021144 03:29:11 INFO - mozversion application_changeset: 275588f4d852d7dc183a9dcc70a311413dc7a063 03:29:11 INFO - mozversion application_display_name: Nightly 03:29:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:29:11 INFO - mozversion application_name: Firefox 03:29:11 INFO - mozversion application_remotingname: firefox 03:29:11 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:29:11 INFO - mozversion application_vendor: Mozilla 03:29:11 INFO - mozversion application_version: 55.0a1 03:29:11 INFO - mozversion platform_buildid: 20170605021144 03:29:11 INFO - mozversion platform_changeset: 275588f4d852d7dc183a9dcc70a311413dc7a063 03:29:11 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:29:11 INFO - mozversion platform_version: 55.0a1 03:29:11 INFO - using testdate: 1496658551 03:29:11 INFO - actual date: 1496658551 03:29:11 INFO - starting webserver on 'localhost:49230' 03:29:11 INFO - SUITE-START | Running 2 tests 03:29:11 INFO - TEST-START | dromaeo_css 03:29:11 INFO - operating with platform_type : mac_ 03:29:11 INFO - Initialising browser for dromaeo_css test... 03:29:11 INFO - Application command: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox http://localhost:49230/getInfo.html -foreground -profile /var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/tmptEuKhE/profile 03:29:11 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox http://localhost:49230/getInfo.html -foreground) 03:29:44 INFO - TEST-INFO | 1656: killed by SIGTERM 03:29:44 INFO - Browser initialized. 03:29:44 INFO - Running cycle 1/1 for dromaeo_css test... 03:29:44 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/tmptEuKhE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:29:47 INFO - PID 1666 | 2017-06-05 03:29:47.040 plugin-container[1667:8279] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x983f, name = 'com.apple.tsm.portname' 03:29:47 INFO - PID 1666 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:29:47 INFO - PID 1666 | 2017-06-05 03:29:47.040 plugin-container[1667:8279] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9e0f, name = 'com.apple.CFPasteboardClient' 03:29:47 INFO - PID 1666 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:29:47 INFO - PID 1666 | 2017-06-05 03:29:47.041 plugin-container[1667:8279] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:29:47 INFO - PID 1666 | 2017-06-05 03:29:47.557 plugin-container[1668:8327] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x454b, name = 'com.apple.tsm.portname' 03:29:47 INFO - PID 1666 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:29:47 INFO - PID 1666 | 2017-06-05 03:29:47.558 plugin-container[1668:8327] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9e0b, name = 'com.apple.CFPasteboardClient' 03:29:47 INFO - PID 1666 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:29:47 INFO - PID 1666 | 2017-06-05 03:29:47.558 plugin-container[1668:8327] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:29:56 INFO - PID 1666 | RSS: Main: 269606912 03:29:56 INFO - PID 1666 | 03:32:58 INFO - PID 1666 | Cycle 1(1): loaded http://localhost:49230/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49230/tests/dromaeo/cssquery-ext.html) 03:33:00 INFO - PID 1666 | RSS: Main: 268197888 03:33:00 INFO - PID 1666 | 03:36:02 INFO - PID 1666 | Cycle 1(1): loaded http://localhost:49230/tests/dromaeo/cssquery-ext.html (next: http://localhost:49230/tests/dromaeo/cssquery-jquery.html) 03:36:02 INFO - PID 1666 | RSS: Main: 281337856 03:36:02 INFO - PID 1666 | 03:39:04 INFO - PID 1666 | Cycle 1(1): loaded http://localhost:49230/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49230/tests/dromaeo/cssquery-mootools.html) 03:39:05 INFO - PID 1666 | RSS: Main: 282533888 03:39:05 INFO - PID 1666 | 03:42:06 INFO - PID 1666 | Cycle 1(1): loaded http://localhost:49230/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49230/tests/dromaeo/cssquery-prototype.html) 03:42:07 INFO - PID 1666 | RSS: Main: 286162944 03:42:07 INFO - PID 1666 | 03:45:10 INFO - PID 1666 | Cycle 1(1): loaded http://localhost:49230/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49230/tests/dromaeo/cssquery-yui.html) 03:45:11 INFO - PID 1666 | RSS: Main: 286846976 03:45:11 INFO - PID 1666 | 03:48:12 INFO - PID 1666 | Cycle 1(1): loaded http://localhost:49230/tests/dromaeo/cssquery-yui.html (next: http://localhost:49230/tests/dromaeo/cssquery-dojo.html) 03:48:13 INFO - PID 1666 | RSS: Main: 288755712 03:48:13 INFO - PID 1666 | 03:48:13 INFO - PID 1666 | __start_tp_report 03:48:13 INFO - PID 1666 | _x_x_mozilla_page_load 03:48:13 INFO - PID 1666 | _x_x_mozilla_page_load_details 03:48:13 INFO - PID 1666 | |i|pagename|runs| 03:48:13 INFO - PID 1666 | |0;dojo.html;3107.8135311881283;3602.135487483003;3616.4213725803875;3623.6738693517586;3625.3111908737337;4903.4606193318705;5804.245448091742;6185.257769067713;6199.659018753967;6319.462845658119;6163.352847950968;6207.4723648489935;6234.438900498954;6307;6337.271213810413;5289.629725919187;5390.838274851761;5469.07025805612;5482.451754824526;5604.971975140119;5609.411011843759;5610.24261724668;5617.297837770278;5618.353889302721;5624.3250809902665;5379.811706590251;5416.1063424534905;5449.209864569655;5469.234307196995;5552.444755524435;5489.725513724337;5504.669719816824;5518.806841760559;5519.365272993617;5525.696086715229;5423.457654234585;5440.972795136038;5459.317585301837;5471.06991811393;5505.779768809283;5036.546710796046;6199.566030377875;6316.463100636452;6321.96839015802;6337.397947195009;6513.609183448961;6592.439642630382;6685.866282674319;6698.062271282024;6706.429953453913;6814.1482314710665;6818.045473633695;6826.317368263183;6834.4874134440115;6843.0419741236265;6135;6239.06414037898;6361.141245931833;6367.458766004849;6372.681365931685;6760.492963027793;6833.760818371433;6899.241083480813;6925.445964322842;6943.89584156238;5518.972405137949;6332.240131184288;6386.265579458422;6495.7076931538195;6586.341365863375;6766.15423072116;6779.864402711918;6787.626680532618;6807.965960170168;6814.591124532544;6424.357564243632;6644.368784965421;6678.298778628271;6685.6322902240845;6701.1623547056615;5801.7389217485315;6386.36136386367;6452.838679032968;6623.768168114093;6625.105610742585;5342.5993050521365;5348.57211423093;5371.3822910365025;5378.542823860016;5382.2464854920345;4797.56821886032;4804.183288840905;4813.831515896927;4819.156647586658;4821.228603423436;6211.16149319836;6238.095476155932;6275.6862156891975;6367.872642547123;6396.744130234739;6836.179658441019;6837.282085381063;6850.965745171242;6862.210845752703;6864.313568643096;6224.906626400608;6358.713857876407;6391.520635952322;6403.359664033559;6410.134631824737;5783.681897495594;5785.566082543826;5843.3864444233595;5890.9396308664855;5943.286805583271;6882;6904.861902761917;6940.722371105099;6954.235034146341;6987.475939304674;6766.391024807791;6771.45828333742;6835.521513494008;6849.794506164823;6865.141857267841;6318.115463835159;6881.41507971828;6952.270011648704;6956.478264130109;6975.720971161097;5078.873028174326;5434.891302173855;6544.312847150981;6561.507886908596;6644.435223006099;6823.624700641314;6839.760608378683;6843.726250949906;6847.623380714109;6880.311968803079;6371.904421433589;6397.26431460388;6484;6507.381798729113;6545.181852268466;6471.967640161769;6535.803925882231;6559.212894452697;6561.376669216417;6569.57297775643;6339.112524246517;6400.23197216337;6421.646809425526;6429.935700642934;6448.9032664511005;6363.3000369958345;6423.807285781434;6553.442957348679;6566.507511936719;6578.079068930258;6331.715072821827;6365.427111559982;6378.649174295459;6414.743410263537;6432.678366081771 03:48:13 INFO - PID 1666 | |1;ext.html;758.503180416827;776.9728059517914;846.5555583318757;1262.9873701262984;1266.1580049267238;39652.612158574455;40391.79804100975;40409.787706368785;40430.39354409683;40670;40354.798226008905;40409.797951010274;40719.18561628766;40823.97940051493;40920.79539602305;7842.490238134503;8202.466839655403;8413.116622754615;8427.578621068922;8434.493930364168;8314.127016663255;8411.83176336473;8412.242898139166;8420.957895210515;8433.70482033129;8388.203120703523;8389.244967952884;8397.076321604618;8427.662893484254;8440.113788052258;8299.419040667155;8368.037675667285;8411.327093832479;8415.873761893576;8420.24217820396;7144.46416518758;8092.231238032377;8165.8366832663605;8238.629261683238;8238.794030149294;37684.811575941945;38027.80986095052;38028.619713802786;38035.04912377185;38091.4286285706;3580.427131658922;3603.6396360364015;3628.564572251347;3631.782093074424;3637.7635453695425;30663.233419164477;30753.38493230123;30767.692323076706;30813;30824.53763193554;3070.3398769264713;3113.4084523940605;3119.672434394379;3126.3122113135073;3133.3263348380206;225593;228764;281298.99999999796;305402;307760;48568;48682.02635947261;48905.26642100371;49032;49096.50903490919;51231.23153152705;51342.97314053698;51397;55352.72323638356;55407;14328.570142895729;14447.277636118151;14552.563423097325;14570.4900328488;14645;11632.953034226792;11707.2975621463;11715.004224641001;11717.06263498918;11737.823932641017;13752.65618359549;13826.446942122202;13877.861221387859;13916.443342266197;14020.71958560823;5250.081235783722;5954.732037058343;6030.427109424598;6086.117512960596;6091.8477038073515;1009.9949500252452;1016.3596933931576;1029.624187171692;1057.6086847866338;1057.7144171073921;22995.655065174036;23052.386332956532;23416.414589635056;23832.404189895045;24234.757652423603;1090.3839330778085;1092.257265059751;1138.0895283772948;1141.49774099396;1148.8219326004482;10663.520141593646;12007.939960300142;12582.37088145589;12715.872841271654;12793.680157996125;305173;306325;310528;311185;320543;58519.95180168674;58699.70650146722;59207;59362.70318648379;59443.702781485816;1472.3300898091343;1503.8571335723088;1513.3341329814846;1518.2788175616495;1520;24122.87938560296;28147.43705125927;29951;30459.39081218319;30503.694963050086;54505.45494545004;54852;54936.725316373166;54980.450195497535;55065.72467137639;258057;259532;259600;260597;260842;37015.07462313356;37242.62757372392;37252.06869828276;37388.252234954605;37401.43897841589;44574;45530.54469455396;46870.76564617155;46928;47547.76226118847;30051.39897202;30053.248668783457;30538;31254.062378128692;31381.686183137877;22625.773742262365;28867.85566072156;31077.689223107478;31375.686243137276;31723.524147138272;37515.81242093772;37880.43179352257;38287.61712382952;38565.03587410225;38723.2255354897;28776.712232877402;29963.850180748956;31442;32049.67950320467;32266;22447.887760561094;23489;24449.755502444747;24679.25962221136;24769.380765480288 03:48:13 INFO - PID 1666 | |2;jquery.html;375.23077690734;418.7968835114971;434.66096444773086;454.5477250136115;462.1980863202343;21493.785062149374;22394.104235830568;22422.88788556059;23196.768032319673;24222.63666045011;23536.764632353672;23822.880885595547;24177.274681759576;24188.879055604742;24245.878770606167;5808.983427900122;6245.0320200369015;6343.587666801666;6411.871762564746;6428.646424446653;5478.397376288605;5964.79123230687;6249.031400132964;6347.8095657130125;6351.61890286582;5035.295058691786;6132.037747920667;6133.447989680928;6140.4341892817265;6151.815445536641;6109.327973922887;6127.20346354971;6136.539759518032;6140.416660417253;6147.323794382614;5452.509274165344;5481.972590137064;5483.7806487740445;5485.232067510552;5493.242162507999;27226.72773272262;27474.313142171406;27541;27602.447951041067;27708.30729231765;2195.637719776235;2246.2025980776916;2263.128695452246;2263.4567703751145;2265.648824432216;18269.360572380036;18743.718844217346;18779.718304225447;18791.34230301933;18801.529961751065;2147.1733382647635;2176.8911554422216;2206.8344874134505;2217.5675743230076;2221.766714494987;180244.09877950657;184105.07947460312;191460;200839;203542.96457035388;12709.936450317875;12810.167339123114;12984.220946743226;13116.868831311756;13136.802947955788;16420.343186272654;16641.33434662624;16719.49841504757;16747.995120292577;16758.234891243053;8079.636416361278;8546.974363076471;9166.81666366669;9171.44971301724;9216.124468175512;8765.254953328911;8790.560471976376;8866.689665861664;8869.778255543662;8955.820883582292;8108.108108108104;8201.876971845428;8227.259546640831;8236.382271329674;8255.25702686761;2062.958740825205;2235.8434909556177;2236.1726161320416;2238.9812635250923;2264.878884951959;833.295864994079;964.647903515226;972.2562239886493;984.9707056126222;1037.1547189040907;18291.81708182928;19700.817950922992;20173.49566260826;20472.385828425173;21188.682169767464;971.1065819446127;1006.3961623026272;1010.838265877456;1047.8794938582162;1049.375621505203;8899.73300800977;10517.65424677509;10610.752602241648;10651.147908167328;10903.236773425942;487854;494871;494891;496469;500971;137640;138990.3050484741;140429.19141617112;140449;141284;1043.6712435582767;1104.7624760676333;1193.1945936493007;1248.5754843353304;1276.8595454500182;22701.772982270628;23746.762532374454;23827;24078.03687852466;24131.758682413652;63579;64484.71030579456;66001;66362.66818665876;66364.6681766588;88376;88804;89287;89427.55286223527;89498.55250723705;8775.868361974703;10158.136558392323;10168.864538446713;10232.59069637206;10326.432046237529;17389.65220695604;17644.348209551845;17982.37061702834;18271.36050238235;18281.542961426072;12224.144309898578;14641.853581464049;14722.337494812546;14728.189949552878;14838.480653177086;13046.760557746999;13242.735145297233;13270.071095023643;13304;13312.404081204073;14685.85314146845;14969.251537422868;15029.774553381489;15097.245137743288;15229.086254824746;10050.849237261593;10214.846777298199;10321.174306055647;10349.689509314732;10369.96300369957;14398.712025759216;14596.708065838837;14597.124172549256;14746.262686865828;14757.631059223606 03:48:13 INFO - PID 1666 | |3;mootools.html;1399.398258748738;1459.7153555056768;1481.9036762610428;1485.910845349279;1505.728968785619;9496.715098547038;10024.498775061254;11538.769224615502;12030.03759699224;12033.21784084034;9719.514024298793;10150.441725705083;11796.587119450822;11812.877776611229;11826.881731182686;2082.7919806512264;2385.5109702510945;2491.950160996779;2543.834650747705;2553.3744232663025;2514.9748502515017;2517.3958250019955;2534.1257266243115;2539.2509209783066;2546.5739186055866;2513.6857892763405;2523.4354700085883;2524.3941454050987;2529.886155123024;2531.7088534818454;2379.9643005354933;2400.7719266669724;2403.279016295122;2405.8556486610682;2409.6265078912797;2445.877706114705;2464.08828733368;2465.211132437603;2466.9136580219606;2467.8766061696842;11522.366269855154;11744.823827642593;11809.114316426303;11812.881871181264;11821.645350639494;6390.456811171056;6568.93431065688;6623.105880706139;6623.768168114093;6630.933690663128;3986.820593073319;4225.408442818008;4291.163223171483;4293.055527783882;4296.935545966813;1250.5373011985532;1257.1891130221047;1263.9052071094704;1283.9871601284055;1296.870312968705;12852.22886626796;13754.93122534391;15665.921670391575;16196.75704864428;16311.021338719596;5827.621204621686;5828.388019258002;5839.211706419664;5883.499902508334;5945.583809133319;13580.456781728817;13742.862571374359;13745;13745.175289482662;13758.587242382744;6611.570247933869;6638.137042184581;6639.269680335159;6639.970804525306;6685.331466853373;4668.85993420198;5606.243157173811;6055;6176.166217560662;6240.31356550779;4466.486354069324;4600.378948841931;4602.286645569942;4618.953810461852;4645.210314246586;1416.1078520531998;1440.5102265229873;1444.6171764482422;1458.4603696632103;1480.7630779075296;831.2518733140222;834.5076404921004;848.5502683577714;852.1904191018557;868.769776009358;5563.942850858405;7207.315305046012;7378.815529611696;7466.962665186639;7562.7353042644345;602.2562135762417;603.4207161125281;603.7494439807518;608.6774009774826;613.2702084519408;4068.2066996935314;4082.3468245080644;4156.542780294165;4225.112726327506;4250.298700714347;14354.349249836403;14912.925435372754;15025.398984040734;15072.060948115231;15100.622484437978;13923.607639235996;14018.509352172625;14705.705885882437;14741.631459213391;14946.775798363033;8414.242718155396;8691.261242794433;8708.042115367305;8756.912430875736;8760.649574017096;7310.122785265802;7345.77962661121;7496.512726672749;7660.69357225727;7674.462787604814;13525.526606568723;13676.726465470834;13997.370118344903;14008.719825603226;14061.156330620195;10896.78206435851;13885.652858678613;13943.860561394256;14218.715625687635;14226.502072427415;8794.296456283353;9123;9158.95420522893;9525.857112143185;9728.270379721691;11027.393493357942;11065.668029959113;11209.71975700614;11224.214304998899;11300.773984520429;9032.683856065007;9208.447493150432;9210.815783684422;9358.672446464341;9381.061893810564;8898.332625053017;9013.233875120426;9061.456312621263;9083.545822708971;9142.63429462814;8149.266566009088;8183.427160098736;8214.34285257166;8279.793005174919;8290.585470726319;6151.723172457339;6196.969015154896;6555.246146693191;6627.966860165669;6713.1944166700305;6277.18396608438;6300.873684001021;6667.83330416724;6697.966510167418;6734.6632668367365 03:48:13 INFO - PID 1666 | |4;prototype.html;383.1589660694775;398.6392314954965;401.752921952999;401.9417184508246;412.4885142423395;5597.63615365001;6423.357664233575;6466.708998095085;6555.6394398308075;6621.536492445531;5273.709945952981;5915.349311575723;6203.751849925998;6305.243370795511;6473.41739243468;4219.198352313051;4488.326750987361;4637.397138372024;4730.929036064462;4796.208625576775;4727.64542659302;4733.337332773414;4737.336772851803;4754.096721622881;4768.165571025074;4682.250839865622;4685.2269375553;4697.295405689139;4705.6470764692785;4712.693674911137;4302.2471067563365;4493.730376177407;4700.882477938045;4708.576228139484;4723.7638118093955;3583.4087375583;3737.8691745789038;4064.593540645941;4069.6947728920154;4083.8570650027405;5691.260136182311;6258.810825943056;6340.175777148987;6409.750098730749;6444.871102577922;5614.578906582023;5638.379778224433;5653.180288858133;5666.781641947001;5684.8294551163535;6471.802716497463;6935.826604334881;6961.408280296181;6988.650567471606;7005.404540614054;4363.759993200372;4396.230374863847;4639.327297541838;4643.956659069999;4648.953510464886;6975.581465112059;7217.98948147265;7321.59731214783;7424.438568693792;7430.331270185709;3598.8020658864016;4470;4638.95361046392;4647.604953578916;4687.671862969628;4743.264793956942;4768.451628062748;4774.259989701602;4782.306565547976;4787.630123089024;4724.71651700899;4746.406699162605;4750.904981900343;5343.198520221998;5542.196381524656;6856.177258728984;6886.24251332353;6890.276520965327;6917.9308206917285;6921.723131074801;1386.8766299297602;1610.6551029889938;1623.245190986197;1624.5126462061335;1640.2946732904727;891.5156264819133;1022.9744256393501;1063.8191507443753;1078.2560033576806;1084.4631907205983;6443.323451037667;6448.645324507197;6456.385903524119;6466.572716460284;6496.805095847132;5744.741486633112;7128.536645118051;7155.284471552907;7165.6775445105095;7184.066071410683;6414.743410263537;6415.230172379344;6426.260979987362;6434.453071488882;6444.871102577922;3231.8060916345094;3236.8185612251827;3703.777773333609;3716.6840818530727;3762.5326122812126;7116.537425067354;7298.562086274735;7342.229065948105;7346.485745997836;7356.264373562708;6396.648184349905;6934;7385.483016188923;7405.703771849174;7418.666160022812;6312.495000399957;7289.817754556178;7317.97548343243;7318.963405183046;7362.926370736224;5863.560232982629;6335.778247761306;6629.966850165718;6949.027136201037;7284.125904891235;5920.763169473173;6661.2006559213205;6677.432418244503;6956.9564565313585;7048.788536343918;6401.263854656774;6668.699908504226;6737.326267373223;7018.298170182941;7046.260142684944;3821.178446633987;3875.488559461756;4689.226277664147;4690.061987602425;4780.091782561302;6121.816345509642;6436.712657468432;7070.787876363717;7174.892376614459;7280.1991780903;5573.832785016456;6108.869859076085;6357.110004599453;6976.02335672996;6991.475639326969;5798.970360373835;6918.584884906922;6931.237563868071;6939.4448444125355;6962.164540255202;5724.513416359489;6279.340669229665;6790.524663273523;6795.640871825556;6873.075538849131;5544.805931792368;6827.93172068273;6867.896981545181;6985.301469852974;7051;5783.595148339576;6040.305364883095;6667.833304167435;6706.558090010672;6768.08630834831 03:48:13 INFO - PID 1666 | |5;yui.html;742.4320394897904;823.1727114250177;840.5503055865113;867.3148212911798;868.7958329792501;14272.857271427283;14912.552623421288;16449.588760280985;17026;17040.318387264524;15996.040237585725;17896.37362692306;17980.460586182402;18010;18024.81975180248;1006.5923301063044;1023.4575674892319;1027.203916964355;1056.1867362131154;1058.8941105889426;1015.9238057145707;1044.660485342263;1047.5495536919123;1047.6176195688556;1052.6999805055561;975.9560819763092;1053.852460655505;1090.1115590793518;1093.081811278526;1095.8356246563;1083.9295445796;1085.1102096281013;1085.2620218251586;1085.6417382263835;1085.6525911708256;794.3526026288556;795.5226863881625;796.872500399939;797.4935915693518;797.9108516874483;17175.828241717674;17568.121593920252;17606.471805845846;17647.117644117872;17915.104244787708;17839.73240401395;17991.280348786033;18117.18472668733;18224.635507289913;18288.634227315513;14757.26213689322;14907.552773416815;14942.103473791607;14964.850351496454;15030.098194108388;3524.788512689247;3553.307105114504;3572.4105522588743;3576.2489877125577;3592.3354179476883;148137;150380;151994.24002880027;153002;154619.22690386476;13623.931880340535;13678.384472698752;13714.519991800438;13833.446662133401;13887.861121388858;26617.86691066571;26797;26884.790184441747;26944.326391839968;27397.45205095887;6737.225219099768;6945.444364450832;7643.770686879402;7822.921770782333;7884.053913530413;3382.526446297471;3409.880654177092;3512.9824350878594;3945.270125026879;4033.072393349546;3525.7531972761662;3604.8017359045502;4268.551802060801;4305.418768466279;4339.500957389878;933.3373304953559;974.0405700385115;974.4007435427161;986.4328011393477;987.8024395121005;641.8555824939351;651.713246171683;656.4780999105723;671.4326394196896;682.2120450879243;10933.448788959933;11605.419729013516;11795;11900.76198476043;11935.880641193651;627.8587317853446;642.1299139665779;649.9155109835691;667.8163505036154;681.8125015620744;5508.283923090053;5523.25436066134;5660.858478537987;5827.883442331215;5915.319738230072;119438;120208;135464;138026.61973380137;138713;117510;118996.40501797608;119099;119982.400087999;120223.39888300502;95688.52155739177;101002.15425678129;104278;104441;106940.46529767146;11707.648770536898;12213.328266945404;12436.626901192978;12636.178648387826;12753.48986040548;36623.45064823976;41745.58254417417;41983.95040123899;43107.56892431161;44595.777021114685;79136.4172716554;79327.81008284765;81895;82032.76950845623;82284.35431291221;17445.738313925554;17687.292508299524;17724.822751772317;17870;17870.731939020665;16278.837211628206;16832.07423591714;18326.72509912379;19031.42905712831;19118.61762764709;17156.39952601653;17598.648027039133;17770.91114544419;17997.100144992437;18178.091095445438;17650.823491764917;17900.01549914715;17920.641587168444;17933.282668693108;18060.277588896297;16978.66042679164;17061.82938170652;17271;17398.9130054354;17535.912320438318;11480.024197942934;11592.710182245512;11810.940945295219;12180.695482613006;12339.197952133083;12439.440225190068;12996.935015324863;13478.46086156582;13614.863851361359;13765.587032389045 03:48:13 INFO - PID 1666 | __end_tp_report 03:48:13 INFO - PID 1666 | __start_cc_report 03:48:13 INFO - PID 1666 | _x_x_mozilla_cycle_collect,449 03:48:13 INFO - PID 1666 | __end_cc_report 03:48:13 INFO - PID 1666 | __startTimestamp1496659693233__endTimestamp 03:48:13 INFO - PID 1666 | 03:48:13 INFO - PID 1666 | ------- Summary: start ------- 03:48:13 INFO - PID 1666 | Number of tests: 6 03:48:13 INFO - PID 1666 | 03:48:13 INFO - PID 1666 | [#0] dojo.html Cycles:165 Average:6156.42 Median:6378.65 stddev:742.02 (11.6%) stddev-sans-first:704.70 03:48:13 INFO - PID 1666 | Values: 3107.8 3602.1 3616.4 3623.7 3625.3 4903.5 5804.2 6185.3 6199.7 6319.5 6163.4 6207.5 6234.4 6307.0 6337.3 5289.6 5390.8 5469.1 5482.5 5605.0 5609.4 5610.2 5617.3 5618.4 5624.3 5379.8 5416.1 5449.2 5469.2 5552.4 5489.7 5504.7 5518.8 5519.4 5525.7 5423.5 5441.0 5459.3 5471.1 5505.8 5036.5 6199.6 6316.5 6322.0 6337.4 6513.6 6592.4 6685.9 6698.1 6706.4 6814.1 6818.0 6826.3 6834.5 6843.0 6135.0 6239.1 6361.1 6367.5 6372.7 6760.5 6833.8 6899.2 6925.4 6943.9 5519.0 6332.2 6386.3 6495.7 6586.3 6766.2 6779.9 6787.6 6808.0 6814.6 6424.4 6644.4 6678.3 6685.6 6701.2 5801.7 6386.4 6452.8 6623.8 6625.1 5342.6 5348.6 5371.4 5378.5 5382.2 4797.6 4804.2 4813.8 4819.2 4821.2 6211.2 6238.1 6275.7 6367.9 6396.7 6836.2 6837.3 6851.0 6862.2 6864.3 6224.9 6358.7 6391.5 6403.4 6410.1 5783.7 5785.6 5843.4 5890.9 5943.3 6882.0 6904.9 6940.7 6954.2 6987.5 6766.4 6771.5 6835.5 6849.8 6865.1 6318.1 6881.4 6952.3 6956.5 6975.7 5078.9 5434.9 6544.3 6561.5 6644.4 6823.6 6839.8 6843.7 6847.6 6880.3 6371.9 6397.3 6484.0 6507.4 6545.2 6472.0 6535.8 6559.2 6561.4 6569.6 6339.1 6400.2 6421.6 6429.9 6448.9 6363.3 6423.8 6553.4 6566.5 6578.1 6331.7 6365.4 6378.6 6414.7 6432.7 03:48:13 INFO - PID 1666 | 03:48:13 INFO - PID 1666 | [#1] ext.html Cycles:180 Average:44586.80 Median:176404.50 stddev:73748.23 (41.8%) stddev-sans-first:73881.69 03:48:13 INFO - PID 1666 | Values: 758.5 777.0 846.6 1263.0 1266.2 39652.6 40391.8 40409.8 40430.4 40670.0 40354.8 40409.8 40719.2 40824.0 40920.8 7842.5 8202.5 8413.1 8427.6 8434.5 8314.1 8411.8 8412.2 8421.0 8433.7 8388.2 8389.2 8397.1 8427.7 8440.1 8299.4 8368.0 8411.3 8415.9 8420.2 7144.5 8092.2 8165.8 8238.6 8238.8 37684.8 38027.8 38028.6 38035.0 38091.4 3580.4 3603.6 3628.6 3631.8 3637.8 30663.2 30753.4 30767.7 30813.0 30824.5 3070.3 3113.4 3119.7 3126.3 3133.3 225593.0 228764.0 281299.0 305402.0 307760.0 48568.0 48682.0 48905.3 49032.0 49096.5 51231.2 51343.0 51397.0 55352.7 55407.0 14328.6 14447.3 14552.6 14570.5 14645.0 11633.0 11707.3 11715.0 11717.1 11737.8 13752.7 13826.4 13877.9 13916.4 14020.7 5250.1 5954.7 6030.4 6086.1 6091.8 1010.0 1016.4 1029.6 1057.6 1057.7 22995.7 23052.4 23416.4 23832.4 24234.8 1090.4 1092.3 1138.1 1141.5 1148.8 10663.5 12007.9 12582.4 12715.9 12793.7 305173.0 306325.0 310528.0 311185.0 320543.0 58520.0 58699.7 59207.0 59362.7 59443.7 1472.3 1503.9 1513.3 1518.3 1520.0 24122.9 28147.4 29951.0 30459.4 30503.7 54505.5 54852.0 54936.7 54980.5 55065.7 258057.0 259532.0 259600.0 260597.0 260842.0 37015.1 37242.6 37252.1 37388.3 37401.4 44574.0 45530.5 46870.8 46928.0 47547.8 30051.4 30053.2 30538.0 31254.1 31381.7 22625.8 28867.9 31077.7 31375.7 31723.5 37515.8 37880.4 38287.6 38565.0 38723.2 28776.7 29963.9 31442.0 32049.7 32266.0 22447.9 23489.0 24449.8 24679.3 24769.4 03:48:13 INFO - PID 1666 | 03:48:13 INFO - PID 1666 | [#2] jquery.html Cycles:180 Average:36636.97 Median:12334.55 stddev:86990.83 (705.3%) stddev-sans-first:87192.25 03:48:13 INFO - PID 1666 | Values: 375.2 418.8 434.7 454.5 462.2 21493.8 22394.1 22422.9 23196.8 24222.6 23536.8 23822.9 24177.3 24188.9 24245.9 5809.0 6245.0 6343.6 6411.9 6428.6 5478.4 5964.8 6249.0 6347.8 6351.6 5035.3 6132.0 6133.4 6140.4 6151.8 6109.3 6127.2 6136.5 6140.4 6147.3 5452.5 5482.0 5483.8 5485.2 5493.2 27226.7 27474.3 27541.0 27602.4 27708.3 2195.6 2246.2 2263.1 2263.5 2265.6 18269.4 18743.7 18779.7 18791.3 18801.5 2147.2 2176.9 2206.8 2217.6 2221.8 180244.1 184105.1 191460.0 200839.0 203543.0 12709.9 12810.2 12984.2 13116.9 13136.8 16420.3 16641.3 16719.5 16748.0 16758.2 8079.6 8547.0 9166.8 9171.4 9216.1 8765.3 8790.6 8866.7 8869.8 8955.8 8108.1 8201.9 8227.3 8236.4 8255.3 2063.0 2235.8 2236.2 2239.0 2264.9 833.3 964.6 972.3 985.0 1037.2 18291.8 19700.8 20173.5 20472.4 21188.7 971.1 1006.4 1010.8 1047.9 1049.4 8899.7 10517.7 10610.8 10651.1 10903.2 487854.0 494871.0 494891.0 496469.0 500971.0 137640.0 138990.3 140429.2 140449.0 141284.0 1043.7 1104.8 1193.2 1248.6 1276.9 22701.8 23746.8 23827.0 24078.0 24131.8 63579.0 64484.7 66001.0 66362.7 66364.7 88376.0 88804.0 89287.0 89427.6 89498.6 8775.9 10158.1 10168.9 10232.6 10326.4 17389.7 17644.3 17982.4 18271.4 18281.5 12224.1 14641.9 14722.3 14728.2 14838.5 13046.8 13242.7 13270.1 13304.0 13312.4 14685.9 14969.3 15029.8 15097.2 15229.1 10050.8 10214.8 10321.2 10349.7 10370.0 14398.7 14596.7 14597.1 14746.3 14757.6 03:48:13 INFO - PID 1666 | 03:48:13 INFO - PID 1666 | [#3] mootools.html Cycles:180 Average:7167.17 Median:4119.44 stddev:4464.17 (108.4%) stddev-sans-first:4455.65 03:48:13 INFO - PID 1666 | Values: 1399.4 1459.7 1481.9 1485.9 1505.7 9496.7 10024.5 11538.8 12030.0 12033.2 9719.5 10150.4 11796.6 11812.9 11826.9 2082.8 2385.5 2492.0 2543.8 2553.4 2515.0 2517.4 2534.1 2539.3 2546.6 2513.7 2523.4 2524.4 2529.9 2531.7 2380.0 2400.8 2403.3 2405.9 2409.6 2445.9 2464.1 2465.2 2466.9 2467.9 11522.4 11744.8 11809.1 11812.9 11821.6 6390.5 6568.9 6623.1 6623.8 6630.9 3986.8 4225.4 4291.2 4293.1 4296.9 1250.5 1257.2 1263.9 1284.0 1296.9 12852.2 13754.9 15665.9 16196.8 16311.0 5827.6 5828.4 5839.2 5883.5 5945.6 13580.5 13742.9 13745.0 13745.2 13758.6 6611.6 6638.1 6639.3 6640.0 6685.3 4668.9 5606.2 6055.0 6176.2 6240.3 4466.5 4600.4 4602.3 4619.0 4645.2 1416.1 1440.5 1444.6 1458.5 1480.8 831.3 834.5 848.6 852.2 868.8 5563.9 7207.3 7378.8 7467.0 7562.7 602.3 603.4 603.7 608.7 613.3 4068.2 4082.3 4156.5 4225.1 4250.3 14354.3 14912.9 15025.4 15072.1 15100.6 13923.6 14018.5 14705.7 14741.6 14946.8 8414.2 8691.3 8708.0 8756.9 8760.6 7310.1 7345.8 7496.5 7660.7 7674.5 13525.5 13676.7 13997.4 14008.7 14061.2 10896.8 13885.7 13943.9 14218.7 14226.5 8794.3 9123.0 9159.0 9525.9 9728.3 11027.4 11065.7 11209.7 11224.2 11300.8 9032.7 9208.4 9210.8 9358.7 9381.1 8898.3 9013.2 9061.5 9083.5 9142.6 8149.3 8183.4 8214.3 8279.8 8290.6 6151.7 6197.0 6555.2 6628.0 6713.2 6277.2 6300.9 6667.8 6698.0 6734.7 03:48:13 INFO - PID 1666 | 03:48:13 INFO - PID 1666 | [#4] prototype.html Cycles:180 Average:5506.64 Median:6269.08 stddev:1756.28 (28.0%) stddev-sans-first:1718.59 03:48:13 INFO - PID 1666 | Values: 383.2 398.6 401.8 401.9 412.5 5597.6 6423.4 6466.7 6555.6 6621.5 5273.7 5915.3 6203.8 6305.2 6473.4 4219.2 4488.3 4637.4 4730.9 4796.2 4727.6 4733.3 4737.3 4754.1 4768.2 4682.3 4685.2 4697.3 4705.6 4712.7 4302.2 4493.7 4700.9 4708.6 4723.8 3583.4 3737.9 4064.6 4069.7 4083.9 5691.3 6258.8 6340.2 6409.8 6444.9 5614.6 5638.4 5653.2 5666.8 5684.8 6471.8 6935.8 6961.4 6988.7 7005.4 4363.8 4396.2 4639.3 4644.0 4649.0 6975.6 7218.0 7321.6 7424.4 7430.3 3598.8 4470.0 4639.0 4647.6 4687.7 4743.3 4768.5 4774.3 4782.3 4787.6 4724.7 4746.4 4750.9 5343.2 5542.2 6856.2 6886.2 6890.3 6917.9 6921.7 1386.9 1610.7 1623.2 1624.5 1640.3 891.5 1023.0 1063.8 1078.3 1084.5 6443.3 6448.6 6456.4 6466.6 6496.8 5744.7 7128.5 7155.3 7165.7 7184.1 6414.7 6415.2 6426.3 6434.5 6444.9 3231.8 3236.8 3703.8 3716.7 3762.5 7116.5 7298.6 7342.2 7346.5 7356.3 6396.6 6934.0 7385.5 7405.7 7418.7 6312.5 7289.8 7318.0 7319.0 7362.9 5863.6 6335.8 6630.0 6949.0 7284.1 5920.8 6661.2 6677.4 6957.0 7048.8 6401.3 6668.7 6737.3 7018.3 7046.3 3821.2 3875.5 4689.2 4690.1 4780.1 6121.8 6436.7 7070.8 7174.9 7280.2 5573.8 6108.9 6357.1 6976.0 6991.5 5799.0 6918.6 6931.2 6939.4 6962.2 5724.5 6279.3 6790.5 6795.6 6873.1 5544.8 6827.9 6867.9 6985.3 7051.0 5783.6 6040.3 6667.8 6706.6 6768.1 03:48:13 INFO - PID 1666 | 03:48:13 INFO - PID 1666 | [#5] yui.html Cycles:180 Average:25585.23 Median:17747.87 stddev:38894.92 (219.2%) stddev-sans-first:38959.30 03:48:13 INFO - PID 1666 | Values: 742.4 823.2 840.6 867.3 868.8 14272.9 14912.6 16449.6 17026.0 17040.3 15996.0 17896.4 17980.5 18010.0 18024.8 1006.6 1023.5 1027.2 1056.2 1058.9 1015.9 1044.7 1047.5 1047.6 1052.7 976.0 1053.9 1090.1 1093.1 1095.8 1083.9 1085.1 1085.3 1085.6 1085.7 794.4 795.5 796.9 797.5 797.9 17175.8 17568.1 17606.5 17647.1 17915.1 17839.7 17991.3 18117.2 18224.6 18288.6 14757.3 14907.6 14942.1 14964.9 15030.1 3524.8 3553.3 3572.4 3576.2 3592.3 148137.0 150380.0 151994.2 153002.0 154619.2 13623.9 13678.4 13714.5 13833.4 13887.9 26617.9 26797.0 26884.8 26944.3 27397.5 6737.2 6945.4 7643.8 7822.9 7884.1 3382.5 3409.9 3513.0 3945.3 4033.1 3525.8 3604.8 4268.6 4305.4 4339.5 933.3 974.0 974.4 986.4 987.8 641.9 651.7 656.5 671.4 682.2 10933.4 11605.4 11795.0 11900.8 11935.9 627.9 642.1 649.9 667.8 681.8 5508.3 5523.3 5660.9 5827.9 5915.3 119438.0 120208.0 135464.0 138026.6 138713.0 117510.0 118996.4 119099.0 119982.4 120223.4 95688.5 101002.2 104278.0 104441.0 106940.5 11707.6 12213.3 12436.6 12636.2 12753.5 36623.5 41745.6 41984.0 43107.6 44595.8 79136.4 79327.8 81895.0 82032.8 82284.4 17445.7 17687.3 17724.8 17870.0 17870.7 16278.8 16832.1 18326.7 19031.4 19118.6 17156.4 17598.6 17770.9 17997.1 18178.1 17650.8 17900.0 17920.6 17933.3 18060.3 16978.7 17061.8 17271.0 17398.9 17535.9 11480.0 11592.7 11810.9 12180.7 12339.2 12439.4 12996.9 13478.5 13614.9 13765.6 03:48:13 INFO - PID 1666 | -------- Summary: end -------- 03:48:13 INFO - PID 1666 | 03:48:13 INFO - TEST-INFO | 1666: exit 0 03:48:13 INFO - TEST-OK | dromaeo_css | took 1142631ms 03:48:13 INFO - TEST-START | kraken 03:48:13 INFO - operating with platform_type : mac_ 03:48:13 INFO - Initialising browser for kraken test... 03:48:13 INFO - Application command: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox http://localhost:49230/getInfo.html -foreground -profile /var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/tmpen4z_p/profile 03:48:13 INFO - TEST-INFO | started process 1699 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox http://localhost:49230/getInfo.html -foreground) 03:48:47 INFO - TEST-INFO | 1699: killed by SIGTERM 03:48:47 INFO - Browser initialized. 03:48:47 INFO - Running cycle 1/1 for kraken test... 03:48:47 INFO - TEST-INFO | started process 1703 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/tmpen4z_p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:48:50 INFO - PID 1703 | 2017-06-05 03:48:50.041 plugin-container[1704:10943] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x993b, name = 'com.apple.tsm.portname' 03:48:50 INFO - PID 1703 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:48:50 INFO - PID 1703 | 2017-06-05 03:48:50.042 plugin-container[1704:10943] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9b0b, name = 'com.apple.CFPasteboardClient' 03:48:50 INFO - PID 1703 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:48:50 INFO - PID 1703 | 2017-06-05 03:48:50.042 plugin-container[1704:10943] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:48:50 INFO - PID 1703 | 2017-06-05 03:48:50.486 plugin-container[1705:10989] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 03:48:50 INFO - PID 1703 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:48:50 INFO - PID 1703 | 2017-06-05 03:48:50.486 plugin-container[1705:10989] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9e0b, name = 'com.apple.CFPasteboardClient' 03:48:50 INFO - PID 1703 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:48:50 INFO - PID 1703 | 2017-06-05 03:48:50.486 plugin-container[1705:10989] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:48:59 INFO - PID 1703 | RSS: Main: 267948032 03:48:59 INFO - PID 1703 | 03:49:02 INFO - PID 1703 | Cycle 1(1): loaded http://localhost:49230/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49230/tests/kraken/driver.html?testName=audio-beat-detection) 03:49:03 INFO - PID 1703 | RSS: Main: 275734528 03:49:03 INFO - PID 1703 | 03:49:06 INFO - PID 1703 | Cycle 1(1): loaded http://localhost:49230/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49230/tests/kraken/driver.html?testName=audio-dft) 03:49:06 INFO - PID 1703 | RSS: Main: 284315648 03:49:06 INFO - PID 1703 | 03:49:10 INFO - PID 1703 | Cycle 1(1): loaded http://localhost:49230/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49230/tests/kraken/driver.html?testName=audio-fft) 03:49:11 INFO - PID 1703 | RSS: Main: 282603520 03:49:11 INFO - PID 1703 | 03:49:13 INFO - PID 1703 | Cycle 1(1): loaded http://localhost:49230/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49230/tests/kraken/driver.html?testName=audio-oscillator) 03:49:13 INFO - PID 1703 | RSS: Main: 283447296 03:49:13 INFO - PID 1703 | 03:49:15 INFO - PID 1703 | Cycle 1(1): loaded http://localhost:49230/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49230/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:49:16 INFO - PID 1703 | RSS: Main: 285265920 03:49:16 INFO - PID 1703 | 03:49:19 INFO - PID 1703 | Cycle 1(1): loaded http://localhost:49230/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49230/tests/kraken/driver.html?testName=imaging-darkroom) 03:49:19 INFO - PID 1703 | RSS: Main: 294924288 03:49:19 INFO - PID 1703 | 03:49:22 INFO - PID 1703 | Cycle 1(1): loaded http://localhost:49230/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49230/tests/kraken/driver.html?testName=imaging-desaturate) 03:49:23 INFO - PID 1703 | RSS: Main: 293777408 03:49:23 INFO - PID 1703 | 03:49:26 INFO - PID 1703 | Cycle 1(1): loaded http://localhost:49230/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49230/tests/kraken/driver.html?testName=json-parse-financial) 03:49:27 INFO - PID 1703 | RSS: Main: 292286464 03:49:27 INFO - PID 1703 | 03:49:28 INFO - PID 1703 | Cycle 1(1): loaded http://localhost:49230/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49230/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:49:29 INFO - PID 1703 | RSS: Main: 292032512 03:49:29 INFO - PID 1703 | 03:49:31 INFO - PID 1703 | Cycle 1(1): loaded http://localhost:49230/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49230/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:49:31 INFO - PID 1703 | RSS: Main: 291377152 03:49:31 INFO - PID 1703 | 03:49:34 INFO - PID 1703 | Cycle 1(1): loaded http://localhost:49230/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49230/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:49:34 INFO - PID 1703 | RSS: Main: 291397632 03:49:34 INFO - PID 1703 | 03:49:37 INFO - PID 1703 | Cycle 1(1): loaded http://localhost:49230/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49230/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:49:38 INFO - PID 1703 | RSS: Main: 291090432 03:49:38 INFO - PID 1703 | 03:49:41 INFO - PID 1703 | Cycle 1(1): loaded http://localhost:49230/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49230/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:49:42 INFO - PID 1703 | RSS: Main: 291012608 03:49:42 INFO - PID 1703 | 03:49:43 INFO - PID 1703 | Cycle 1(1): loaded http://localhost:49230/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49230/tests/kraken/driver.html?testName=ai-astar) 03:49:44 INFO - PID 1703 | RSS: Main: 292909056 03:49:44 INFO - PID 1703 | 03:49:44 INFO - PID 1703 | __start_tp_report 03:49:44 INFO - PID 1703 | _x_x_mozilla_page_load 03:49:44 INFO - PID 1703 | _x_x_mozilla_page_load_details 03:49:44 INFO - PID 1703 | |i|pagename|runs| 03:49:44 INFO - PID 1703 | |0;ai-astar;102;115;115;114;115;124;168;169;113;113 03:49:44 INFO - PID 1703 | |1;audio-beat-detection;130;110;109;151;112;124;109;115;147;140 03:49:44 INFO - PID 1703 | |2;audio-dft;197;203;197;234;217;225;247;270;278;197 03:49:44 INFO - PID 1703 | |3;audio-fft;70;58;84;109;60;80;57;62;93;83 03:49:44 INFO - PID 1703 | |4;audio-oscillator;81;70;84;67;70;71;89;71;69;89 03:49:44 INFO - PID 1703 | |5;imaging-gaussian-blur;112;88;82;135;137;89;89;89;90;89 03:49:44 INFO - PID 1703 | |6;imaging-darkroom;98;96;95;95;97;95;95;97;98;96 03:49:44 INFO - PID 1703 | |7;imaging-desaturate;111;147;104;142;149;93;93;95;93;123 03:49:44 INFO - PID 1703 | |8;json-parse-financial;49;49;52;51;49;51;51;53;51;50 03:49:44 INFO - PID 1703 | |9;json-stringify-tinderbox;57;57;68;58;65;63;56;55;58;58 03:49:44 INFO - PID 1703 | |10;stanford-crypto-aes;87;87;86;86;95;114;110;115;101;90 03:49:44 INFO - PID 1703 | |11;stanford-crypto-ccm;137;135;135;134;140;151;153;132;152;151 03:49:44 INFO - PID 1703 | |12;stanford-crypto-pbkdf2;220;211;233;238;186;184;182;188;183;229 03:49:44 INFO - PID 1703 | |13;stanford-crypto-sha256-iterative;66;69;63;66;68;64;65;66;67;69 03:49:44 INFO - PID 1703 | __end_tp_report 03:49:44 INFO - PID 1703 | __start_cc_report 03:49:44 INFO - PID 1703 | _x_x_mozilla_cycle_collect,1181 03:49:44 INFO - PID 1703 | __end_cc_report 03:49:44 INFO - PID 1703 | __startTimestamp1496659784148__endTimestamp 03:49:44 INFO - PID 1703 | 03:49:44 INFO - PID 1703 | ------- Summary: start ------- 03:49:44 INFO - PID 1703 | Number of tests: 14 03:49:44 INFO - PID 1703 | 03:49:44 INFO - PID 1703 | [#0] ai-astar Cycles:10 Average:124.80 Median:115.00 stddev:23.63 (20.5%) stddev-sans-first:23.57 03:49:44 INFO - PID 1703 | Values: 102.0 115.0 115.0 114.0 115.0 124.0 168.0 169.0 113.0 113.0 03:49:44 INFO - PID 1703 | 03:49:44 INFO - PID 1703 | [#1] audio-beat-detection Cycles:10 Average:124.70 Median:127.00 stddev:16.38 (12.9%) stddev-sans-first:17.27 03:49:44 INFO - PID 1703 | Values: 130.0 110.0 109.0 151.0 112.0 124.0 109.0 115.0 147.0 140.0 03:49:44 INFO - PID 1703 | 03:49:44 INFO - PID 1703 | [#2] audio-dft Cycles:10 Average:226.50 Median:229.50 stddev:30.33 (13.2%) stddev-sans-first:30.23 03:49:44 INFO - PID 1703 | Values: 197.0 203.0 197.0 234.0 217.0 225.0 247.0 270.0 278.0 197.0 03:49:44 INFO - PID 1703 | 03:49:44 INFO - PID 1703 | [#3] audio-fft Cycles:10 Average:75.60 Median:75.00 stddev:17.25 (23.0%) stddev-sans-first:18.18 03:49:44 INFO - PID 1703 | Values: 70.0 58.0 84.0 109.0 60.0 80.0 57.0 62.0 93.0 83.0 03:49:44 INFO - PID 1703 | 03:49:44 INFO - PID 1703 | [#4] audio-oscillator Cycles:10 Average:76.10 Median:76.00 stddev:8.69 (11.4%) stddev-sans-first:9.03 03:49:44 INFO - PID 1703 | Values: 81.0 70.0 84.0 67.0 70.0 71.0 89.0 71.0 69.0 89.0 03:49:44 INFO - PID 1703 | 03:49:44 INFO - PID 1703 | [#5] imaging-gaussian-blur Cycles:10 Average:100.00 Median:89.00 stddev:20.52 (23.1%) stddev-sans-first:21.30 03:49:44 INFO - PID 1703 | Values: 112.0 88.0 82.0 135.0 137.0 89.0 89.0 89.0 90.0 89.0 03:49:44 INFO - PID 1703 | 03:49:44 INFO - PID 1703 | [#6] imaging-darkroom Cycles:10 Average:96.20 Median:96.50 stddev:1.23 (1.3%) stddev-sans-first:1.12 03:49:44 INFO - PID 1703 | Values: 98.0 96.0 95.0 95.0 97.0 95.0 95.0 97.0 98.0 96.0 03:49:44 INFO - PID 1703 | 03:49:44 INFO - PID 1703 | [#7] imaging-desaturate Cycles:10 Average:115.00 Median:121.00 stddev:23.48 (19.4%) stddev-sans-first:24.86 03:49:44 INFO - PID 1703 | Values: 111.0 147.0 104.0 142.0 149.0 93.0 93.0 95.0 93.0 123.0 03:49:44 INFO - PID 1703 | 03:49:44 INFO - PID 1703 | [#8] json-parse-financial Cycles:10 Average:50.60 Median:51.00 stddev:1.35 (2.6%) stddev-sans-first:1.30 03:49:44 INFO - PID 1703 | Values: 49.0 49.0 52.0 51.0 49.0 51.0 51.0 53.0 51.0 50.0 03:49:44 INFO - PID 1703 | 03:49:44 INFO - PID 1703 | [#9] json-stringify-tinderbox Cycles:10 Average:59.50 Median:58.00 stddev:4.30 (7.4%) stddev-sans-first:4.47 03:49:44 INFO - PID 1703 | Values: 57.0 57.0 68.0 58.0 65.0 63.0 56.0 55.0 58.0 58.0 03:49:44 INFO - PID 1703 | 03:49:44 INFO - PID 1703 | [#10] stanford-crypto-aes Cycles:10 Average:97.10 Median:86.50 stddev:11.99 (13.9%) stddev-sans-first:12.14 03:49:44 INFO - PID 1703 | Values: 87.0 87.0 86.0 86.0 95.0 114.0 110.0 115.0 101.0 90.0 03:49:44 INFO - PID 1703 | 03:49:44 INFO - PID 1703 | [#11] stanford-crypto-ccm Cycles:10 Average:142.00 Median:145.50 stddev:8.65 (5.9%) stddev-sans-first:8.99 03:49:44 INFO - PID 1703 | Values: 137.0 135.0 135.0 134.0 140.0 151.0 153.0 132.0 152.0 151.0 03:49:44 INFO - PID 1703 | 03:49:44 INFO - PID 1703 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:205.40 Median:215.50 stddev:23.12 (10.7%) stddev-sans-first:23.92 03:49:44 INFO - PID 1703 | Values: 220.0 211.0 233.0 238.0 186.0 184.0 182.0 188.0 183.0 229.0 03:49:44 INFO - PID 1703 | 03:49:44 INFO - PID 1703 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.50 stddev:2.00 (3.0%) stddev-sans-first:2.12 03:49:44 INFO - PID 1703 | Values: 66.0 69.0 63.0 66.0 68.0 64.0 65.0 66.0 67.0 69.0 03:49:44 INFO - PID 1703 | -------- Summary: end -------- 03:49:44 INFO - PID 1703 | 03:49:44 INFO - TEST-INFO | 1703: exit 0 03:49:45 INFO - TEST-OK | kraken | took 91188ms 03:49:45 INFO - SUITE-END | took 1233s 03:49:45 INFO - Completed test suite (00:20:34) 03:49:45 INFO - javascript benchmark 03:49:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8126.347572615231, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3107.8135311881283, 3602.135487483003, 3616.4213725803875, 3623.6738693517586, 3625.3111908737337, 4903.4606193318705, 5804.245448091742, 6185.257769067713, 6199.659018753967, 6319.462845658119, 6163.352847950968, 6207.4723648489935, 6234.438900498954, 6307.0, 6337.271213810413, 5289.629725919187, 5390.838274851761, 5469.07025805612, 5482.451754824526, 5604.971975140119, 5609.411011843759, 5610.24261724668, 5617.297837770278, 5618.353889302721, 5624.3250809902665, 5379.811706590251, 5416.1063424534905, 5449.209864569655, 5469.234307196995, 5552.444755524435, 5489.725513724337, 5504.669719816824, 5518.806841760559, 5519.365272993617, 5525.696086715229, 5423.457654234585, 5440.972795136038, 5459.317585301837, 5471.06991811393, 5505.779768809283, 5036.546710796046, 6199.566030377875, 6316.463100636452, 6321.96839015802, 6337.397947195009, 6513.609183448961, 6592.439642630382, 6685.866282674319, 6698.062271282024, 6706.429953453913, 6814.1482314710665, 6818.045473633695, 6826.317368263183, 6834.4874134440115, 6843.0419741236265, 6135.0, 6239.06414037898, 6361.141245931833, 6367.458766004849, 6372.681365931685, 6760.492963027793, 6833.760818371433, 6899.241083480813, 6925.445964322842, 6943.89584156238, 5518.972405137949, 6332.240131184288, 6386.265579458422, 6495.7076931538195, 6586.341365863375, 6766.15423072116, 6779.864402711918, 6787.626680532618, 6807.965960170168, 6814.591124532544, 6424.357564243632, 6644.368784965421, 6678.298778628271, 6685.6322902240845, 6701.1623547056615, 5801.7389217485315, 6386.36136386367, 6452.838679032968, 6623.768168114093, 6625.105610742585, 5342.5993050521365, 5348.57211423093, 5371.3822910365025, 5378.542823860016, 5382.2464854920345, 4797.56821886032, 4804.183288840905, 4813.831515896927, 4819.156647586658, 4821.228603423436, 6211.16149319836, 6238.095476155932, 6275.6862156891975, 6367.872642547123, 6396.744130234739, 6836.179658441019, 6837.282085381063, 6850.965745171242, 6862.210845752703, 6864.313568643096, 6224.906626400608, 6358.713857876407, 6391.520635952322, 6403.359664033559, 6410.134631824737, 5783.681897495594, 5785.566082543826, 5843.3864444233595, 5890.9396308664855, 5943.286805583271, 6882.0, 6904.861902761917, 6940.722371105099, 6954.235034146341, 6987.475939304674, 6766.391024807791, 6771.45828333742, 6835.521513494008, 6849.794506164823, 6865.141857267841, 6318.115463835159, 6881.41507971828, 6952.270011648704, 6956.478264130109, 6975.720971161097, 5078.873028174326, 5434.891302173855, 6544.312847150981, 6561.507886908596, 6644.435223006099, 6823.624700641314, 6839.760608378683, 6843.726250949906, 6847.623380714109, 6880.311968803079, 6371.904421433589, 6397.26431460388, 6484.0, 6507.381798729113, 6545.181852268466, 6471.967640161769, 6535.803925882231, 6559.212894452697, 6561.376669216417, 6569.57297775643, 6339.112524246517, 6400.23197216337, 6421.646809425526, 6429.935700642934, 6448.9032664511005, 6363.3000369958345, 6423.807285781434, 6553.442957348679, 6566.507511936719, 6578.079068930258, 6331.715072821827, 6365.427111559982, 6378.649174295459, 6414.743410263537, 6432.678366081771], "value": 6107.630510683425, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [758.503180416827, 776.9728059517914, 846.5555583318757, 1262.9873701262984, 1266.1580049267238, 39652.612158574455, 40391.79804100975, 40409.787706368785, 40430.39354409683, 40670.0, 40354.798226008905, 40409.797951010274, 40719.18561628766, 40823.97940051493, 40920.79539602305, 7842.490238134503, 8202.466839655403, 8413.116622754615, 8427.578621068922, 8434.493930364168, 8314.127016663255, 8411.83176336473, 8412.242898139166, 8420.957895210515, 8433.70482033129, 8388.203120703523, 8389.244967952884, 8397.076321604618, 8427.662893484254, 8440.113788052258, 8299.419040667155, 8368.037675667285, 8411.327093832479, 8415.873761893576, 8420.24217820396, 7144.46416518758, 8092.231238032377, 8165.8366832663605, 8238.629261683238, 8238.794030149294, 37684.811575941945, 38027.80986095052, 38028.619713802786, 38035.04912377185, 38091.4286285706, 3580.427131658922, 3603.6396360364015, 3628.564572251347, 3631.782093074424, 3637.7635453695425, 30663.233419164477, 30753.38493230123, 30767.692323076706, 30813.0, 30824.53763193554, 3070.3398769264713, 3113.4084523940605, 3119.672434394379, 3126.3122113135073, 3133.3263348380206, 225593.0, 228764.0, 281298.99999999796, 305402.0, 307760.0, 48568.0, 48682.02635947261, 48905.26642100371, 49032.0, 49096.50903490919, 51231.23153152705, 51342.97314053698, 51397.0, 55352.72323638356, 55407.0, 14328.570142895729, 14447.277636118151, 14552.563423097325, 14570.4900328488, 14645.0, 11632.953034226792, 11707.2975621463, 11715.004224641001, 11717.06263498918, 11737.823932641017, 13752.65618359549, 13826.446942122202, 13877.861221387859, 13916.443342266197, 14020.71958560823, 5250.081235783722, 5954.732037058343, 6030.427109424598, 6086.117512960596, 6091.8477038073515, 1009.9949500252452, 1016.3596933931576, 1029.624187171692, 1057.6086847866338, 1057.7144171073921, 22995.655065174036, 23052.386332956532, 23416.414589635056, 23832.404189895045, 24234.757652423603, 1090.3839330778085, 1092.257265059751, 1138.0895283772948, 1141.49774099396, 1148.8219326004482, 10663.520141593646, 12007.939960300142, 12582.37088145589, 12715.872841271654, 12793.680157996125, 305173.0, 306325.0, 310528.0, 311185.0, 320543.0, 58519.95180168674, 58699.70650146722, 59207.0, 59362.70318648379, 59443.702781485816, 1472.3300898091343, 1503.8571335723088, 1513.3341329814846, 1518.2788175616495, 1520.0, 24122.87938560296, 28147.43705125927, 29951.0, 30459.39081218319, 30503.694963050086, 54505.45494545004, 54852.0, 54936.725316373166, 54980.450195497535, 55065.72467137639, 258057.0, 259532.0, 259600.0, 260597.0, 260842.0, 37015.07462313356, 37242.62757372392, 37252.06869828276, 37388.252234954605, 37401.43897841589, 44574.0, 45530.54469455396, 46870.76564617155, 46928.0, 47547.76226118847, 30051.39897202, 30053.248668783457, 30538.0, 31254.062378128692, 31381.686183137877, 22625.773742262365, 28867.85566072156, 31077.689223107478, 31375.686243137276, 31723.524147138272, 37515.81242093772, 37880.43179352257, 38287.61712382952, 38565.03587410225, 38723.2255354897, 28776.712232877402, 29963.850180748956, 31442.0, 32049.67950320467, 32266.0, 22447.887760561094, 23489.0, 24449.755502444747, 24679.25962221136, 24769.380765480288], "value": 17915.094217775113, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.23077690734, 418.7968835114971, 434.66096444773086, 454.5477250136115, 462.1980863202343, 21493.785062149374, 22394.104235830568, 22422.88788556059, 23196.768032319673, 24222.63666045011, 23536.764632353672, 23822.880885595547, 24177.274681759576, 24188.879055604742, 24245.878770606167, 5808.983427900122, 6245.0320200369015, 6343.587666801666, 6411.871762564746, 6428.646424446653, 5478.397376288605, 5964.79123230687, 6249.031400132964, 6347.8095657130125, 6351.61890286582, 5035.295058691786, 6132.037747920667, 6133.447989680928, 6140.4341892817265, 6151.815445536641, 6109.327973922887, 6127.20346354971, 6136.539759518032, 6140.416660417253, 6147.323794382614, 5452.509274165344, 5481.972590137064, 5483.7806487740445, 5485.232067510552, 5493.242162507999, 27226.72773272262, 27474.313142171406, 27541.0, 27602.447951041067, 27708.30729231765, 2195.637719776235, 2246.2025980776916, 2263.128695452246, 2263.4567703751145, 2265.648824432216, 18269.360572380036, 18743.718844217346, 18779.718304225447, 18791.34230301933, 18801.529961751065, 2147.1733382647635, 2176.8911554422216, 2206.8344874134505, 2217.5675743230076, 2221.766714494987, 180244.09877950657, 184105.07947460312, 191460.0, 200839.0, 203542.96457035388, 12709.936450317875, 12810.167339123114, 12984.220946743226, 13116.868831311756, 13136.802947955788, 16420.343186272654, 16641.33434662624, 16719.49841504757, 16747.995120292577, 16758.234891243053, 8079.636416361278, 8546.974363076471, 9166.81666366669, 9171.44971301724, 9216.124468175512, 8765.254953328911, 8790.560471976376, 8866.689665861664, 8869.778255543662, 8955.820883582292, 8108.108108108104, 8201.876971845428, 8227.259546640831, 8236.382271329674, 8255.25702686761, 2062.958740825205, 2235.8434909556177, 2236.1726161320416, 2238.9812635250923, 2264.878884951959, 833.295864994079, 964.647903515226, 972.2562239886493, 984.9707056126222, 1037.1547189040907, 18291.81708182928, 19700.817950922992, 20173.49566260826, 20472.385828425173, 21188.682169767464, 971.1065819446127, 1006.3961623026272, 1010.838265877456, 1047.8794938582162, 1049.375621505203, 8899.73300800977, 10517.65424677509, 10610.752602241648, 10651.147908167328, 10903.236773425942, 487854.0, 494871.0, 494891.0, 496469.0, 500971.0, 137640.0, 138990.3050484741, 140429.19141617112, 140449.0, 141284.0, 1043.6712435582767, 1104.7624760676333, 1193.1945936493007, 1248.5754843353304, 1276.8595454500182, 22701.772982270628, 23746.762532374454, 23827.0, 24078.03687852466, 24131.758682413652, 63579.0, 64484.71030579456, 66001.0, 66362.66818665876, 66364.6681766588, 88376.0, 88804.0, 89287.0, 89427.55286223527, 89498.55250723705, 8775.868361974703, 10158.136558392323, 10168.864538446713, 10232.59069637206, 10326.432046237529, 17389.65220695604, 17644.348209551845, 17982.37061702834, 18271.36050238235, 18281.542961426072, 12224.144309898578, 14641.853581464049, 14722.337494812546, 14728.189949552878, 14838.480653177086, 13046.760557746999, 13242.735145297233, 13270.071095023643, 13304.0, 13312.404081204073, 14685.85314146845, 14969.251537422868, 15029.774553381489, 15097.245137743288, 15229.086254824746, 10050.849237261593, 10214.846777298199, 10321.174306055647, 10349.689509314732, 10369.96300369957, 14398.712025759216, 14596.708065838837, 14597.124172549256, 14746.262686865828, 14757.631059223606], "value": 11114.273380988392, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1399.398258748738, 1459.7153555056768, 1481.9036762610428, 1485.910845349279, 1505.728968785619, 9496.715098547038, 10024.498775061254, 11538.769224615502, 12030.03759699224, 12033.21784084034, 9719.514024298793, 10150.441725705083, 11796.587119450822, 11812.877776611229, 11826.881731182686, 2082.7919806512264, 2385.5109702510945, 2491.950160996779, 2543.834650747705, 2553.3744232663025, 2514.9748502515017, 2517.3958250019955, 2534.1257266243115, 2539.2509209783066, 2546.5739186055866, 2513.6857892763405, 2523.4354700085883, 2524.3941454050987, 2529.886155123024, 2531.7088534818454, 2379.9643005354933, 2400.7719266669724, 2403.279016295122, 2405.8556486610682, 2409.6265078912797, 2445.877706114705, 2464.08828733368, 2465.211132437603, 2466.9136580219606, 2467.8766061696842, 11522.366269855154, 11744.823827642593, 11809.114316426303, 11812.881871181264, 11821.645350639494, 6390.456811171056, 6568.93431065688, 6623.105880706139, 6623.768168114093, 6630.933690663128, 3986.820593073319, 4225.408442818008, 4291.163223171483, 4293.055527783882, 4296.935545966813, 1250.5373011985532, 1257.1891130221047, 1263.9052071094704, 1283.9871601284055, 1296.870312968705, 12852.22886626796, 13754.93122534391, 15665.921670391575, 16196.75704864428, 16311.021338719596, 5827.621204621686, 5828.388019258002, 5839.211706419664, 5883.499902508334, 5945.583809133319, 13580.456781728817, 13742.862571374359, 13745.0, 13745.175289482662, 13758.587242382744, 6611.570247933869, 6638.137042184581, 6639.269680335159, 6639.970804525306, 6685.331466853373, 4668.85993420198, 5606.243157173811, 6055.0, 6176.166217560662, 6240.31356550779, 4466.486354069324, 4600.378948841931, 4602.286645569942, 4618.953810461852, 4645.210314246586, 1416.1078520531998, 1440.5102265229873, 1444.6171764482422, 1458.4603696632103, 1480.7630779075296, 831.2518733140222, 834.5076404921004, 848.5502683577714, 852.1904191018557, 868.769776009358, 5563.942850858405, 7207.315305046012, 7378.815529611696, 7466.962665186639, 7562.7353042644345, 602.2562135762417, 603.4207161125281, 603.7494439807518, 608.6774009774826, 613.2702084519408, 4068.2066996935314, 4082.3468245080644, 4156.542780294165, 4225.112726327506, 4250.298700714347, 14354.349249836403, 14912.925435372754, 15025.398984040734, 15072.060948115231, 15100.622484437978, 13923.607639235996, 14018.509352172625, 14705.705885882437, 14741.631459213391, 14946.775798363033, 8414.242718155396, 8691.261242794433, 8708.042115367305, 8756.912430875736, 8760.649574017096, 7310.122785265802, 7345.77962661121, 7496.512726672749, 7660.69357225727, 7674.462787604814, 13525.526606568723, 13676.726465470834, 13997.370118344903, 14008.719825603226, 14061.156330620195, 10896.78206435851, 13885.652858678613, 13943.860561394256, 14218.715625687635, 14226.502072427415, 8794.296456283353, 9123.0, 9158.95420522893, 9525.857112143185, 9728.270379721691, 11027.393493357942, 11065.668029959113, 11209.71975700614, 11224.214304998899, 11300.773984520429, 9032.683856065007, 9208.447493150432, 9210.815783684422, 9358.672446464341, 9381.061893810564, 8898.332625053017, 9013.233875120426, 9061.456312621263, 9083.545822708971, 9142.63429462814, 8149.266566009088, 8183.427160098736, 8214.34285257166, 8279.793005174919, 8290.585470726319, 6151.723172457339, 6196.969015154896, 6555.246146693191, 6627.966860165669, 6713.1944166700305, 6277.18396608438, 6300.873684001021, 6667.83330416724, 6697.966510167418, 6734.6632668367365], "value": 5405.786435734376, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.1589660694775, 398.6392314954965, 401.752921952999, 401.9417184508246, 412.4885142423395, 5597.63615365001, 6423.357664233575, 6466.708998095085, 6555.6394398308075, 6621.536492445531, 5273.709945952981, 5915.349311575723, 6203.751849925998, 6305.243370795511, 6473.41739243468, 4219.198352313051, 4488.326750987361, 4637.397138372024, 4730.929036064462, 4796.208625576775, 4727.64542659302, 4733.337332773414, 4737.336772851803, 4754.096721622881, 4768.165571025074, 4682.250839865622, 4685.2269375553, 4697.295405689139, 4705.6470764692785, 4712.693674911137, 4302.2471067563365, 4493.730376177407, 4700.882477938045, 4708.576228139484, 4723.7638118093955, 3583.4087375583, 3737.8691745789038, 4064.593540645941, 4069.6947728920154, 4083.8570650027405, 5691.260136182311, 6258.810825943056, 6340.175777148987, 6409.750098730749, 6444.871102577922, 5614.578906582023, 5638.379778224433, 5653.180288858133, 5666.781641947001, 5684.8294551163535, 6471.802716497463, 6935.826604334881, 6961.408280296181, 6988.650567471606, 7005.404540614054, 4363.759993200372, 4396.230374863847, 4639.327297541838, 4643.956659069999, 4648.953510464886, 6975.581465112059, 7217.98948147265, 7321.59731214783, 7424.438568693792, 7430.331270185709, 3598.8020658864016, 4470.0, 4638.95361046392, 4647.604953578916, 4687.671862969628, 4743.264793956942, 4768.451628062748, 4774.259989701602, 4782.306565547976, 4787.630123089024, 4724.71651700899, 4746.406699162605, 4750.904981900343, 5343.198520221998, 5542.196381524656, 6856.177258728984, 6886.24251332353, 6890.276520965327, 6917.9308206917285, 6921.723131074801, 1386.8766299297602, 1610.6551029889938, 1623.245190986197, 1624.5126462061335, 1640.2946732904727, 891.5156264819133, 1022.9744256393501, 1063.8191507443753, 1078.2560033576806, 1084.4631907205983, 6443.323451037667, 6448.645324507197, 6456.385903524119, 6466.572716460284, 6496.805095847132, 5744.741486633112, 7128.536645118051, 7155.284471552907, 7165.6775445105095, 7184.066071410683, 6414.743410263537, 6415.230172379344, 6426.260979987362, 6434.453071488882, 6444.871102577922, 3231.8060916345094, 3236.8185612251827, 3703.777773333609, 3716.6840818530727, 3762.5326122812126, 7116.537425067354, 7298.562086274735, 7342.229065948105, 7346.485745997836, 7356.264373562708, 6396.648184349905, 6934.0, 7385.483016188923, 7405.703771849174, 7418.666160022812, 6312.495000399957, 7289.817754556178, 7317.97548343243, 7318.963405183046, 7362.926370736224, 5863.560232982629, 6335.778247761306, 6629.966850165718, 6949.027136201037, 7284.125904891235, 5920.763169473173, 6661.2006559213205, 6677.432418244503, 6956.9564565313585, 7048.788536343918, 6401.263854656774, 6668.699908504226, 6737.326267373223, 7018.298170182941, 7046.260142684944, 3821.178446633987, 3875.488559461756, 4689.226277664147, 4690.061987602425, 4780.091782561302, 6121.816345509642, 6436.712657468432, 7070.787876363717, 7174.892376614459, 7280.1991780903, 5573.832785016456, 6108.869859076085, 6357.110004599453, 6976.02335672996, 6991.475639326969, 5798.970360373835, 6918.584884906922, 6931.237563868071, 6939.4448444125355, 6962.164540255202, 5724.513416359489, 6279.340669229665, 6790.524663273523, 6795.640871825556, 6873.075538849131, 5544.805931792368, 6827.93172068273, 6867.896981545181, 6985.301469852974, 7051.0, 5783.595148339576, 6040.305364883095, 6667.833304167435, 6706.558090010672, 6768.08630834831], "value": 4952.803427134764, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [742.4320394897904, 823.1727114250177, 840.5503055865113, 867.3148212911798, 868.7958329792501, 14272.857271427283, 14912.552623421288, 16449.588760280985, 17026.0, 17040.318387264524, 15996.040237585725, 17896.37362692306, 17980.460586182402, 18010.0, 18024.81975180248, 1006.5923301063044, 1023.4575674892319, 1027.203916964355, 1056.1867362131154, 1058.8941105889426, 1015.9238057145707, 1044.660485342263, 1047.5495536919123, 1047.6176195688556, 1052.6999805055561, 975.9560819763092, 1053.852460655505, 1090.1115590793518, 1093.081811278526, 1095.8356246563, 1083.9295445796, 1085.1102096281013, 1085.2620218251586, 1085.6417382263835, 1085.6525911708256, 794.3526026288556, 795.5226863881625, 796.872500399939, 797.4935915693518, 797.9108516874483, 17175.828241717674, 17568.121593920252, 17606.471805845846, 17647.117644117872, 17915.104244787708, 17839.73240401395, 17991.280348786033, 18117.18472668733, 18224.635507289913, 18288.634227315513, 14757.26213689322, 14907.552773416815, 14942.103473791607, 14964.850351496454, 15030.098194108388, 3524.788512689247, 3553.307105114504, 3572.4105522588743, 3576.2489877125577, 3592.3354179476883, 148137.0, 150380.0, 151994.24002880027, 153002.0, 154619.22690386476, 13623.931880340535, 13678.384472698752, 13714.519991800438, 13833.446662133401, 13887.861121388858, 26617.86691066571, 26797.0, 26884.790184441747, 26944.326391839968, 27397.45205095887, 6737.225219099768, 6945.444364450832, 7643.770686879402, 7822.921770782333, 7884.053913530413, 3382.526446297471, 3409.880654177092, 3512.9824350878594, 3945.270125026879, 4033.072393349546, 3525.7531972761662, 3604.8017359045502, 4268.551802060801, 4305.418768466279, 4339.500957389878, 933.3373304953559, 974.0405700385115, 974.4007435427161, 986.4328011393477, 987.8024395121005, 641.8555824939351, 651.713246171683, 656.4780999105723, 671.4326394196896, 682.2120450879243, 10933.448788959933, 11605.419729013516, 11795.0, 11900.76198476043, 11935.880641193651, 627.8587317853446, 642.1299139665779, 649.9155109835691, 667.8163505036154, 681.8125015620744, 5508.283923090053, 5523.25436066134, 5660.858478537987, 5827.883442331215, 5915.319738230072, 119438.0, 120208.0, 135464.0, 138026.61973380137, 138713.0, 117510.0, 118996.40501797608, 119099.0, 119982.400087999, 120223.39888300502, 95688.52155739177, 101002.15425678129, 104278.0, 104441.0, 106940.46529767146, 11707.648770536898, 12213.328266945404, 12436.626901192978, 12636.178648387826, 12753.48986040548, 36623.45064823976, 41745.58254417417, 41983.95040123899, 43107.56892431161, 44595.777021114685, 79136.4172716554, 79327.81008284765, 81895.0, 82032.76950845623, 82284.35431291221, 17445.738313925554, 17687.292508299524, 17724.822751772317, 17870.0, 17870.731939020665, 16278.837211628206, 16832.07423591714, 18326.72509912379, 19031.42905712831, 19118.61762764709, 17156.39952601653, 17598.648027039133, 17770.91114544419, 17997.100144992437, 18178.091095445438, 17650.823491764917, 17900.01549914715, 17920.641587168444, 17933.282668693108, 18060.277588896297, 16978.66042679164, 17061.82938170652, 17271.0, 17398.9130054354, 17535.912320438318, 11480.024197942934, 11592.710182245512, 11810.940945295219, 12180.695482613006, 12339.197952133083, 12439.440225190068, 12996.935015324863, 13478.46086156582, 13614.863851361359, 13765.587032389045], "value": 8844.200268905131, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1559.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 115.0, 115.0, 114.0, 115.0, 124.0, 168.0, 169.0, 113.0, 113.0], "value": 124.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 110.0, 109.0, 151.0, 112.0, 124.0, 109.0, 115.0, 147.0, 140.0], "value": 124.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 203.0, 197.0, 234.0, 217.0, 225.0, 247.0, 270.0, 278.0, 197.0], "value": 226.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 58.0, 84.0, 109.0, 60.0, 80.0, 57.0, 62.0, 93.0, 83.0], "value": 75.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 70.0, 84.0, 67.0, 70.0, 71.0, 89.0, 71.0, 69.0, 89.0], "value": 76.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 88.0, 82.0, 135.0, 137.0, 89.0, 89.0, 89.0, 90.0, 89.0], "value": 100.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 96.0, 95.0, 95.0, 97.0, 95.0, 95.0, 97.0, 98.0, 96.0], "value": 96.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 147.0, 104.0, 142.0, 149.0, 93.0, 93.0, 95.0, 93.0, 123.0], "value": 115.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 49.0, 52.0, 51.0, 49.0, 51.0, 51.0, 53.0, 51.0, 50.0], "value": 50.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 68.0, 58.0, 65.0, 63.0, 56.0, 55.0, 58.0, 58.0], "value": 59.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 86.0, 86.0, 95.0, 114.0, 110.0, 115.0, 101.0, 90.0], "value": 97.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 135.0, 135.0, 134.0, 140.0, 151.0, 153.0, 132.0, 152.0, 151.0], "value": 142.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [220.0, 211.0, 233.0, 238.0, 186.0, 184.0, 182.0, 188.0, 183.0, 229.0], "value": 205.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 63.0, 66.0, 68.0, 64.0, 65.0, 66.0, 67.0, 69.0], "value": 66.3, "unit": "score"}]}]} 03:49:45 INFO - Return code: 0 03:49:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:49:45 INFO - # TBPL SUCCESS # 03:49:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:49:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:49:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:49:45 INFO - 2017-06-05 03:49:45.566 screenresolution[1711:11384] starting screenresolution argv=screenresolution get 03:49:45 INFO - 2017-06-05 03:49:45.568 screenresolution[1711:11384] Display 0: 1600x1200x32@60 03:49:45 INFO - 2017-06-05 03:49:45.574 screenresolution[1712:11387] starting screenresolution argv=screenresolution list 03:49:45 INFO - Available Modes on Display 0 03:49:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:49:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:49:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:49:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:49:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:49:45 INFO - Intel Iris: 03:49:45 INFO - Chipset Model: Intel Iris 03:49:45 INFO - Type: GPU 03:49:45 INFO - Bus: Built-In 03:49:45 INFO - VRAM (Dynamic, Max): 1536 MB 03:49:45 INFO - Vendor: Intel (0x8086) 03:49:45 INFO - Device ID: 0x0a2e 03:49:45 INFO - Revision ID: 0x0009 03:49:45 INFO - Displays: 03:49:45 INFO - Display: 03:49:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:49:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:49:45 INFO - Display Serial Number: 1600x1200 60 03:49:45 INFO - Main Display: Yes 03:49:45 INFO - Mirror: Off 03:49:45 INFO - Online: Yes 03:49:45 INFO - Rotation: Supported 03:49:45 INFO - Return code: 0 03:49:45 INFO - Running post-action listener: _resource_record_post_action 03:49:45 INFO - [mozharness: 2017-06-05 10:49:45.810022Z] Finished run-tests step (success) 03:49:45 INFO - Running post-run listener: _resource_record_post_run 03:49:45 INFO - Total resource usage - Wall time: 1256s; CPU: 53.0%; Read bytes: 45145088; Write bytes: 570222592; Read time: 472; Write time: 1805 03:49:45 INFO - TinderboxPrint: CPU usage
53.5% 03:49:45 INFO - TinderboxPrint: I/O read bytes / time
45,145,088 / 472 03:49:45 INFO - TinderboxPrint: I/O write bytes / time
570,222,592 / 1,805 03:49:45 INFO - TinderboxPrint: CPU idle
2,338.5 (46.5%) 03:49:45 INFO - TinderboxPrint: CPU system
1,023.2 (20.4%) 03:49:45 INFO - TinderboxPrint: CPU user
1,664.0 (33.1%) 03:49:45 INFO - TinderboxPrint: Swap in / out
287,457,280 / 0 03:49:45 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 230345216; Write bytes: 230303744; Read time: 16859; Write time: 474 03:49:45 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:49:45 INFO - run-tests - Wall time: 1235s; CPU: 53.0%; Read bytes: 44112896; Write bytes: 321478656; Read time: 450; Write time: 1281 03:49:46 INFO - Running post-run listener: _upload_blobber_files 03:49:46 INFO - Blob upload gear active. 03:49:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:49:46 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:49:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:49:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:49:46 INFO - (blobuploader) - INFO - Open directory for files ... 03:49:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:49:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:49:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:47 INFO - (blobuploader) - INFO - Done attempting. 03:49:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:49:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:49:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:48 INFO - (blobuploader) - INFO - Done attempting. 03:49:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:49:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:49 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:49:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:49 INFO - (blobuploader) - INFO - Done attempting. 03:49:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:49:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:49:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:51 INFO - (blobuploader) - INFO - Done attempting. 03:49:51 INFO - (blobuploader) - INFO - Iteration through files over. 03:49:51 INFO - Return code: 0 03:49:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:49:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:49:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a19adac0902e465e3a85e38d33677feba7c0ebc43a28fce53d2dae1899caeb3652b3cee7c43299f4a00fe29792681d29f39f7db10d6c0e8e7a9e5cb1f0f16893", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e87f798f2bf82dd257837f29a05f8de1372da0d56695c78d719e5b1991bb801bfb9ec94a64a1e67f2c5cdb24a3026edad7e51a3107c2f61b507736501b1e64a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4692f3a1afaba5d03ce76238af6d03b3c7ce8fdcb7ddc960d1510e23fe1a27d5e52ebd6d104a950b54a862712b3632a6c8bf7f8ac0e9b91c7e938f62e3bc8a4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07b65389fbabe81f4c989d15e689d98fad0ec549affbe37f75d16a82be868f76760a127f5a95ba1417a96df15c1f705fc284a10eb0e0a60e47b98e50b516b54c"} 03:49:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:49:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:49:51 INFO - Contents: 03:49:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a19adac0902e465e3a85e38d33677feba7c0ebc43a28fce53d2dae1899caeb3652b3cee7c43299f4a00fe29792681d29f39f7db10d6c0e8e7a9e5cb1f0f16893", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e87f798f2bf82dd257837f29a05f8de1372da0d56695c78d719e5b1991bb801bfb9ec94a64a1e67f2c5cdb24a3026edad7e51a3107c2f61b507736501b1e64a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4692f3a1afaba5d03ce76238af6d03b3c7ce8fdcb7ddc960d1510e23fe1a27d5e52ebd6d104a950b54a862712b3632a6c8bf7f8ac0e9b91c7e938f62e3bc8a4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07b65389fbabe81f4c989d15e689d98fad0ec549affbe37f75d16a82be868f76760a127f5a95ba1417a96df15c1f705fc284a10eb0e0a60e47b98e50b516b54c"} 03:49:51 INFO - Running post-run listener: copy_logs_to_upload_dir 03:49:51 INFO - Copying logs to upload dir... 03:49:51 INFO - mkdir: /builds/slave/test/build/upload/logs 03:49:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1339.307905 ========= master_lag: 1.89 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 22 mins, 21 secs) (at 2017-06-05 03:49:53.270710) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-05 03:49:53.273930) ========= 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.FD1Cpq8uDe/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.uvtzJQ11Cj/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a19adac0902e465e3a85e38d33677feba7c0ebc43a28fce53d2dae1899caeb3652b3cee7c43299f4a00fe29792681d29f39f7db10d6c0e8e7a9e5cb1f0f16893", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e87f798f2bf82dd257837f29a05f8de1372da0d56695c78d719e5b1991bb801bfb9ec94a64a1e67f2c5cdb24a3026edad7e51a3107c2f61b507736501b1e64a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4692f3a1afaba5d03ce76238af6d03b3c7ce8fdcb7ddc960d1510e23fe1a27d5e52ebd6d104a950b54a862712b3632a6c8bf7f8ac0e9b91c7e938f62e3bc8a4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07b65389fbabe81f4c989d15e689d98fad0ec549affbe37f75d16a82be868f76760a127f5a95ba1417a96df15c1f705fc284a10eb0e0a60e47b98e50b516b54c"} build_url:https://queue.taskcluster.net/v1/task/RSAMZbYIQaCZN1SHK5W3ew/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011394 build_url: 'https://queue.taskcluster.net/v1/task/RSAMZbYIQaCZN1SHK5W3ew/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a19adac0902e465e3a85e38d33677feba7c0ebc43a28fce53d2dae1899caeb3652b3cee7c43299f4a00fe29792681d29f39f7db10d6c0e8e7a9e5cb1f0f16893", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e87f798f2bf82dd257837f29a05f8de1372da0d56695c78d719e5b1991bb801bfb9ec94a64a1e67f2c5cdb24a3026edad7e51a3107c2f61b507736501b1e64a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4692f3a1afaba5d03ce76238af6d03b3c7ce8fdcb7ddc960d1510e23fe1a27d5e52ebd6d104a950b54a862712b3632a6c8bf7f8ac0e9b91c7e938f62e3bc8a4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07b65389fbabe81f4c989d15e689d98fad0ec549affbe37f75d16a82be868f76760a127f5a95ba1417a96df15c1f705fc284a10eb0e0a60e47b98e50b516b54c"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-05 03:49:53.312520) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 03:49:53.312898) ========= 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.FD1Cpq8uDe/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.uvtzJQ11Cj/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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.005110 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 03:49:53.361782) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-05 03:49:53.362143) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-05 03:49:53.362529) ========= ========= Total master_lag: 2.03 =========