builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0151 starttime: 1454969626.69 results: success (0) buildid: 20160208120726 builduid: b57f21185fb045d8888f8f9e63f0754c revision: ab9e450ac509a019406b9d0200cd56a0d3dc5af8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-08 14:13:46.694986) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-08 14:13:46.695430) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-08 14:13:46.695723) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Zvwib7OszM/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.F8o5ofM20u/Listeners TMPDIR=/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 /builds/slave/test program finished with exit code 0 elapsedTime=0.005245 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-08 14:13:46.719508) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-08 14:13:46.720009) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-08 14:13:46.738775) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 14:13:46.739041) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Zvwib7OszM/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.F8o5ofM20u/Listeners TMPDIR=/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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.005867 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 14:13:46.787250) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-08 14:13:46.787531) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-08 14:13:46.787870) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 14:13:46.793170) ========= 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.Zvwib7OszM/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.F8o5ofM20u/Listeners TMPDIR=/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-02-08 14:13:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 42.3M=0s 2016-02-08 14:13:47 (42.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.487581 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 14:13:47.296163) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 14:13:47.296476) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Zvwib7OszM/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.F8o5ofM20u/Listeners TMPDIR=/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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.025730 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 14:13:47.347555) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-08 14:13:47.348008) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ab9e450ac509a019406b9d0200cd56a0d3dc5af8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev ab9e450ac509a019406b9d0200cd56a0d3dc5af8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Zvwib7OszM/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.F8o5ofM20u/Listeners TMPDIR=/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-02-08 14:13:47,400 truncating revision to first 12 chars 2016-02-08 14:13:47,400 Setting DEBUG logging. 2016-02-08 14:13:47,400 attempt 1/10 2016-02-08 14:13:47,400 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ab9e450ac509?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-08 14:13:49,044 unpacking tar archive at: fx-team-ab9e450ac509/testing/mozharness/ program finished with exit code 0 elapsedTime=1.882021 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-08 14:13:49.246678) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-08 14:13:49.247077) ========= echo ab9e450ac509a019406b9d0200cd56a0d3dc5af8 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'ab9e450ac509a019406b9d0200cd56a0d3dc5af8'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Zvwib7OszM/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.F8o5ofM20u/Listeners TMPDIR=/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 ab9e450ac509a019406b9d0200cd56a0d3dc5af8 program finished with exit code 0 elapsedTime=0.005334 script_repo_revision: 'ab9e450ac509a019406b9d0200cd56a0d3dc5af8' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-08 14:13:49.297577) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-08 14:13:49.297928) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-08 14:13:49.310648) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-02-08 14:13:49.310990) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Zvwib7OszM/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.F8o5ofM20u/Listeners TMPDIR=/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 14:13:49 INFO - MultiFileLogger online at 20160208 14:13:49 in /builds/slave/test 14:13:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:13:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:13:49 INFO - {'append_to_log': False, 14:13:49 INFO - 'base_work_dir': '/builds/slave/test', 14:13:49 INFO - 'blob_upload_branch': 'Fx-Team', 14:13:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:13:49 INFO - 'branch': 'Fx-Team', 14:13:49 INFO - 'buildbot_json_path': 'buildprops.json', 14:13:49 INFO - 'config_files': ('talos/mac_config.py',), 14:13:49 INFO - 'default_actions': ('clobber', 14:13:49 INFO - 'read-buildbot-config', 14:13:49 INFO - 'download-and-extract', 14:13:49 INFO - 'populate-webroot', 14:13:49 INFO - 'create-virtualenv', 14:13:49 INFO - 'install', 14:13:49 INFO - 'run-tests'), 14:13:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:13:49 INFO - 'download_minidump_stackwalk': True, 14:13:49 INFO - 'download_symbols': 'ondemand', 14:13:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:13:49 INFO - 'tooltool.py': '/tools/tooltool.py', 14:13:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:13:49 INFO - '/tools/misc-python/virtualenv.py')}, 14:13:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:13:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:13:49 INFO - 'installer_path': 'installer.exe', 14:13:49 INFO - 'log_level': 'info', 14:13:49 INFO - 'log_name': 'talos', 14:13:49 INFO - 'log_to_console': True, 14:13:49 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:13:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:13:49 INFO - 'opt_config_files': (), 14:13:49 INFO - 'pip_index': False, 14:13:49 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:13:49 INFO - 'cmd': ('bash', 14:13:49 INFO - '-c', 14:13:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:13:49 INFO - 'enabled': True, 14:13:49 INFO - 'halt_on_failure': False, 14:13:49 INFO - 'name': 'check_screen_resolution'},), 14:13:49 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:13:49 INFO - 'cmd': ('bash', 14:13:49 INFO - '-c', 14:13:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:13:49 INFO - 'enabled': True, 14:13:49 INFO - 'halt_on_failure': False, 14:13:49 INFO - 'name': 'check_screen_resolution'},), 14:13:49 INFO - 'run_cmd_checks_enabled': True, 14:13:49 INFO - 'sps_profile': False, 14:13:49 INFO - 'sps_profile_interval': 0, 14:13:49 INFO - 'suite': 'dromaeojs-e10s', 14:13:49 INFO - 'system_bits': '32', 14:13:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:13:49 INFO - 'title': 't-yosemite-r7-0151', 14:13:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:13:49 INFO - 'use_talos_json': True, 14:13:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:13:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:13:49 INFO - 'work_dir': 'build'} 14:13:49 INFO - ##### 14:13:49 INFO - ##### Running clobber step. 14:13:49 INFO - ##### 14:13:49 INFO - Running pre-action listener: _resource_record_pre_action 14:13:49 INFO - Running main action method: clobber 14:13:49 INFO - rmtree: /builds/slave/test/build 14:13:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:13:51 INFO - Running post-action listener: _resource_record_post_action 14:13:51 INFO - ##### 14:13:51 INFO - ##### Running read-buildbot-config step. 14:13:51 INFO - ##### 14:13:51 INFO - Running pre-action listener: _resource_record_pre_action 14:13:51 INFO - Running main action method: read_buildbot_config 14:13:51 INFO - Using buildbot properties: 14:13:51 INFO - { 14:13:51 INFO - "project": "", 14:13:51 INFO - "product": "firefox", 14:13:51 INFO - "script_repo_revision": "production", 14:13:51 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 14:13:51 INFO - "repository": "", 14:13:51 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 14:13:51 INFO - "buildid": "20160208120726", 14:13:51 INFO - "pgo_build": "False", 14:13:51 INFO - "basedir": "/builds/slave/test", 14:13:51 INFO - "buildnumber": 405, 14:13:51 INFO - "slavename": "t-yosemite-r7-0151", 14:13:51 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 14:13:51 INFO - "platform": "yosemite_r7", 14:13:51 INFO - "scheduler": "tests-fx-team-macosx64-talos", 14:13:51 INFO - "branch": "fx-team", 14:13:51 INFO - "repo_path": "integration/fx-team", 14:13:51 INFO - "revision": "ab9e450ac509a019406b9d0200cd56a0d3dc5af8", 14:13:51 INFO - "stage_platform": "macosx64", 14:13:51 INFO - "builduid": "b57f21185fb045d8888f8f9e63f0754c", 14:13:51 INFO - "slavebuilddir": "test" 14:13:51 INFO - } 14:13:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/fG9PiljZSSyDVPPeUNVTUg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 14:13:51 INFO - Running post-action listener: _resource_record_post_action 14:13:51 INFO - ##### 14:13:51 INFO - ##### Running download-and-extract step. 14:13:51 INFO - ##### 14:13:51 INFO - Running pre-action listener: _resource_record_pre_action 14:13:51 INFO - Running main action method: download_and_extract 14:13:51 INFO - mkdir: /builds/slave/test/build/tests 14:13:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:13:51 INFO - https://queue.taskcluster.net/v1/task/fG9PiljZSSyDVPPeUNVTUg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:13:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fG9PiljZSSyDVPPeUNVTUg/artifacts/public/build/test_packages.json 14:13:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fG9PiljZSSyDVPPeUNVTUg/artifacts/public/build/test_packages.json 14:13:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fG9PiljZSSyDVPPeUNVTUg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 14:13:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fG9PiljZSSyDVPPeUNVTUg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 14:13:52 INFO - Downloaded 1277 bytes. 14:13:52 INFO - Reading from file /builds/slave/test/build/test_packages.json 14:13:52 INFO - Using the following test package requirements: 14:13:52 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 14:13:52 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:13:52 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 14:13:52 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:13:52 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 14:13:52 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:13:52 INFO - u'jsshell-mac.zip'], 14:13:52 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:13:52 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 14:13:52 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 14:13:52 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:13:52 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 14:13:52 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:13:52 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 14:13:52 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:13:52 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 14:13:52 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 14:13:52 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:13:52 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 14:13:52 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:13:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:13:52 INFO - https://queue.taskcluster.net/v1/task/fG9PiljZSSyDVPPeUNVTUg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:13:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fG9PiljZSSyDVPPeUNVTUg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 14:13:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fG9PiljZSSyDVPPeUNVTUg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 14:13:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fG9PiljZSSyDVPPeUNVTUg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 14:13:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fG9PiljZSSyDVPPeUNVTUg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:13:53 INFO - Downloaded 17753932 bytes. 14:13:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:13:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 14:13:56 INFO - Return code: 0 14:13:56 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 14:13:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:13:56 INFO - https://queue.taskcluster.net/v1/task/fG9PiljZSSyDVPPeUNVTUg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:13:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fG9PiljZSSyDVPPeUNVTUg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 14:13:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fG9PiljZSSyDVPPeUNVTUg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 14:13:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fG9PiljZSSyDVPPeUNVTUg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 14:13:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fG9PiljZSSyDVPPeUNVTUg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:13:57 INFO - Downloaded 17753932 bytes. 14:13:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:13:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 14:14:00 INFO - Return code: 0 14:14:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:14:00 INFO - https://queue.taskcluster.net/v1/task/fG9PiljZSSyDVPPeUNVTUg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 14:14:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fG9PiljZSSyDVPPeUNVTUg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 14:14:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fG9PiljZSSyDVPPeUNVTUg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 14:14:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fG9PiljZSSyDVPPeUNVTUg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 14:14:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fG9PiljZSSyDVPPeUNVTUg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 14:14:01 INFO - Downloaded 10706547 bytes. 14:14:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:14:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 14:14:01 INFO - Return code: 0 14:14:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:14:01 INFO - https://queue.taskcluster.net/v1/task/fG9PiljZSSyDVPPeUNVTUg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 14:14:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fG9PiljZSSyDVPPeUNVTUg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 14:14:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fG9PiljZSSyDVPPeUNVTUg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 14:14:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fG9PiljZSSyDVPPeUNVTUg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 14:14:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fG9PiljZSSyDVPPeUNVTUg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 14:14:04 INFO - Downloaded 111839005 bytes. 14:14:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fG9PiljZSSyDVPPeUNVTUg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 14:14:04 INFO - mkdir: /builds/slave/test/properties 14:14:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:14:04 INFO - Writing to file /builds/slave/test/properties/build_url 14:14:04 INFO - Contents: 14:14:04 INFO - build_url:https://queue.taskcluster.net/v1/task/fG9PiljZSSyDVPPeUNVTUg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 14:14:05 INFO - Running post-action listener: _resource_record_post_action 14:14:05 INFO - Running post-action listener: set_extra_try_arguments 14:14:05 INFO - ##### 14:14:05 INFO - ##### Running populate-webroot step. 14:14:05 INFO - ##### 14:14:05 INFO - Running pre-action listener: _resource_record_pre_action 14:14:05 INFO - Running main action method: populate_webroot 14:14:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:14:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:14:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:14:05 INFO - '--tppagecycles', 14:14:05 INFO - '7'], 14:14:05 INFO - 'tests': ['tsvgm']}}, 14:14:05 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:14:05 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:14:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:14:05 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 14:14:05 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:14:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:14:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:14:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:14:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:14:05 INFO - 'talos_options': ['--e10s'], 14:14:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:14:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:14:05 INFO - 'tests': ['damp', 'tps']}, 14:14:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:14:05 INFO - 'talos_options': ['--e10s'], 14:14:05 INFO - 'tests': ['damp', 'tps']}, 14:14:05 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:14:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:14:05 INFO - 'other': {'tests': ['a11yr', 14:14:05 INFO - 'ts_paint', 14:14:05 INFO - 'tpaint', 14:14:05 INFO - 'sessionrestore', 14:14:05 INFO - 'sessionrestore_no_auto_restore']}, 14:14:05 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:14:05 INFO - 'tests': ['a11yr', 14:14:05 INFO - 'ts_paint', 14:14:05 INFO - 'tpaint', 14:14:05 INFO - 'sessionrestore', 14:14:05 INFO - 'sessionrestore_no_auto_restore']}, 14:14:05 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:14:05 INFO - 'tests': ['a11yr', 14:14:05 INFO - 'ts_paint', 14:14:05 INFO - 'tpaint', 14:14:05 INFO - 'sessionrestore', 14:14:05 INFO - 'sessionrestore_no_auto_restore']}, 14:14:05 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:14:05 INFO - 'tests': ['a11yr', 14:14:05 INFO - 'ts_paint', 14:14:05 INFO - 'tpaint', 14:14:05 INFO - 'sessionrestore', 14:14:05 INFO - 'sessionrestore_no_auto_restore']}, 14:14:05 INFO - 'other_l64': {'tests': ['a11yr', 14:14:05 INFO - 'ts_paint', 14:14:05 INFO - 'tpaint', 14:14:05 INFO - 'sessionrestore', 14:14:05 INFO - 'sessionrestore_no_auto_restore']}, 14:14:05 INFO - 'other_nol64': {'tests': ['a11yr', 14:14:05 INFO - 'ts_paint', 14:14:05 INFO - 'tpaint', 14:14:05 INFO - 'sessionrestore', 14:14:05 INFO - 'sessionrestore_no_auto_restore']}, 14:14:05 INFO - 'svgr': {'tests': ['tsvgx', 14:14:05 INFO - 'tsvgr_opacity', 14:14:05 INFO - 'tart', 14:14:05 INFO - 'tscrollx', 14:14:05 INFO - 'cart']}, 14:14:05 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:14:05 INFO - 'tests': ['tsvgx', 14:14:05 INFO - 'tsvgr_opacity', 14:14:05 INFO - 'tart', 14:14:05 INFO - 'tscrollx', 14:14:05 INFO - 'cart']}, 14:14:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:14:05 INFO - 'tests': ['tp5o']}, 14:14:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:14:05 INFO - 'talos_options': ['--e10s'], 14:14:05 INFO - 'tests': ['tp5o']}, 14:14:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:14:05 INFO - 'talos_options': ['--xperf_path', 14:14:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:14:05 INFO - 'tests': ['tp5n']}, 14:14:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:14:05 INFO - 'talos_options': ['--e10s', 14:14:05 INFO - '--xperf_path', 14:14:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:14:05 INFO - 'tests': ['tp5n']}}, 14:14:05 INFO - 'talos.zip': {'path': '', 14:14:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:14:05 INFO - Running post-action listener: _resource_record_post_action 14:14:05 INFO - ##### 14:14:05 INFO - ##### Running create-virtualenv step. 14:14:05 INFO - ##### 14:14:05 INFO - Running pre-action listener: _resource_record_pre_action 14:14:05 INFO - Running main action method: create_virtualenv 14:14:05 INFO - Creating virtualenv /builds/slave/test/build/venv 14:14:05 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 14:14:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:14:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:14:06 INFO - Using real prefix '/tools/python27' 14:14:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:14:06 INFO - Installing distribute.............................................................................................................................................................................................done. 14:14:09 INFO - Installing pip.................done. 14:14:09 INFO - Return code: 0 14:14:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:14:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:14:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:14:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b5bea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5c54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc892c9cd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b462d30>, '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 0x10b286db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b459b20>, '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.Zvwib7OszM/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.F8o5ofM20u/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 14:14:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:14:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:14:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Zvwib7OszM/Render', 14:14:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:14:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:14:09 INFO - 'HOME': '/Users/cltbld', 14:14:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:14:09 INFO - 'LOGNAME': 'cltbld', 14:14:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:09 INFO - 'MOZ_NO_REMOTE': '1', 14:14:09 INFO - 'NO_EM_RESTART': '1', 14:14:09 INFO - 'PAGER': '/bin/cat', 14:14:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:14:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:09 INFO - 'PWD': '/builds/slave/test', 14:14:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:14:09 INFO - 'SHELL': '/bin/bash', 14:14:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F8o5ofM20u/Listeners', 14:14:09 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 14:14:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:14:09 INFO - 'USER': 'cltbld', 14:14:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:14:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:14:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:09 INFO - 'XPC_FLAGS': '0x0', 14:14:09 INFO - 'XPC_SERVICE_NAME': '0', 14:14:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:14:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:09 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 14:14:09 INFO - Cleaning up... 14:14:09 INFO - Return code: 0 14:14:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:14:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:14:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:14:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b5bea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5c54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc892c9cd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b462d30>, '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 0x10b286db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b459b20>, '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.Zvwib7OszM/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.F8o5ofM20u/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 14:14:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 14:14:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:14:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Zvwib7OszM/Render', 14:14:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:14:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:14:09 INFO - 'HOME': '/Users/cltbld', 14:14:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:14:09 INFO - 'LOGNAME': 'cltbld', 14:14:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:09 INFO - 'MOZ_NO_REMOTE': '1', 14:14:09 INFO - 'NO_EM_RESTART': '1', 14:14:09 INFO - 'PAGER': '/bin/cat', 14:14:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:14:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:09 INFO - 'PWD': '/builds/slave/test', 14:14:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:14:09 INFO - 'SHELL': '/bin/bash', 14:14:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F8o5ofM20u/Listeners', 14:14:09 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 14:14:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:14:09 INFO - 'USER': 'cltbld', 14:14:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:14:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:14:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:09 INFO - 'XPC_FLAGS': '0x0', 14:14:09 INFO - 'XPC_SERVICE_NAME': '0', 14:14:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:14:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:10 INFO - Downloading/unpacking psutil>=0.7.1 14:14:10 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 14:14:10 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 14:14:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:10 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 14:14:10 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 14:14:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:14:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:14:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:14:12 INFO - Installing collected packages: psutil 14:14:12 INFO - Running setup.py install for psutil 14:14:13 INFO - building 'psutil._psutil_osx' extension 14:14:13 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 14:14:13 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 14:14:13 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 14:14:13 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 14:14:13 INFO - building 'psutil._psutil_posix' extension 14:14:13 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 14:14:13 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:14:13 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:14:13 INFO - ^ 14:14:13 INFO - 1 warning generated. 14:14:13 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 14:14:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:14:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:14:14 INFO - Successfully installed psutil 14:14:14 INFO - Cleaning up... 14:14:14 INFO - Return code: 0 14:14:14 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:14:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:14:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:14:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b5bea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5c54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc892c9cd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b462d30>, '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 0x10b286db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b459b20>, '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.Zvwib7OszM/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.F8o5ofM20u/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 14:14:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 14:14:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:14:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Zvwib7OszM/Render', 14:14:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:14:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:14:14 INFO - 'HOME': '/Users/cltbld', 14:14:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:14:14 INFO - 'LOGNAME': 'cltbld', 14:14:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:14 INFO - 'MOZ_NO_REMOTE': '1', 14:14:14 INFO - 'NO_EM_RESTART': '1', 14:14:14 INFO - 'PAGER': '/bin/cat', 14:14:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:14:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:14 INFO - 'PWD': '/builds/slave/test', 14:14:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:14:14 INFO - 'SHELL': '/bin/bash', 14:14:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F8o5ofM20u/Listeners', 14:14:14 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 14:14:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:14:14 INFO - 'USER': 'cltbld', 14:14:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:14:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:14:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:14 INFO - 'XPC_FLAGS': '0x0', 14:14:14 INFO - 'XPC_SERVICE_NAME': '0', 14:14:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:14:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:14 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:14:14 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 14:14:14 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 14:14:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:14 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 14:14:14 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 14:14:16 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:14:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:14:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:14:16 INFO - Installing collected packages: mozsystemmonitor 14:14:16 INFO - Running setup.py install for mozsystemmonitor 14:14:17 INFO - Successfully installed mozsystemmonitor 14:14:17 INFO - Cleaning up... 14:14:17 INFO - Return code: 0 14:14:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:14:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:14:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:14:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b5bea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5c54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc892c9cd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b462d30>, '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 0x10b286db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b459b20>, '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.Zvwib7OszM/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.F8o5ofM20u/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 14:14:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:14:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:14:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Zvwib7OszM/Render', 14:14:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:14:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:14:17 INFO - 'HOME': '/Users/cltbld', 14:14:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:14:17 INFO - 'LOGNAME': 'cltbld', 14:14:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:17 INFO - 'MOZ_NO_REMOTE': '1', 14:14:17 INFO - 'NO_EM_RESTART': '1', 14:14:17 INFO - 'PAGER': '/bin/cat', 14:14:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:14:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:17 INFO - 'PWD': '/builds/slave/test', 14:14:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:14:17 INFO - 'SHELL': '/bin/bash', 14:14:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F8o5ofM20u/Listeners', 14:14:17 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 14:14:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:14:17 INFO - 'USER': 'cltbld', 14:14:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:14:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:14:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:17 INFO - 'XPC_FLAGS': '0x0', 14:14:17 INFO - 'XPC_SERVICE_NAME': '0', 14:14:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:14:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:17 INFO - Downloading/unpacking blobuploader==1.2.4 14:14:17 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 14:14:17 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 14:14:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:17 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 14:14:17 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 14:14:19 INFO - Downloading blobuploader-1.2.4.tar.gz 14:14:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:14:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:14:19 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 14:14:19 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 14:14:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:19 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 14:14:19 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 14:14:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:14:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:14:20 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 14:14:20 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 14:14:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:20 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 14:14:20 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 14:14:20 INFO - Downloading docopt-0.6.1.tar.gz 14:14:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:14:20 INFO - Installing collected packages: blobuploader, requests, docopt 14:14:20 INFO - Running setup.py install for blobuploader 14:14:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:14:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:14:20 INFO - Running setup.py install for requests 14:14:21 INFO - Running setup.py install for docopt 14:14:21 INFO - Successfully installed blobuploader requests docopt 14:14:21 INFO - Cleaning up... 14:14:21 INFO - Return code: 0 14:14:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:14:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:14:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b5bea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5c54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc892c9cd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b462d30>, '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 0x10b286db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b459b20>, '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.Zvwib7OszM/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.F8o5ofM20u/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 14:14:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:14:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:14:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Zvwib7OszM/Render', 14:14:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:14:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:14:21 INFO - 'HOME': '/Users/cltbld', 14:14:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:14:21 INFO - 'LOGNAME': 'cltbld', 14:14:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:21 INFO - 'MOZ_NO_REMOTE': '1', 14:14:21 INFO - 'NO_EM_RESTART': '1', 14:14:21 INFO - 'PAGER': '/bin/cat', 14:14:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:14:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:21 INFO - 'PWD': '/builds/slave/test', 14:14:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:14:21 INFO - 'SHELL': '/bin/bash', 14:14:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F8o5ofM20u/Listeners', 14:14:21 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 14:14:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:14:21 INFO - 'USER': 'cltbld', 14:14:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:14:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:14:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:21 INFO - 'XPC_FLAGS': '0x0', 14:14:21 INFO - 'XPC_SERVICE_NAME': '0', 14:14:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:14:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:14:21 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-WJKF5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:14:22 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-GWPgLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:14:22 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-APNGVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:14:22 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-7wZR4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:14:22 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-GYEAZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:14:22 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-sKsT71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:14:22 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-h0zMlg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:14:22 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-j1iFHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:14:22 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-qTuS99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:14:22 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-9mFzBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:14:23 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-MhGRqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:14:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:14:23 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-SMiO2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:14:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:14:23 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-t7ute5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:14:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:14:23 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-k7JzRU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:14:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:14:23 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-bbftxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:14:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:14:23 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-_iYi45-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:14:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:14:23 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-HEdDp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:14:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:14:23 INFO - Running setup.py install for manifestparser 14:14:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:14:23 INFO - Running setup.py install for mozcrash 14:14:24 INFO - Running setup.py install for mozdebug 14:14:24 INFO - Running setup.py install for mozdevice 14:14:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:14:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:14:24 INFO - Running setup.py install for mozfile 14:14:24 INFO - Running setup.py install for mozhttpd 14:14:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:14:24 INFO - Running setup.py install for mozinfo 14:14:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:14:24 INFO - Running setup.py install for mozInstall 14:14:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:14:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:14:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:14:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:14:24 INFO - Running setup.py install for mozleak 14:14:25 INFO - Running setup.py install for mozlog 14:14:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:14:25 INFO - Running setup.py install for moznetwork 14:14:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:14:25 INFO - Running setup.py install for mozprocess 14:14:25 INFO - Running setup.py install for mozprofile 14:14:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:14:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:14:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:14:25 INFO - Running setup.py install for mozrunner 14:14:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:14:25 INFO - Running setup.py install for mozscreenshot 14:14:25 INFO - Running setup.py install for moztest 14:14:26 INFO - Running setup.py install for mozversion 14:14:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:14:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:14:26 INFO - Cleaning up... 14:14:26 INFO - Return code: 0 14:14:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:14:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:14:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b5bea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5c54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc892c9cd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b462d30>, '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 0x10b286db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b459b20>, '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.Zvwib7OszM/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.F8o5ofM20u/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 14:14:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:14:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:14:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Zvwib7OszM/Render', 14:14:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:14:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:14:26 INFO - 'HOME': '/Users/cltbld', 14:14:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:14:26 INFO - 'LOGNAME': 'cltbld', 14:14:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:26 INFO - 'MOZ_NO_REMOTE': '1', 14:14:26 INFO - 'NO_EM_RESTART': '1', 14:14:26 INFO - 'PAGER': '/bin/cat', 14:14:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:14:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:26 INFO - 'PWD': '/builds/slave/test', 14:14:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:14:26 INFO - 'SHELL': '/bin/bash', 14:14:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F8o5ofM20u/Listeners', 14:14:26 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 14:14:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:14:26 INFO - 'USER': 'cltbld', 14:14:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:14:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:14:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:26 INFO - 'XPC_FLAGS': '0x0', 14:14:26 INFO - 'XPC_SERVICE_NAME': '0', 14:14:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:14:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:14:26 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-kQaLo2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:14:26 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)) 14:14:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:14:26 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-EGhnMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:14:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 14:14:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:14:26 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-VR6YOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:14:26 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)) 14:14:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:14:26 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-jnoVX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:14:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:14:27 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-Y6hlHw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:14:27 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)) 14:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:14:27 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-M2q2R9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:14:27 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)) 14:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:14:27 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-IgkBhh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:14:27 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)) 14:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:14:27 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-8cFR1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:14:27 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)) 14:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:14:27 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-hDI838-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:14:27 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)) 14:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:14:27 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-Fzpqg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:14:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 14:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:14:27 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-23O2uU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:14:27 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)) 14:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:14:27 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-OhXs4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:14:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 14:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:14:27 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-uOW0p1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:14:27 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)) 14:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:14:27 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-Tff5gO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:14:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 14:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:14:28 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-u3HRDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:14:28 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)) 14:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:14:28 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-PjTnUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:14:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:14:28 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-7ePqnP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:14:28 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)) 14:14:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:14:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:14:28 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)) 14:14:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:14:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:14:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:14:28 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 14:14:28 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 14:14:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:28 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 14:14:28 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 14:14:30 INFO - Downloading blessings-1.6.tar.gz 14:14:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:14:30 INFO - Installing collected packages: blessings 14:14:30 INFO - Running setup.py install for blessings 14:14:31 INFO - Successfully installed blessings 14:14:31 INFO - Cleaning up... 14:14:31 INFO - Return code: 0 14:14:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:14:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:14:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:14:31 INFO - Reading from file tmpfile_stdout 14:14:31 INFO - Current package versions: 14:14:31 INFO - blessings == 1.6 14:14:31 INFO - blobuploader == 1.2.4 14:14:31 INFO - docopt == 0.6.1 14:14:31 INFO - manifestparser == 1.1 14:14:31 INFO - mozInstall == 1.12 14:14:31 INFO - mozcrash == 0.16 14:14:31 INFO - mozdebug == 0.1 14:14:31 INFO - mozdevice == 0.48 14:14:31 INFO - mozfile == 1.2 14:14:31 INFO - mozhttpd == 0.7 14:14:31 INFO - mozinfo == 0.9 14:14:31 INFO - mozleak == 0.1 14:14:31 INFO - mozlog == 3.1 14:14:31 INFO - moznetwork == 0.27 14:14:31 INFO - mozprocess == 0.22 14:14:31 INFO - mozprofile == 0.28 14:14:31 INFO - mozrunner == 6.11 14:14:31 INFO - mozscreenshot == 0.1 14:14:31 INFO - mozsystemmonitor == 0.0 14:14:31 INFO - moztest == 0.7 14:14:31 INFO - mozversion == 1.4 14:14:31 INFO - psutil == 3.1.1 14:14:31 INFO - requests == 1.2.3 14:14:31 INFO - wsgiref == 0.1.2 14:14:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:14:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:14:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b5bea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5c54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc892c9cd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b462d30>, '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 0x10b286db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b459b20>, '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.Zvwib7OszM/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.F8o5ofM20u/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 14:14:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:14:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:14:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Zvwib7OszM/Render', 14:14:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:14:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:14:31 INFO - 'HOME': '/Users/cltbld', 14:14:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:14:31 INFO - 'LOGNAME': 'cltbld', 14:14:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:31 INFO - 'MOZ_NO_REMOTE': '1', 14:14:31 INFO - 'NO_EM_RESTART': '1', 14:14:31 INFO - 'PAGER': '/bin/cat', 14:14:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:14:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:31 INFO - 'PWD': '/builds/slave/test', 14:14:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:14:31 INFO - 'SHELL': '/bin/bash', 14:14:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F8o5ofM20u/Listeners', 14:14:31 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 14:14:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:14:31 INFO - 'USER': 'cltbld', 14:14:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:14:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:14:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:31 INFO - 'XPC_FLAGS': '0x0', 14:14:31 INFO - 'XPC_SERVICE_NAME': '0', 14:14:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:14:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:31 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)) 14:14:31 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)) 14:14:31 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)) 14:14:31 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)) 14:14:31 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)) 14:14:31 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)) 14:14:31 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)) 14:14:31 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)) 14:14:31 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)) 14:14:31 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)) 14:14:31 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)) 14:14:31 INFO - Cleaning up... 14:14:31 INFO - Return code: 0 14:14:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:14:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:14:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14: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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b5bea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5c54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc892c9cd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b462d30>, '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 0x10b286db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b459b20>, '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.Zvwib7OszM/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.F8o5ofM20u/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 14:14:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:14:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:14:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Zvwib7OszM/Render', 14:14:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:14:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:14:31 INFO - 'HOME': '/Users/cltbld', 14:14:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:14:31 INFO - 'LOGNAME': 'cltbld', 14:14:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:31 INFO - 'MOZ_NO_REMOTE': '1', 14:14:31 INFO - 'NO_EM_RESTART': '1', 14:14:31 INFO - 'PAGER': '/bin/cat', 14:14:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:14:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:31 INFO - 'PWD': '/builds/slave/test', 14:14:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:14:31 INFO - 'SHELL': '/bin/bash', 14:14:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F8o5ofM20u/Listeners', 14:14:31 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 14:14:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:14:31 INFO - 'USER': 'cltbld', 14:14:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:14:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:14:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:31 INFO - 'XPC_FLAGS': '0x0', 14:14:31 INFO - 'XPC_SERVICE_NAME': '0', 14:14:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:14:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:31 INFO - Downloading/unpacking jsonschema 14:14: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 14:14: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 14:14:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14: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 14:14: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 14:14:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:14:34 INFO - Downloading/unpacking functools32 (from jsonschema) 14:14: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 14:14: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 14:14:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14: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 14:14: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 14:14:34 INFO - Downloading functools32-3.2.3-2.tar.gz 14:14:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:14:34 INFO - warning: no files found matching '*.txt' 14:14:34 INFO - no previously-included directories found matching 'build' 14:14:34 INFO - no previously-included directories found matching 'dist' 14:14:34 INFO - no previously-included directories found matching '.git*' 14:14:34 INFO - Installing collected packages: jsonschema, functools32 14:14:34 INFO - Running setup.py install for functools32 14:14:34 INFO - warning: no files found matching '*.txt' 14:14:34 INFO - no previously-included directories found matching 'build' 14:14:34 INFO - no previously-included directories found matching 'dist' 14:14:34 INFO - no previously-included directories found matching '.git*' 14:14:34 INFO - Successfully installed jsonschema functools32 14:14:34 INFO - Cleaning up... 14:14:34 INFO - Return code: 0 14:14:34 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:14:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14: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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b5bea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5c54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc892c9cd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b462d30>, '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 0x10b286db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b459b20>, '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.Zvwib7OszM/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.F8o5ofM20u/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 14:14:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:14:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:14:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Zvwib7OszM/Render', 14:14:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:14:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:14:34 INFO - 'HOME': '/Users/cltbld', 14:14:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:14:34 INFO - 'LOGNAME': 'cltbld', 14:14:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:34 INFO - 'MOZ_NO_REMOTE': '1', 14:14:34 INFO - 'NO_EM_RESTART': '1', 14:14:34 INFO - 'PAGER': '/bin/cat', 14:14:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:14:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:34 INFO - 'PWD': '/builds/slave/test', 14:14:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:14:34 INFO - 'SHELL': '/bin/bash', 14:14:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F8o5ofM20u/Listeners', 14:14:34 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 14:14:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:14:34 INFO - 'USER': 'cltbld', 14:14:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:14:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:14:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:34 INFO - 'XPC_FLAGS': '0x0', 14:14:34 INFO - 'XPC_SERVICE_NAME': '0', 14:14:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:14:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:35 INFO - Downloading/unpacking flake8 14:14: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 14:14: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 14:14:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14: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 14:14: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 14:14:37 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:14:37 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:14:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:14:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:14:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:14:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:14:37 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:14:37 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:14:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:14:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:14:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:14:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:14:38 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:14:38 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 14:14:38 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 14:14:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:38 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 14:14:38 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 14:14:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:14:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:14:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:14:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:14:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:14:38 INFO - no previously-included directories found matching 'docs/_build' 14:14:38 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:14:38 INFO - Running setup.py install for pep8 14:14:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:14:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:14:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:14:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:14:38 INFO - no previously-included directories found matching 'docs/_build' 14:14:38 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:14:38 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:14:38 INFO - Cleaning up... 14:14:39 INFO - Return code: 0 14:14:39 INFO - Running post-action listener: _resource_record_post_action 14:14:39 INFO - Running post-action listener: _start_resource_monitoring 14:14:39 INFO - Starting resource monitoring. 14:14:39 INFO - ##### 14:14:39 INFO - ##### Running install step. 14:14:39 INFO - ##### 14:14:39 INFO - Running pre-action listener: _resource_record_pre_action 14:14:39 INFO - Running main action method: install 14:14:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:14:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:14:39 INFO - Reading from file tmpfile_stdout 14:14:39 INFO - Detecting whether we're running mozinstall >=1.0... 14:14:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:14:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:14:39 INFO - Reading from file tmpfile_stdout 14:14:39 INFO - Output received: 14:14:39 INFO - Usage: mozinstall [options] installer 14:14:39 INFO - Options: 14:14:39 INFO - -h, --help show this help message and exit 14:14:39 INFO - -d DEST, --destination=DEST 14:14:39 INFO - Directory to install application into. [default: 14:14:39 INFO - "/builds/slave/test"] 14:14:39 INFO - --app=APP Application being installed. [default: firefox] 14:14:39 INFO - mkdir: /builds/slave/test/build/application 14:14:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:14:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 14:15:14 INFO - Reading from file tmpfile_stdout 14:15:14 INFO - Output received: 14:15:14 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:15:14 INFO - Running post-action listener: _resource_record_post_action 14:15:14 INFO - ##### 14:15:14 INFO - ##### Running run-tests step. 14:15:14 INFO - ##### 14:15:14 INFO - Running pre-action listener: _resource_record_pre_action 14:15:14 INFO - Running main action method: run_tests 14:15:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:15:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:15:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:15:14 INFO - 2016-02-08 14:15:14.213 screenresolution[1654:7346] starting screenresolution argv=screenresolution get 14:15:14 INFO - 2016-02-08 14:15:14.216 screenresolution[1654:7346] Display 0: 1600x1200x32@60 14:15:14 INFO - 2016-02-08 14:15:14.221 screenresolution[1655:7348] starting screenresolution argv=screenresolution list 14:15:14 INFO - Available Modes on Display 0 14:15:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:15:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:15:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:15:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:15:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:15:14 INFO - Intel Iris: 14:15:14 INFO - Chipset Model: Intel Iris 14:15:14 INFO - Type: GPU 14:15:14 INFO - Bus: Built-In 14:15:14 INFO - VRAM (Dynamic, Max): 1536 MB 14:15:14 INFO - Vendor: Intel (0x8086) 14:15:14 INFO - Device ID: 0x0a2e 14:15:14 INFO - Revision ID: 0x0009 14:15:14 INFO - Displays: 14:15:14 INFO - Display: 14:15:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:15:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:15:14 INFO - Display Serial Number: 1600x1200 60 14:15:14 INFO - Main Display: Yes 14:15:14 INFO - Mirror: Off 14:15:14 INFO - Online: Yes 14:15:14 INFO - Rotation: Supported 14:15:14 INFO - Return code: 0 14:15:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:15:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:15:14 INFO - Python 2.7.3 14:15:14 INFO - Return code: 0 14:15:14 INFO - grabbing minidump binary from tooltool 14:15:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:14 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b462d30>, '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 0x10b286db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b459b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:15:14 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 14:15:14 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 14:15:14 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:15:14 INFO - Return code: 0 14:15:14 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:15:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:15:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:15:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:15:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:15:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:15:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:15:15 INFO - Return code: 0 14:15:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fG9PiljZSSyDVPPeUNVTUg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0151', '--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 14:15:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fG9PiljZSSyDVPPeUNVTUg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0151 --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 14:15:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Zvwib7OszM/Render', 14:15:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:15:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:15:15 INFO - 'HOME': '/Users/cltbld', 14:15:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:15:15 INFO - 'LOGNAME': 'cltbld', 14:15:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:15:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:15:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:15 INFO - 'MOZ_NO_REMOTE': '1', 14:15:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:15:15 INFO - 'NO_EM_RESTART': '1', 14:15:15 INFO - 'PAGER': '/bin/cat', 14:15:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:15:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:15 INFO - 'PWD': '/builds/slave/test', 14:15:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:15:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:15:15 INFO - 'SHELL': '/bin/bash', 14:15:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F8o5ofM20u/Listeners', 14:15:15 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 14:15:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:15:15 INFO - 'USER': 'cltbld', 14:15:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:15:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:15:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:15 INFO - 'XPC_FLAGS': '0x0', 14:15:15 INFO - 'XPC_SERVICE_NAME': '0', 14:15:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:15:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fG9PiljZSSyDVPPeUNVTUg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0151', '--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 14:15:16 INFO - mozversion application_buildid: 20160208120726 14:15:16 INFO - mozversion application_changeset: ab9e450ac509a019406b9d0200cd56a0d3dc5af8 14:15:16 INFO - mozversion application_display_name: Nightly 14:15:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:15:16 INFO - mozversion application_name: Firefox 14:15:16 INFO - mozversion application_remotingname: firefox 14:15:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:15:16 INFO - mozversion application_vendor: Mozilla 14:15:16 INFO - mozversion application_version: 47.0a1 14:15:16 INFO - mozversion platform_buildid: 20160208120726 14:15:16 INFO - mozversion platform_changeset: ab9e450ac509a019406b9d0200cd56a0d3dc5af8 14:15:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:15:16 INFO - mozversion platform_version: 47.0a1 14:15:16 INFO - using testdate: 1454969716 14:15:16 INFO - actual date: 1454969716 14:15:16 INFO - starting webserver on 'localhost:49274' 14:15:16 INFO - SUITE-START | Running 2 tests 14:15:16 INFO - TEST-START | dromaeo_css 14:15:16 INFO - operating with platform_type : mac_ 14:15:16 INFO - Initialising browser for dromaeo_css test... 14:15:16 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/tmpjVSXGj/profile http://localhost:49274/getInfo.html) 14:15:19 INFO - PROCESS | 1673 | __metrics Screen width/height:1600/1200 14:15:19 INFO - PROCESS | 1673 | colorDepth:24 14:15:19 INFO - PROCESS | 1673 | Browser inner width/height: 1024/689 14:15:19 INFO - PROCESS | 1673 | __metrics 14:15:19 INFO - PROCESS | 1673 | 14:15:19 INFO - PROCESS | 1673 | ###!!! [Child][MessageChannel] Error: (msgtype=0x2A0045,name=PBrowser::Msg___delete__) Channel closing: too late to send/recv, messages will be lost 14:15:19 INFO - PROCESS | 1673 | 14:15:20 INFO - TEST-INFO | 1673: exit 0 14:15:20 INFO - Browser initialized. 14:15:20 INFO - Running cycle 1/1 for dromaeo_css test... 14:15:20 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/tmpjVSXGj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:15:32 INFO - PROCESS | 1677 | RSS: Main: 259207168 14:15:32 INFO - PROCESS | 1677 | 14:16:21 INFO - PROCESS | 1677 | 1454969781738 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:18:32 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 14:18:33 INFO - PROCESS | 1677 | RSS: Main: 272138240 14:18:33 INFO - PROCESS | 1677 | 14:21:35 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 14:21:36 INFO - PROCESS | 1677 | RSS: Main: 283979776 14:21:36 INFO - PROCESS | 1677 | 14:24:38 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 14:24:38 INFO - PROCESS | 1677 | RSS: Main: 285073408 14:24:38 INFO - PROCESS | 1677 | 14:27:40 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 14:27:41 INFO - PROCESS | 1677 | RSS: Main: 287313920 14:27:41 INFO - PROCESS | 1677 | 14:30:44 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 14:30:44 INFO - PROCESS | 1677 | RSS: Main: 288276480 14:30:44 INFO - PROCESS | 1677 | 14:33:47 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 14:33:47 INFO - PROCESS | 1677 | RSS: Main: 291258368 14:33:47 INFO - PROCESS | 1677 | 14:33:47 INFO - PROCESS | 1677 | __start_tp_report 14:33:47 INFO - PROCESS | 1677 | _x_x_mozilla_page_load 14:33:47 INFO - PROCESS | 1677 | _x_x_mozilla_page_load_details 14:33:47 INFO - PROCESS | 1677 | |i|pagename|runs| 14:33:47 INFO - PROCESS | 1677 | |0;dojo.html;3518.3491054154983;3587.6232995535483;3618.077390265482;3637.0543658648744;3643.4352675335317;5689.175069614904;5734.541236701064;5813.825585232445;5836.970815145924;5865.648061116325;5711.742971566279;5843.357230704619;5847;5848.181254624356;5856.385079566648;5194.454582268864;5241.161414173733;5252.8686782830355;5285.947140528584;5314.2560041594015;5154.278401023859;5252.6323157379;5290.92063619046;5331.57347412208;5355.169948657965;5130.820421285256;5162.74186290684;5241.31862857826;5247.86880327991;5281.155015197588;5204.791808327663;5225.790968361261;5250.81622143227;5270.420253772082;5274.5780337572905;5077.086124497589;5187.403448603422;5218.373795144569;5223.033738758304;5239.5546378557865;5563.221149039097;5732.082866741343;5732.656040637575;5742.885142297172;5771.50942169916;6286.968565157145;6304.495640348761;6319.178506794134;6332.810015699536;6337.429631333156;5215.504527069922;5698.831739493394;6254.15568898202;6311.8737625247695;6323.873522529524;5943;5948.078047902539;5951.642901425928;5951.821445356646;6008.879822403527;6215.844603884849;6327.651979141191;6379.585326953733;6398.040293955851;6401.3598640135615;4867.9269810952865;6139.754409823647;6150.323464418911;6217.937820621736;6218.409251121137;6275.6862156891975;6296.307406185316;6324.968375158095;6342.8414289642205;6432.678366081677;5475.863103422446;6161;6270.498360131179;6271.027990661455;6300.8424789379715;4710.293455981561;6149.2620885494025;6192.442680158807;6267.874642507124;6304.842378940563;4307.332363483665;4813.879653008703;4956.677815942025;4984.3021976923255;5003.449620541737;3818.4845045919;3867.207222519377;4312.137572485452;4391.538888416734;4469.910601787946;5812.186293918855;5848.88302233953;5887.882242355129;5894.440028197314;5966.701664916737;6190.597611155351;6262.780802671976;6296.5277604178955;6306.432421082033;6314.652694101776;4672.883177920511;5850.678212698343;5854.121881717691;5856.590038697335;5890.676012819336;5449.918251226235;5467.5625949923915;5474.452554744574;5477.972610136924;5478.726063696799;6272.905906411407;6348.714307856158;6399.8080057598345;6414.390632889868;6420.422162005442;6265.122882796503;6284.74861005573;6305.337939516468;6305.747770089145;6307.3377295383325;6278.215223097113;6421.7110230038825;6428.517861160525;6429.421352078335;6462.192225971754;6197.163382943245;6247.656378899204;6268.404501572343;6270.435660790551;6278.058291256348;6237.500999919905;6262.4990000800735;6265.592736472115;6265.686715664289;6277.466415354746;4681.368015317888;6105.419985101408;6141.109539116893;6174.536909731698;6228.626282422888;6177.660228687286;6200.658963757037;6211.130441738251;6215.34738852414;6226.439620434183;5428.592855535771;6095.1466794647895;6113.2969708482315;6117.449429551361;6122.5408094392205;6089.269287685329;6126.792505495216;6210.658413787285;6234.314225435289;6246.781362652286;6046.365131661112;6048;6104.021790100797;6112.541559382975;6131.743695907123 14:33:47 INFO - PROCESS | 1677 | |1;ext.html;454.718074793628;455.3215708594196;558.9776408943643;566.9879265511064;598.8293336399125;37591.81204093979;37919;37938.43092353617;37981.430278545806;38213.808930955376;38626;39265.822025339214;39430.60569394305;39674.80162599183;40008;8714.215720585162;8861.291096712279;8888.466691998468;8901.332400069989;8902.910970890272;8005.399595030367;9314.254859611216;9368.110029547217;9506.667266645669;9523.380980236298;8063.475874068166;8083.717069902555;9445.622175112987;9470.147686708195;9539;9476.71569852902;9591.712248632517;9625.71122866315;9643.614255429844;9648.662296819577;9572.808543829084;9645.42127472354;9690.12788849007;9717.46553939533;9749.951250243703;31498.842505787554;38437.61562384368;38741;38772.41841372382;38856.834294971195;3366.545516355285;3407.097119263397;3470;3538.663826936437;3728.6084961079237;23725.762742372528;28237.85881070602;28267.872167761045;29839;29864.55203171954;2751.435955629111;2802.8038037337396;2815.619891314667;2832.2211391867195;2857.3713782967716;500153;502709;503264;506995;507440;53853.73073134688;58080.999999999156;61723.765524690156;69220.96168557476;69300.6534967332;52909.47090529045;57101;61447.69276153591;63104;65029.67485162544;16553.586160346087;16628.33486660544;16698;16721.581960451087;16766.83233167677;12496.375181240901;12592.559260425842;12645.988320934488;12675.17611355259;12687.984961203081;17247.396341128002;18257.726134107997;21731.348059558237;21799.67300490494;21856.562868742538;9068;9300.069993000645;9309.53452327381;9334.25325973934;9353.579088941015;798.7204478432618;936.7377134402378;959.827231098409;970.4322971061866;1079.838024296346;28009;28116;28338.858305708753;28558.571621425694;28655.283617909303;1034.5189486888482;1114.3926560024806;1127.2053202492223;1151.1481503687212;1193.3496244546743;13177.748113929161;13196.340182990813;14440.205788681513;14855.70288594222;14968.70062598742;535668;537028;676909;677598;680617;58942.11586826115;58976;58979;59245.40754592399;59395.109073363936;1137.2380505061628;1251.5431867368345;1343.0525737680207;1357.7556039912713;1461.919594422317;25332.873335633205;29068.854655726587;29346.119616411543;29533.966311179007;29723.256918577208;40166.799166003984;49440.50559494359;49818;49972.50027499678;50080;509563;513572;514341;515532;678401;36211.45682814707;42163.578364215966;43621;44421.77789111034;44768.81781782258;44513.332300016176;44846.3273050898;45440;45625.8593535151;45923.77038114788;36605;37574.248515029;37802;38212;38524.8442546724;36531;36736.448953266256;37491;37623.623763762014;37731.24537509289;36452.81773591115;37435.6256437443;37597.06007349838;37651.246975060894;37828.43257351197;27296.181114566596;31513.842430788616;33410.49884251689;33609.655613775176;33784;25378;25495.23514294574;25520.361990950376;25588.765859055104;25643.487130257665 14:33:47 INFO - PROCESS | 1677 | |2;jquery.html;359.277851518448;360.4305197787496;360.9440536716809;362.86755334302984;364.4642375707709;13953.720925581481;18797.436076917682;19464.610707785854;19670.21319147236;20382;19096.236150553963;19200.943948082884;19391.903040484776;19585;19626;5465.316835395575;5622.803201887935;5716.342620598622;5757.251557297545;5761.395053519383;5554.750036248379;5739.426057394248;5739.942600573982;5744.253247077874;5751.7699292028265;3809.466674665549;5696.601237913348;5700.543956483492;5855.209546711203;6115.419035191672;5578.9163162552595;6035.426634469718;6055.606385584967;6095.939040609604;6109;4845.610444072782;5603.719814009283;5606.187102870102;5612.07400778871;5632.662040277596;13099.279539625317;13228.801567976489;13230.603081907559;13239.20564766117;13418.859396951271;2056.0953180600486;2110.2086717480943;2114.312848324301;2160.5138843760187;2211.8783466909313;8886.333524985588;9751.683522724412;10385.79228415435;13607.911367090608;14093.15441073539;1718.8109307976113;1760.8415242628098;1777.6533575952694;1779.0570997371415;1822.571695651521;98917.5054124732;102193;102198.48900755522;102423;104543;11086.948914450852;11257.831132533018;11341.546338146547;11346.205765596495;11457.14071444645;13425.93287033578;13544.661383465493;13649.249291289074;13651.453941842215;13683.11059781111;8427.95786021066;8455.027671817697;8527.317814574819;8554.61504232311;8562.357823163287;8538.97532296116;8584.227419532272;8611.268042216356;8685.956570217108;8708.52103134321;4402.009547851708;4425.75658338788;4449.265871131227;4466.129104824528;4537.8411755588395;1563.9296231669603;1864.3474783825552;1944.3583617406223;1971.4972681966008;1975.2000439821895;857.5840717252128;953.7377221264069;989.1048601016092;999.4103478947311;1045.0698877998586;19824.60350793005;20247;20250.797492024893;20277.087531061137;20481.38555843327;762.2758379539349;829.7178959153916;929.8372784762639;933.3886304470583;982.3025651787311;10802.51388687511;10919.454027298603;10938.781224375469;11007.284526505751;11068.667939961813;723196;735795;738348;741685;744296;106672.3999139998;107950;109144;109726.45136774264;112416.43791780989;1091.154355374591;1100.5102729285552;1101.1081024370285;1111.1666250312105;1112.3937454087543;18159.18283677264;18271.903685778896;18340.082995849887;18423.53941151482;18526.629467410847;37346.626533735405;51658;51891.96216075733;52410.73794631002;53722.656933576975;69476.6526167366;71379;72011.63994179995;72491.63754181407;73939.26060739324;7308.817279567841;7872.291493765589;7898.249666281694;7915.762527124196;7916.84166316682;11449.885501145216;11769.823452648046;11902.821457677968;12098.710206515996;12294.385280735749;7863.410244231591;9740.512974351112;9865.210783137476;10152.39085654863;10575.947120264349;10235.7441063974;10313.329633573794;10317.587296508056;10582.947085264525;10871.239013268996;10554.577816887238;10686.412247326161;10745.946270268598;10794.136469082612;10796.244262901522;7413.989971702371;7603.239676032353;7781.766547003599;7805.14143444232;7832.490888092256;8022;10585.629502967358;10693.839592405964;10753.892461075602;10804 14:33:47 INFO - PROCESS | 1677 | |3;mootools.html;1364.6110858405352;1536.1090567470867;1724.3361305897233;1859.4793457831795;1902.1250224896546;7967.402444816633;8631.870521942175;8725.301975841934;8908.599113039905;8939.374243802937;7161.749338773144;7190.424766018719;8854.203121719043;8857.51283679399;8868.625363068735;2497.7002759668867;2505.6742623458927;2509.5482813093636;2521.936951576216;2526.077981536735;2063.659496183128;2453.889574969122;2498.462830491444;2508.39798448372;2508.849469031855;2124.808767210951;2141.6038032963875;2196.890155492219;2239.787220214077;2404.2787163850776;2428.259380888828;2445.6698345723366;2484.763947424992;2489.514544663791;2495.263897150336;2435.8416702914255;2453.6319552067334;2476.925692229236;2479.3677612208953;2481.2184161988916;7670.695981683128;8554.914450855475;8637.136286371375;8661.090585488559;8681;4570.908581828345;4844.32179494871;5317.096093664048;5356.946430535684;5502.614816962814;3685.318216129998;3708.7774733515807;3749.7562658427387;3774.622537746231;3781.621837816224;910.2263076385086;941.270515350602;1065.0095411267519;1065.7974984752873;1101.7851518953807;9628.807423851484;12055.095867809949;12063.03495720349;12066.034717222688;12089.576864809778;4831.275308703723;4929.260610908393;4977.8302099006705;4979.925301120486;5014.997000599895;10045.648402305884;10302.845457318146;10316.071553560216;10326.535305911251;10348.965103489742;4524.9547504524535;5476.014317422902;5487.396386397493;5487.835364939058;5508.3114610673665;4619.9076018479445;4622.791974361162;4891.461939186686;4986.875328116754;5029.069622119846;3835.022069372292;3846.74996125251;3853.460515527828;3861.9613803861603;3880.359740642819;1139.7549526851767;1213.3387303919208;1216.1486959128645;1224.5958833584896;1226.1110694746417;1082.3614067700096;1090.5637744901944;1122.2144498850837;1228.2569045727207;1347.036868638928;6848.452123830081;7032.789016329519;7442.776716698508;7539.396848252236;7579.848403032019;635.7043974551856;646.890028695123;648.2447948140458;648.740503798475;789.4671097009495;6012.248468941382;6159.168512250879;6226.875462490725;6279.340669229757;6317.241930968313;10285.691429256985;10714.982076702701;10951.890481095086;11008.339499629888;11201.66395008151;10363.481825908675;10381.169506439466;10464.215183861088;10567.418791966516;10585.153187744962;8077.35381169505;8220.17798220185;8253.13342099083;8260.008798944045;8295.253427191581;8072;8093.19068093186;8108.716194933149;8148.877766833383;8157.776333550015;9297.907020929704;9304.16262536375;9586.945436001895;9612.615495380387;9627.90372096298;9589.520523973913;9877;10043.748906277402;10103.09072183507;10118.443485608363;7584.696612135453;7587.848243035219;7701.961490192737;7720.691172353043;7721.189275126031;8042.557659328793;8129.512229266263;8156.265936065783;8277.95861020691;8388.370872184732;6939.722411103499;7670.693172273047;7841.059072911287;7863.646135924012;7909.288164065261;7591.443754030521;7633.847323053619;7664.156942736406;7783.143854175923;7836.373090152888;7750.806229844299;7815.765527034198;7817.5309481431295;7822.491538050009;7828.80427989282;6911.654417279216;6970.302969702989;7022.894656580258;7094.793885039452;7104.431645468453;5954.940450595439;6022.367651396716;7141.64291785419;7314.08573928259;7323.157836848831 14:33:47 INFO - PROCESS | 1677 | |4;prototype.html;323.45497836146086;328.76657573123083;328.83065221410965;332.6307798343839;335.795164949381;5154.664946778462;5347.946520534793;5350.2777125088105;6875.521762820992;6908.378245957862;6840.076589660394;6873.690683919223;6907.929270962996;6913.585184888898;6945.548539344939;4095.8771236862794;4197.328427451608;5000.149974504343;5109.284700141983;5132.332796736419;5103.183490641498;5103.923441148368;5117.692938423706;5118.6416950813455;5143.4599367066485;4693.366395536593;4880.023995200956;4881.682690625115;4890.657653964224;4917.680350777206;4876.9268460972935;4879.682820616648;4891.241857512091;4898.118338699032;4902.994886048352;3938.074552480165;4126.195391898581;4148.066684995882;4150.83396664133;4157.189348077126;5258;6322.936770632326;6615.669216539154;6628.5691430056895;6635.469162466991;5870.412958704138;5951.22634057574;5963.344032156503;5967.49276311514;5973.671448070354;5709.74306156224;6116.785912493041;6693.196816382017;7373.963130184368;7508.849823003564;4643.6517261205545;4789.425268967711;4851.854444366674;4861.440934292566;4902.436219834729;7813.101493328227;7892.131865494791;7895.289423951815;7901.170377110436;7922.920770792333;4975.577075948512;4982.227754698028;4992.850214493571;5000.074986127505;5001.7499125043605;3925.9607403926166;5096.006278775677;5102.668326558762;5107.284980102789;5111.233315002779;5987.461128498456;6001.12983617373;6002.639841609517;6014.398560144038;6019.4883434908525;7468;7478.177400485943;7488.9625551871895;7503.699852005859;7517.301686445971;1528.4115615488117;1747.2923465996291;1765.5850875044355;1768.0717623247897;1770.1060964213248;1103.4372470040337;1106.9723256918642;1132.230083543182;1147.4778975566098;1150.4017910686396;6775.864482710417;6795;6820.556663816936;6824.624645644537;6894.24163342032;6886.655667216619;7690.807729806799;7703.653335599912;7710.074791025113;7722.92277077222;5836;6238.500919926395;6476.935230647728;6777.525573209828;6836.863262734817;4049.4128351388886;4071.267171909085;4083;4089.20260549196;4106.815193316308;7970.242826931432;7975.2423519765525;7980.4812687175145;8007.639656215484;8022.237887400687;6212.378762123842;7939.722109726132;7954.284114429729;8090.029196496458;8126.2686358226865;8130.59347032646;8134.877976830352;8148.633311500997;8166.183381661786;8167;7486.5508069516;7673.577953212627;7803.336716379172;7807.921920780719;7883.369330453665;7687.923120768721;7702.845943081219;7717.845643087219;7718.305352518076;7742.7677169685;7813.3749300057;8137;8153.062397824327;8156.959215203886;8161.224683655043;3870.9419358710206;4790.95209047919;4797.928031079467;4824.396950381202;4824.541668541483;7821.569813660303;7822.491538050009;7824.452288339761;7828.80427989282;7857.253560911704;7254.056972593529;7513.8497230054;7525.623718814147;7566.470347075652;7584.241575842371;6462.870742585216;7502.774916752506;7506.587137707478;7538.434617403607;7544.547327160388;7305.634718264172;7321.487495875238;7326.084239470067;7335.77992660221;7341.632918353954;7267.7819665410125;7462.10454745434;7480.139783924918;7488.850222995618;7496.887546686695;7172.601342738325;7290.9635451822405;7314.6708398121145;7317.707291708272;7329 14:33:47 INFO - PROCESS | 1677 | |5;yui.html;601.4351075338183;648.7340190521884;681.1281559603707;702.395939492037;743.8995735575695;14646.34091465884;14748.557543273719;14883.702325953474;14922;14924.4776432825;13519.864801351983;13546.932265338684;13552.119112257697;13579;13588.456461741518;665.314725832391;816.930560902324;829.261956858395;848.2323497235012;849.647396330522;832.5046597274612;836.2390224895346;838.4927119092953;842.9367797415188;843.0473564871686;894.2398960883262;897.7890195803981;898.191627535217;899.2626046641757;899.9910000899972;873.1268731268731;874.2175752701329;886.9512176830304;888.9599968001423;890.1187824054205;652.1131261484378;654.9639769812659;658.4008552217459;660.2769966886252;660.6465540935625;14471.565853024425;14534.781978270334;14618.195999220039;14703.97072204946;14721.190334531597;10357.964203579657;11101.666949991513;12506.562270320586;12565;12932.612021639367;8327.249067493136;10158.492075396201;10214.08073273409;10240.74398140045;10372.688819335432;2971.272038350596;3456.343294773985;3561.2521370511963;3577.8550863723617;3692.1877187018813;50481.999999999636;83924.90187745355;84161.73757393644;84425;85170.29659406777;8173.591320433955;8921;9255.583498742573;9357.877054753337;9546.42721436716;20967;21028.89485552593;21255.0435230415;21275.574488510145;21362.679559806616;7355.301246381585;7459.552426854406;7555.886661700079;7654.961725191339;7786.454948153688;3403.761736678409;4155.91688166235;4163.7293575917465;4196.475440569929;4202.768847713344;3504.789712617251;3550.5916819565564;3577.5349204603235;3589.5513060867393;3591.4612808078473;656.7077650445601;661.5435349608755;672.6838385958591;677.0893148714971;677.116363146099;570.7089384413979;577.9683265371292;600.2376981233808;626.4706323156925;635.675805339271;8248.628811703487;8473.788155296044;8519.148085191431;8578;8627.956860215785;493.44980346912934;515.3274976156152;571.0577547047405;603.8912995660735;622.9314775374705;3775.5846856845724;3777.0295548073327;3876.2247550490015;4041.8383264669674;4105.630493255561;88091;88497.67253491202;89020.10979890247;89155.55422222847;89223;76485.6175719129;77246;77537;77700;78332;70506.64746676336;70820;70879;70885.58228835497;71228;8126.36350475017;8198.713045043394;8201.13888041747;8353;8392.74963554149;48639;48966.51033489762;49481;50748;51362.74318628533;65787;70098;70364;70602.64698676474;70901;9926.428582073566;9947.433871215588;10029.04724051214;10105.090541851268;10362.533685983997;11026.558937642405;11039.006489415991;11410.885891140982;11879.465424055765;12016.699582510508;10371.325863818827;10601.787964240826;10791;10791.676249712522;10959.06847917936;8259.83480330402;10168.186545076524;10402.635907743193;10756.946215269187;10762.623308184176;8372.581370931552;9681.854772178282;9702.75743106428;10286.228532859916;10522.736931576772;8604.698835540727;8881.339480708659;8881.467111973303;8914;9041.50271735061;6412.61524308543;8603.483790972561;9095.317851161057;9171;9181.908180918106 14:33:47 INFO - PROCESS | 1677 | __end_tp_report 14:33:47 INFO - PROCESS | 1677 | __start_cc_report 14:33:47 INFO - PROCESS | 1677 | _x_x_mozilla_cycle_collect,375 14:33:47 INFO - PROCESS | 1677 | __end_cc_report 14:33:47 INFO - PROCESS | 1677 | __startTimestamp1454970827381__endTimestamp 14:33:47 INFO - PROCESS | 1677 | 14:33:47 INFO - PROCESS | 1677 | ------- Summary: start ------- 14:33:47 INFO - PROCESS | 1677 | Number of tests: 6 14:33:47 INFO - PROCESS | 1677 | 14:33:47 INFO - PROCESS | 1677 | [#0] dojo.html Cycles:165 Average:5760.42 Median:6046.37 stddev:675.72 (11.2%) stddev-sans-first:654.50 14:33:47 INFO - PROCESS | 1677 | Values: 3518.3 3587.6 3618.1 3637.1 3643.4 5689.2 5734.5 5813.8 5837.0 5865.6 5711.7 5843.4 5847.0 5848.2 5856.4 5194.5 5241.2 5252.9 5285.9 5314.3 5154.3 5252.6 5290.9 5331.6 5355.2 5130.8 5162.7 5241.3 5247.9 5281.2 5204.8 5225.8 5250.8 5270.4 5274.6 5077.1 5187.4 5218.4 5223.0 5239.6 5563.2 5732.1 5732.7 5742.9 5771.5 6287.0 6304.5 6319.2 6332.8 6337.4 5215.5 5698.8 6254.2 6311.9 6323.9 5943.0 5948.1 5951.6 5951.8 6008.9 6215.8 6327.7 6379.6 6398.0 6401.4 4867.9 6139.8 6150.3 6217.9 6218.4 6275.7 6296.3 6325.0 6342.8 6432.7 5475.9 6161.0 6270.5 6271.0 6300.8 4710.3 6149.3 6192.4 6267.9 6304.8 4307.3 4813.9 4956.7 4984.3 5003.4 3818.5 3867.2 4312.1 4391.5 4469.9 5812.2 5848.9 5887.9 5894.4 5966.7 6190.6 6262.8 6296.5 6306.4 6314.7 4672.9 5850.7 5854.1 5856.6 5890.7 5449.9 5467.6 5474.5 5478.0 5478.7 6272.9 6348.7 6399.8 6414.4 6420.4 6265.1 6284.7 6305.3 6305.7 6307.3 6278.2 6421.7 6428.5 6429.4 6462.2 6197.2 6247.7 6268.4 6270.4 6278.1 6237.5 6262.5 6265.6 6265.7 6277.5 4681.4 6105.4 6141.1 6174.5 6228.6 6177.7 6200.7 6211.1 6215.3 6226.4 5428.6 6095.1 6113.3 6117.4 6122.5 6089.3 6126.8 6210.7 6234.3 6246.8 6046.4 6048.0 6104.0 6112.5 6131.7 14:33:47 INFO - PROCESS | 1677 | 14:33:47 INFO - PROCESS | 1677 | [#1] ext.html Cycles:180 Average:69095.34 Median:38756.71 stddev:150205.38 (387.6%) stddev-sans-first:150538.33 14:33:47 INFO - PROCESS | 1677 | Values: 454.7 455.3 559.0 567.0 598.8 37591.8 37919.0 37938.4 37981.4 38213.8 38626.0 39265.8 39430.6 39674.8 40008.0 8714.2 8861.3 8888.5 8901.3 8902.9 8005.4 9314.3 9368.1 9506.7 9523.4 8063.5 8083.7 9445.6 9470.1 9539.0 9476.7 9591.7 9625.7 9643.6 9648.7 9572.8 9645.4 9690.1 9717.5 9750.0 31498.8 38437.6 38741.0 38772.4 38856.8 3366.5 3407.1 3470.0 3538.7 3728.6 23725.8 28237.9 28267.9 29839.0 29864.6 2751.4 2802.8 2815.6 2832.2 2857.4 500153.0 502709.0 503264.0 506995.0 507440.0 53853.7 58081.0 61723.8 69221.0 69300.7 52909.5 57101.0 61447.7 63104.0 65029.7 16553.6 16628.3 16698.0 16721.6 16766.8 12496.4 12592.6 12646.0 12675.2 12688.0 17247.4 18257.7 21731.3 21799.7 21856.6 9068.0 9300.1 9309.5 9334.3 9353.6 798.7 936.7 959.8 970.4 1079.8 28009.0 28116.0 28338.9 28558.6 28655.3 1034.5 1114.4 1127.2 1151.1 1193.3 13177.7 13196.3 14440.2 14855.7 14968.7 535668.0 537028.0 676909.0 677598.0 680617.0 58942.1 58976.0 58979.0 59245.4 59395.1 1137.2 1251.5 1343.1 1357.8 1461.9 25332.9 29068.9 29346.1 29534.0 29723.3 40166.8 49440.5 49818.0 49972.5 50080.0 509563.0 513572.0 514341.0 515532.0 678401.0 36211.5 42163.6 43621.0 44421.8 44768.8 44513.3 44846.3 45440.0 45625.9 45923.8 36605.0 37574.2 37802.0 38212.0 38524.8 36531.0 36736.4 37491.0 37623.6 37731.2 36452.8 37435.6 37597.1 37651.2 37828.4 27296.2 31513.8 33410.5 33609.7 33784.0 25378.0 25495.2 25520.4 25588.8 25643.5 14:33:47 INFO - PROCESS | 1677 | 14:33:47 INFO - PROCESS | 1677 | [#2] jquery.html Cycles:180 Average:37035.14 Median:2112.26 stddev:121279.23 (5741.7%) stddev-sans-first:121588.18 14:33:47 INFO - PROCESS | 1677 | Values: 359.3 360.4 360.9 362.9 364.5 13953.7 18797.4 19464.6 19670.2 20382.0 19096.2 19200.9 19391.9 19585.0 19626.0 5465.3 5622.8 5716.3 5757.3 5761.4 5554.8 5739.4 5739.9 5744.3 5751.8 3809.5 5696.6 5700.5 5855.2 6115.4 5578.9 6035.4 6055.6 6095.9 6109.0 4845.6 5603.7 5606.2 5612.1 5632.7 13099.3 13228.8 13230.6 13239.2 13418.9 2056.1 2110.2 2114.3 2160.5 2211.9 8886.3 9751.7 10385.8 13607.9 14093.2 1718.8 1760.8 1777.7 1779.1 1822.6 98917.5 102193.0 102198.5 102423.0 104543.0 11086.9 11257.8 11341.5 11346.2 11457.1 13425.9 13544.7 13649.2 13651.5 13683.1 8428.0 8455.0 8527.3 8554.6 8562.4 8539.0 8584.2 8611.3 8686.0 8708.5 4402.0 4425.8 4449.3 4466.1 4537.8 1563.9 1864.3 1944.4 1971.5 1975.2 857.6 953.7 989.1 999.4 1045.1 19824.6 20247.0 20250.8 20277.1 20481.4 762.3 829.7 929.8 933.4 982.3 10802.5 10919.5 10938.8 11007.3 11068.7 723196.0 735795.0 738348.0 741685.0 744296.0 106672.4 107950.0 109144.0 109726.5 112416.4 1091.2 1100.5 1101.1 1111.2 1112.4 18159.2 18271.9 18340.1 18423.5 18526.6 37346.6 51658.0 51892.0 52410.7 53722.7 69476.7 71379.0 72011.6 72491.6 73939.3 7308.8 7872.3 7898.2 7915.8 7916.8 11449.9 11769.8 11902.8 12098.7 12294.4 7863.4 9740.5 9865.2 10152.4 10575.9 10235.7 10313.3 10317.6 10582.9 10871.2 10554.6 10686.4 10745.9 10794.1 10796.2 7414.0 7603.2 7781.8 7805.1 7832.5 8022.0 10585.6 10693.8 10753.9 10804.0 14:33:47 INFO - PROCESS | 1677 | 14:33:47 INFO - PROCESS | 1677 | [#3] mootools.html Cycles:180 Average:6001.90 Median:5481.71 stddev:3199.24 (58.4%) stddev-sans-first:3189.23 14:33:47 INFO - PROCESS | 1677 | Values: 1364.6 1536.1 1724.3 1859.5 1902.1 7967.4 8631.9 8725.3 8908.6 8939.4 7161.7 7190.4 8854.2 8857.5 8868.6 2497.7 2505.7 2509.5 2521.9 2526.1 2063.7 2453.9 2498.5 2508.4 2508.8 2124.8 2141.6 2196.9 2239.8 2404.3 2428.3 2445.7 2484.8 2489.5 2495.3 2435.8 2453.6 2476.9 2479.4 2481.2 7670.7 8554.9 8637.1 8661.1 8681.0 4570.9 4844.3 5317.1 5356.9 5502.6 3685.3 3708.8 3749.8 3774.6 3781.6 910.2 941.3 1065.0 1065.8 1101.8 9628.8 12055.1 12063.0 12066.0 12089.6 4831.3 4929.3 4977.8 4979.9 5015.0 10045.6 10302.8 10316.1 10326.5 10349.0 4525.0 5476.0 5487.4 5487.8 5508.3 4619.9 4622.8 4891.5 4986.9 5029.1 3835.0 3846.7 3853.5 3862.0 3880.4 1139.8 1213.3 1216.1 1224.6 1226.1 1082.4 1090.6 1122.2 1228.3 1347.0 6848.5 7032.8 7442.8 7539.4 7579.8 635.7 646.9 648.2 648.7 789.5 6012.2 6159.2 6226.9 6279.3 6317.2 10285.7 10715.0 10951.9 11008.3 11201.7 10363.5 10381.2 10464.2 10567.4 10585.2 8077.4 8220.2 8253.1 8260.0 8295.3 8072.0 8093.2 8108.7 8148.9 8157.8 9297.9 9304.2 9586.9 9612.6 9627.9 9589.5 9877.0 10043.7 10103.1 10118.4 7584.7 7587.8 7702.0 7720.7 7721.2 8042.6 8129.5 8156.3 8278.0 8388.4 6939.7 7670.7 7841.1 7863.6 7909.3 7591.4 7633.8 7664.2 7783.1 7836.4 7750.8 7815.8 7817.5 7822.5 7828.8 6911.7 6970.3 7022.9 7094.8 7104.4 5954.9 6022.4 7141.6 7314.1 7323.2 14:33:47 INFO - PROCESS | 1677 | 14:33:47 INFO - PROCESS | 1677 | [#4] prototype.html Cycles:180 Average:6004.21 Median:6734.53 stddev:1977.13 (29.4%) stddev-sans-first:1936.15 14:33:47 INFO - PROCESS | 1677 | Values: 323.5 328.8 328.8 332.6 335.8 5154.7 5347.9 5350.3 6875.5 6908.4 6840.1 6873.7 6907.9 6913.6 6945.5 4095.9 4197.3 5000.1 5109.3 5132.3 5103.2 5103.9 5117.7 5118.6 5143.5 4693.4 4880.0 4881.7 4890.7 4917.7 4876.9 4879.7 4891.2 4898.1 4903.0 3938.1 4126.2 4148.1 4150.8 4157.2 5258.0 6322.9 6615.7 6628.6 6635.5 5870.4 5951.2 5963.3 5967.5 5973.7 5709.7 6116.8 6693.2 7374.0 7508.8 4643.7 4789.4 4851.9 4861.4 4902.4 7813.1 7892.1 7895.3 7901.2 7922.9 4975.6 4982.2 4992.9 5000.1 5001.7 3926.0 5096.0 5102.7 5107.3 5111.2 5987.5 6001.1 6002.6 6014.4 6019.5 7468.0 7478.2 7489.0 7503.7 7517.3 1528.4 1747.3 1765.6 1768.1 1770.1 1103.4 1107.0 1132.2 1147.5 1150.4 6775.9 6795.0 6820.6 6824.6 6894.2 6886.7 7690.8 7703.7 7710.1 7722.9 5836.0 6238.5 6476.9 6777.5 6836.9 4049.4 4071.3 4083.0 4089.2 4106.8 7970.2 7975.2 7980.5 8007.6 8022.2 6212.4 7939.7 7954.3 8090.0 8126.3 8130.6 8134.9 8148.6 8166.2 8167.0 7486.6 7673.6 7803.3 7807.9 7883.4 7687.9 7702.8 7717.8 7718.3 7742.8 7813.4 8137.0 8153.1 8157.0 8161.2 3870.9 4791.0 4797.9 4824.4 4824.5 7821.6 7822.5 7824.5 7828.8 7857.3 7254.1 7513.8 7525.6 7566.5 7584.2 6462.9 7502.8 7506.6 7538.4 7544.5 7305.6 7321.5 7326.1 7335.8 7341.6 7267.8 7462.1 7480.1 7488.9 7496.9 7172.6 7291.0 7314.7 7317.7 7329.0 14:33:47 INFO - PROCESS | 1677 | 14:33:47 INFO - PROCESS | 1677 | [#5] yui.html Cycles:180 Average:17898.89 Median:33222.70 stddev:25486.88 (76.7%) stddev-sans-first:25525.28 14:33:47 INFO - PROCESS | 1677 | Values: 601.4 648.7 681.1 702.4 743.9 14646.3 14748.6 14883.7 14922.0 14924.5 13519.9 13546.9 13552.1 13579.0 13588.5 665.3 816.9 829.3 848.2 849.6 832.5 836.2 838.5 842.9 843.0 894.2 897.8 898.2 899.3 900.0 873.1 874.2 887.0 889.0 890.1 652.1 655.0 658.4 660.3 660.6 14471.6 14534.8 14618.2 14704.0 14721.2 10358.0 11101.7 12506.6 12565.0 12932.6 8327.2 10158.5 10214.1 10240.7 10372.7 2971.3 3456.3 3561.3 3577.9 3692.2 50482.0 83924.9 84161.7 84425.0 85170.3 8173.6 8921.0 9255.6 9357.9 9546.4 20967.0 21028.9 21255.0 21275.6 21362.7 7355.3 7459.6 7555.9 7655.0 7786.5 3403.8 4155.9 4163.7 4196.5 4202.8 3504.8 3550.6 3577.5 3589.6 3591.5 656.7 661.5 672.7 677.1 677.1 570.7 578.0 600.2 626.5 635.7 8248.6 8473.8 8519.1 8578.0 8628.0 493.4 515.3 571.1 603.9 622.9 3775.6 3777.0 3876.2 4041.8 4105.6 88091.0 88497.7 89020.1 89155.6 89223.0 76485.6 77246.0 77537.0 77700.0 78332.0 70506.6 70820.0 70879.0 70885.6 71228.0 8126.4 8198.7 8201.1 8353.0 8392.7 48639.0 48966.5 49481.0 50748.0 51362.7 65787.0 70098.0 70364.0 70602.6 70901.0 9926.4 9947.4 10029.0 10105.1 10362.5 11026.6 11039.0 11410.9 11879.5 12016.7 10371.3 10601.8 10791.0 10791.7 10959.1 8259.8 10168.2 10402.6 10756.9 10762.6 8372.6 9681.9 9702.8 10286.2 10522.7 8604.7 8881.3 8881.5 8914.0 9041.5 6412.6 8603.5 9095.3 9171.0 9181.9 14:33:47 INFO - PROCESS | 1677 | -------- Summary: end -------- 14:33:47 INFO - PROCESS | 1677 | 14:33:47 INFO - TEST-INFO | 1677: exit 0 14:33:47 INFO - TEST-OK | dromaeo_css | took 1111393ms 14:33:47 INFO - TEST-START | kraken 14:33:47 INFO - operating with platform_type : mac_ 14:33:47 INFO - Initialising browser for kraken test... 14:33:47 INFO - TEST-INFO | started process 1690 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/tmp6yCj2j/profile http://localhost:49274/getInfo.html) 14:33:50 INFO - PROCESS | 1690 | __metrics Screen width/height:1600/1200 14:33:50 INFO - PROCESS | 1690 | colorDepth:24 14:33:50 INFO - PROCESS | 1690 | Browser inner width/height: 1024/689 14:33:50 INFO - PROCESS | 1690 | __metrics 14:33:50 INFO - PROCESS | 1690 | 14:33:50 INFO - PROCESS | 1690 | ###!!! [Child][MessageChannel] Error: (msgtype=0x2A0045,name=PBrowser::Msg___delete__) Channel closing: too late to send/recv, messages will be lost 14:33:50 INFO - PROCESS | 1690 | 14:33:51 INFO - TEST-INFO | 1690: exit 0 14:33:51 INFO - Browser initialized. 14:33:51 INFO - Running cycle 1/1 for kraken test... 14:33:51 INFO - TEST-INFO | started process 1693 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/tmp6yCj2j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:34:03 INFO - PROCESS | 1693 | RSS: Main: 259235840 14:34:03 INFO - PROCESS | 1693 | 14:34:06 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 14:34:06 INFO - PROCESS | 1693 | RSS: Main: 271470592 14:34:06 INFO - PROCESS | 1693 | 14:34:09 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 14:34:10 INFO - PROCESS | 1693 | RSS: Main: 279150592 14:34:10 INFO - PROCESS | 1693 | 14:34:13 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 14:34:14 INFO - PROCESS | 1693 | RSS: Main: 283152384 14:34:14 INFO - PROCESS | 1693 | 14:34:16 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 14:34:16 INFO - PROCESS | 1693 | RSS: Main: 285274112 14:34:16 INFO - PROCESS | 1693 | 14:34:19 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:34:19 INFO - PROCESS | 1693 | RSS: Main: 286105600 14:34:19 INFO - PROCESS | 1693 | 14:34:22 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 14:34:22 INFO - PROCESS | 1693 | RSS: Main: 285650944 14:34:22 INFO - PROCESS | 1693 | 14:34:25 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 14:34:26 INFO - PROCESS | 1693 | RSS: Main: 285745152 14:34:26 INFO - PROCESS | 1693 | 14:34:29 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 14:34:29 INFO - PROCESS | 1693 | RSS: Main: 286085120 14:34:29 INFO - PROCESS | 1693 | 14:34:31 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:34:31 INFO - PROCESS | 1693 | RSS: Main: 285179904 14:34:31 INFO - PROCESS | 1693 | 14:34:33 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:34:34 INFO - PROCESS | 1693 | RSS: Main: 284717056 14:34:34 INFO - PROCESS | 1693 | 14:34:36 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:34:37 INFO - PROCESS | 1693 | RSS: Main: 285941760 14:34:37 INFO - PROCESS | 1693 | 14:34:39 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:34:40 INFO - PROCESS | 1693 | RSS: Main: 286572544 14:34:40 INFO - PROCESS | 1693 | 14:34:43 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:34:43 INFO - PROCESS | 1693 | RSS: Main: 285761536 14:34:43 INFO - PROCESS | 1693 | 14:34:45 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 14:34:45 INFO - PROCESS | 1693 | RSS: Main: 286425088 14:34:45 INFO - PROCESS | 1693 | 14:34:45 INFO - PROCESS | 1693 | __start_tp_report 14:34:45 INFO - PROCESS | 1693 | _x_x_mozilla_page_load 14:34:45 INFO - PROCESS | 1693 | _x_x_mozilla_page_load_details 14:34:45 INFO - PROCESS | 1693 | |i|pagename|runs| 14:34:45 INFO - PROCESS | 1693 | |0;ai-astar;115;110;127;167;126;138;170;162;114;114 14:34:45 INFO - PROCESS | 1693 | |1;audio-beat-detection;159;121;159;158;138;141;126;175;176;157 14:34:45 INFO - PROCESS | 1693 | |2;audio-dft;226;282;211;223;201;199;202;202;198;196 14:34:45 INFO - PROCESS | 1693 | |3;audio-fft;71;78;71;108;61;83;89;86;142;56 14:34:45 INFO - PROCESS | 1693 | |4;audio-oscillator;83;88;160;107;119;81;118;120;121;146 14:34:45 INFO - PROCESS | 1693 | |5;imaging-gaussian-blur;89;95;90;96;90;95;87;94;88;95 14:34:45 INFO - PROCESS | 1693 | |6;imaging-darkroom;101;154;98;97;96;97;98;97;98;98 14:34:45 INFO - PROCESS | 1693 | |7;imaging-desaturate;91;94;92;96;95;91;93;94;92;91 14:34:45 INFO - PROCESS | 1693 | |8;json-parse-financial;58;58;59;55;57;59;57;65;58;56 14:34:45 INFO - PROCESS | 1693 | |9;json-stringify-tinderbox;66;67;74;70;76;98;59;90;106;106 14:34:45 INFO - PROCESS | 1693 | |10;stanford-crypto-aes;87;95;86;85;85;85;86;83;89;89 14:34:45 INFO - PROCESS | 1693 | |11;stanford-crypto-ccm;141;136;133;136;120;124;125;132;145;121 14:34:45 INFO - PROCESS | 1693 | |12;stanford-crypto-pbkdf2;131;174;185;183;147;131;142;129;186;184 14:34:45 INFO - PROCESS | 1693 | |13;stanford-crypto-sha256-iterative;68;66;69;66;68;67;91;105;105;101 14:34:45 INFO - PROCESS | 1693 | __end_tp_report 14:34:45 INFO - PROCESS | 1693 | __start_cc_report 14:34:45 INFO - PROCESS | 1693 | _x_x_mozilla_cycle_collect,936 14:34:45 INFO - PROCESS | 1693 | __end_cc_report 14:34:45 INFO - PROCESS | 1693 | __startTimestamp1454970885883__endTimestamp 14:34:45 INFO - PROCESS | 1693 | 14:34:45 INFO - PROCESS | 1693 | ------- Summary: start ------- 14:34:45 INFO - PROCESS | 1693 | Number of tests: 14 14:34:45 INFO - PROCESS | 1693 | 14:34:45 INFO - PROCESS | 1693 | [#0] ai-astar Cycles:10 Average:134.30 Median:132.50 stddev:23.65 (17.8%) stddev-sans-first:24.03 14:34:45 INFO - PROCESS | 1693 | Values: 115.0 110.0 127.0 167.0 126.0 138.0 170.0 162.0 114.0 114.0 14:34:45 INFO - PROCESS | 1693 | 14:34:45 INFO - PROCESS | 1693 | [#1] audio-beat-detection Cycles:10 Average:151.00 Median:158.50 stddev:18.88 (11.9%) stddev-sans-first:19.80 14:34:45 INFO - PROCESS | 1693 | Values: 159.0 121.0 159.0 158.0 138.0 141.0 126.0 175.0 176.0 157.0 14:34:45 INFO - PROCESS | 1693 | 14:34:45 INFO - PROCESS | 1693 | [#2] audio-dft Cycles:10 Average:214.00 Median:206.50 stddev:26.08 (12.6%) stddev-sans-first:27.29 14:34:45 INFO - PROCESS | 1693 | Values: 226.0 282.0 211.0 223.0 201.0 199.0 202.0 202.0 198.0 196.0 14:34:45 INFO - PROCESS | 1693 | 14:34:45 INFO - PROCESS | 1693 | [#3] audio-fft Cycles:10 Average:84.50 Median:74.50 stddev:25.07 (33.6%) stddev-sans-first:26.11 14:34:45 INFO - PROCESS | 1693 | Values: 71.0 78.0 71.0 108.0 61.0 83.0 89.0 86.0 142.0 56.0 14:34:45 INFO - PROCESS | 1693 | 14:34:45 INFO - PROCESS | 1693 | [#4] audio-oscillator Cycles:10 Average:114.30 Median:153.00 stddev:25.91 (16.9%) stddev-sans-first:24.88 14:34:45 INFO - PROCESS | 1693 | Values: 83.0 88.0 160.0 107.0 119.0 81.0 118.0 120.0 121.0 146.0 14:34:45 INFO - PROCESS | 1693 | 14:34:45 INFO - PROCESS | 1693 | [#5] imaging-gaussian-blur Cycles:10 Average:91.90 Median:94.50 stddev:3.41 (3.6%) stddev-sans-first:3.46 14:34:45 INFO - PROCESS | 1693 | Values: 89.0 95.0 90.0 96.0 90.0 95.0 87.0 94.0 88.0 95.0 14:34:45 INFO - PROCESS | 1693 | 14:34:45 INFO - PROCESS | 1693 | [#6] imaging-darkroom Cycles:10 Average:103.40 Median:97.50 stddev:17.83 (18.3%) stddev-sans-first:18.89 14:34:45 INFO - PROCESS | 1693 | Values: 101.0 154.0 98.0 97.0 96.0 97.0 98.0 97.0 98.0 98.0 14:34:45 INFO - PROCESS | 1693 | 14:34:45 INFO - PROCESS | 1693 | [#7] imaging-desaturate Cycles:10 Average:92.90 Median:93.50 stddev:1.79 (1.9%) stddev-sans-first:1.76 14:34:45 INFO - PROCESS | 1693 | Values: 91.0 94.0 92.0 96.0 95.0 91.0 93.0 94.0 92.0 91.0 14:34:45 INFO - PROCESS | 1693 | 14:34:45 INFO - PROCESS | 1693 | [#8] json-parse-financial Cycles:10 Average:58.20 Median:58.00 stddev:2.70 (4.7%) stddev-sans-first:2.86 14:34:45 INFO - PROCESS | 1693 | Values: 58.0 58.0 59.0 55.0 57.0 59.0 57.0 65.0 58.0 56.0 14:34:45 INFO - PROCESS | 1693 | 14:34:45 INFO - PROCESS | 1693 | [#9] json-stringify-tinderbox Cycles:10 Average:81.20 Median:72.00 stddev:17.38 (24.1%) stddev-sans-first:17.55 14:34:45 INFO - PROCESS | 1693 | Values: 66.0 67.0 74.0 70.0 76.0 98.0 59.0 90.0 106.0 106.0 14:34:45 INFO - PROCESS | 1693 | 14:34:45 INFO - PROCESS | 1693 | [#10] stanford-crypto-aes Cycles:10 Average:87.00 Median:86.50 stddev:3.37 (3.9%) stddev-sans-first:3.57 14:34:45 INFO - PROCESS | 1693 | Values: 87.0 95.0 86.0 85.0 85.0 85.0 86.0 83.0 89.0 89.0 14:34:45 INFO - PROCESS | 1693 | 14:34:45 INFO - PROCESS | 1693 | [#11] stanford-crypto-ccm Cycles:10 Average:131.30 Median:134.50 stddev:8.54 (6.3%) stddev-sans-first:8.30 14:34:45 INFO - PROCESS | 1693 | Values: 141.0 136.0 133.0 136.0 120.0 124.0 125.0 132.0 145.0 121.0 14:34:45 INFO - PROCESS | 1693 | 14:34:45 INFO - PROCESS | 1693 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.20 Median:178.50 stddev:25.24 (14.1%) stddev-sans-first:24.62 14:34:45 INFO - PROCESS | 1693 | Values: 131.0 174.0 185.0 183.0 147.0 131.0 142.0 129.0 186.0 184.0 14:34:45 INFO - PROCESS | 1693 | 14:34:45 INFO - PROCESS | 1693 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:80.60 Median:67.50 stddev:17.57 (26.0%) stddev-sans-first:18.03 14:34:45 INFO - PROCESS | 1693 | Values: 68.0 66.0 69.0 66.0 68.0 67.0 91.0 105.0 105.0 101.0 14:34:45 INFO - PROCESS | 1693 | -------- Summary: end -------- 14:34:45 INFO - PROCESS | 1693 | 14:34:46 INFO - TEST-INFO | 1693: exit 0 14:34:46 INFO - TEST-OK | kraken | took 58740ms 14:34:46 INFO - SUITE-END | took 1170s 14:34:47 INFO - Completed test suite (00:19:30) 14:34:47 INFO - Working with test: dromaeo_css 14:34:47 INFO - Generating results file: dromaeo_css 14:34:47 INFO - Working with test: kraken 14:34:47 INFO - Generating results file: kraken 14:34:47 INFO - javascript benchmark 14:34:47 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:34:47 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 14:34:47 INFO - process_Request line: dromaeo_css 7495.74 graph.html#tests=[[72,64,61]] 14:34:47 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:34:47 INFO - process_Request line: kraken 1583.80 graph.html#tests=[[232,64,61]] 14:34:47 INFO - RETURN: dromaeo_css: 7495.74 14:34:47 INFO - RETURN: kraken: 1583.80 14:34:47 INFO - javascript benchmark 14:34:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3518.3491054154983, 3587.6232995535483, 3618.077390265482, 3637.0543658648744, 3643.4352675335317, 5689.175069614904, 5734.541236701064, 5813.825585232445, 5836.970815145924, 5865.648061116325, 5711.742971566279, 5843.357230704619, 5847.0, 5848.181254624356, 5856.385079566648, 5194.454582268864, 5241.161414173733, 5252.8686782830355, 5285.947140528584, 5314.2560041594015, 5154.278401023859, 5252.6323157379, 5290.92063619046, 5331.57347412208, 5355.169948657965, 5130.820421285256, 5162.74186290684, 5241.31862857826, 5247.86880327991, 5281.155015197588, 5204.791808327663, 5225.790968361261, 5250.81622143227, 5270.420253772082, 5274.5780337572905, 5077.086124497589, 5187.403448603422, 5218.373795144569, 5223.033738758304, 5239.5546378557865, 5563.221149039097, 5732.082866741343, 5732.656040637575, 5742.885142297172, 5771.50942169916, 6286.968565157145, 6304.495640348761, 6319.178506794134, 6332.810015699536, 6337.429631333156, 5215.504527069922, 5698.831739493394, 6254.15568898202, 6311.8737625247695, 6323.873522529524, 5943.0, 5948.078047902539, 5951.642901425928, 5951.821445356646, 6008.879822403527, 6215.844603884849, 6327.651979141191, 6379.585326953733, 6398.040293955851, 6401.3598640135615, 4867.9269810952865, 6139.754409823647, 6150.323464418911, 6217.937820621736, 6218.409251121137, 6275.6862156891975, 6296.307406185316, 6324.968375158095, 6342.8414289642205, 6432.678366081677, 5475.863103422446, 6161.0, 6270.498360131179, 6271.027990661455, 6300.8424789379715, 4710.293455981561, 6149.2620885494025, 6192.442680158807, 6267.874642507124, 6304.842378940563, 4307.332363483665, 4813.879653008703, 4956.677815942025, 4984.3021976923255, 5003.449620541737, 3818.4845045919, 3867.207222519377, 4312.137572485452, 4391.538888416734, 4469.910601787946, 5812.186293918855, 5848.88302233953, 5887.882242355129, 5894.440028197314, 5966.701664916737, 6190.597611155351, 6262.780802671976, 6296.5277604178955, 6306.432421082033, 6314.652694101776, 4672.883177920511, 5850.678212698343, 5854.121881717691, 5856.590038697335, 5890.676012819336, 5449.918251226235, 5467.5625949923915, 5474.452554744574, 5477.972610136924, 5478.726063696799, 6272.905906411407, 6348.714307856158, 6399.8080057598345, 6414.390632889868, 6420.422162005442, 6265.122882796503, 6284.74861005573, 6305.337939516468, 6305.747770089145, 6307.3377295383325, 6278.215223097113, 6421.7110230038825, 6428.517861160525, 6429.421352078335, 6462.192225971754, 6197.163382943245, 6247.656378899204, 6268.404501572343, 6270.435660790551, 6278.058291256348, 6237.500999919905, 6262.4990000800735, 6265.592736472115, 6265.686715664289, 6277.466415354746, 4681.368015317888, 6105.419985101408, 6141.109539116893, 6174.536909731698, 6228.626282422888, 6177.660228687286, 6200.658963757037, 6211.130441738251, 6215.34738852414, 6226.439620434183, 5428.592855535771, 6095.1466794647895, 6113.2969708482315, 6117.449429551361, 6122.5408094392205, 6089.269287685329, 6126.792505495216, 6210.658413787285, 6234.314225435289, 6246.781362652286, 6046.365131661112, 6048.0, 6104.021790100797, 6112.541559382975, 6131.743695907123], "unit": "score", "name": "dojo.html", "value": 5720.032969829938}, {"lowerIsBetter": false, "replicates": [454.718074793628, 455.3215708594196, 558.9776408943643, 566.9879265511064, 598.8293336399125, 37591.81204093979, 37919.0, 37938.43092353617, 37981.430278545806, 38213.808930955376, 38626.0, 39265.822025339214, 39430.60569394305, 39674.80162599183, 40008.0, 8714.215720585162, 8861.291096712279, 8888.466691998468, 8901.332400069989, 8902.910970890272, 8005.399595030367, 9314.254859611216, 9368.110029547217, 9506.667266645669, 9523.380980236298, 8063.475874068166, 8083.717069902555, 9445.622175112987, 9470.147686708195, 9539.0, 9476.71569852902, 9591.712248632517, 9625.71122866315, 9643.614255429844, 9648.662296819577, 9572.808543829084, 9645.42127472354, 9690.12788849007, 9717.46553939533, 9749.951250243703, 31498.842505787554, 38437.61562384368, 38741.0, 38772.41841372382, 38856.834294971195, 3366.545516355285, 3407.097119263397, 3470.0, 3538.663826936437, 3728.6084961079237, 23725.762742372528, 28237.85881070602, 28267.872167761045, 29839.0, 29864.55203171954, 2751.435955629111, 2802.8038037337396, 2815.619891314667, 2832.2211391867195, 2857.3713782967716, 500153.0, 502709.0, 503264.0, 506995.0, 507440.0, 53853.73073134688, 58080.999999999156, 61723.765524690156, 69220.96168557476, 69300.6534967332, 52909.47090529045, 57101.0, 61447.69276153591, 63104.0, 65029.67485162544, 16553.586160346087, 16628.33486660544, 16698.0, 16721.581960451087, 16766.83233167677, 12496.375181240901, 12592.559260425842, 12645.988320934488, 12675.17611355259, 12687.984961203081, 17247.396341128002, 18257.726134107997, 21731.348059558237, 21799.67300490494, 21856.562868742538, 9068.0, 9300.069993000645, 9309.53452327381, 9334.25325973934, 9353.579088941015, 798.7204478432618, 936.7377134402378, 959.827231098409, 970.4322971061866, 1079.838024296346, 28009.0, 28116.0, 28338.858305708753, 28558.571621425694, 28655.283617909303, 1034.5189486888482, 1114.3926560024806, 1127.2053202492223, 1151.1481503687212, 1193.3496244546743, 13177.748113929161, 13196.340182990813, 14440.205788681513, 14855.70288594222, 14968.70062598742, 535668.0, 537028.0, 676909.0, 677598.0, 680617.0, 58942.11586826115, 58976.0, 58979.0, 59245.40754592399, 59395.109073363936, 1137.2380505061628, 1251.5431867368345, 1343.0525737680207, 1357.7556039912713, 1461.919594422317, 25332.873335633205, 29068.854655726587, 29346.119616411543, 29533.966311179007, 29723.256918577208, 40166.799166003984, 49440.50559494359, 49818.0, 49972.50027499678, 50080.0, 509563.0, 513572.0, 514341.0, 515532.0, 678401.0, 36211.45682814707, 42163.578364215966, 43621.0, 44421.77789111034, 44768.81781782258, 44513.332300016176, 44846.3273050898, 45440.0, 45625.8593535151, 45923.77038114788, 36605.0, 37574.248515029, 37802.0, 38212.0, 38524.8442546724, 36531.0, 36736.448953266256, 37491.0, 37623.623763762014, 37731.24537509289, 36452.81773591115, 37435.6256437443, 37597.06007349838, 37651.246975060894, 37828.43257351197, 27296.181114566596, 31513.842430788616, 33410.49884251689, 33609.655613775176, 33784.0, 25378.0, 25495.23514294574, 25520.361990950376, 25588.765859055104, 25643.487130257665], "unit": "score", "name": "ext.html", "value": 19834.52196366036}, {"lowerIsBetter": false, "replicates": [359.277851518448, 360.4305197787496, 360.9440536716809, 362.86755334302984, 364.4642375707709, 13953.720925581481, 18797.436076917682, 19464.610707785854, 19670.21319147236, 20382.0, 19096.236150553963, 19200.943948082884, 19391.903040484776, 19585.0, 19626.0, 5465.316835395575, 5622.803201887935, 5716.342620598622, 5757.251557297545, 5761.395053519383, 5554.750036248379, 5739.426057394248, 5739.942600573982, 5744.253247077874, 5751.7699292028265, 3809.466674665549, 5696.601237913348, 5700.543956483492, 5855.209546711203, 6115.419035191672, 5578.9163162552595, 6035.426634469718, 6055.606385584967, 6095.939040609604, 6109.0, 4845.610444072782, 5603.719814009283, 5606.187102870102, 5612.07400778871, 5632.662040277596, 13099.279539625317, 13228.801567976489, 13230.603081907559, 13239.20564766117, 13418.859396951271, 2056.0953180600486, 2110.2086717480943, 2114.312848324301, 2160.5138843760187, 2211.8783466909313, 8886.333524985588, 9751.683522724412, 10385.79228415435, 13607.911367090608, 14093.15441073539, 1718.8109307976113, 1760.8415242628098, 1777.6533575952694, 1779.0570997371415, 1822.571695651521, 98917.5054124732, 102193.0, 102198.48900755522, 102423.0, 104543.0, 11086.948914450852, 11257.831132533018, 11341.546338146547, 11346.205765596495, 11457.14071444645, 13425.93287033578, 13544.661383465493, 13649.249291289074, 13651.453941842215, 13683.11059781111, 8427.95786021066, 8455.027671817697, 8527.317814574819, 8554.61504232311, 8562.357823163287, 8538.97532296116, 8584.227419532272, 8611.268042216356, 8685.956570217108, 8708.52103134321, 4402.009547851708, 4425.75658338788, 4449.265871131227, 4466.129104824528, 4537.8411755588395, 1563.9296231669603, 1864.3474783825552, 1944.3583617406223, 1971.4972681966008, 1975.2000439821895, 857.5840717252128, 953.7377221264069, 989.1048601016092, 999.4103478947311, 1045.0698877998586, 19824.60350793005, 20247.0, 20250.797492024893, 20277.087531061137, 20481.38555843327, 762.2758379539349, 829.7178959153916, 929.8372784762639, 933.3886304470583, 982.3025651787311, 10802.51388687511, 10919.454027298603, 10938.781224375469, 11007.284526505751, 11068.667939961813, 723196.0, 735795.0, 738348.0, 741685.0, 744296.0, 106672.3999139998, 107950.0, 109144.0, 109726.45136774264, 112416.43791780989, 1091.154355374591, 1100.5102729285552, 1101.1081024370285, 1111.1666250312105, 1112.3937454087543, 18159.18283677264, 18271.903685778896, 18340.082995849887, 18423.53941151482, 18526.629467410847, 37346.626533735405, 51658.0, 51891.96216075733, 52410.73794631002, 53722.656933576975, 69476.6526167366, 71379.0, 72011.63994179995, 72491.63754181407, 73939.26060739324, 7308.817279567841, 7872.291493765589, 7898.249666281694, 7915.762527124196, 7916.84166316682, 11449.885501145216, 11769.823452648046, 11902.821457677968, 12098.710206515996, 12294.385280735749, 7863.410244231591, 9740.512974351112, 9865.210783137476, 10152.39085654863, 10575.947120264349, 10235.7441063974, 10313.329633573794, 10317.587296508056, 10582.947085264525, 10871.239013268996, 10554.577816887238, 10686.412247326161, 10745.946270268598, 10794.136469082612, 10796.244262901522, 7413.989971702371, 7603.239676032353, 7781.766547003599, 7805.14143444232, 7832.490888092256, 8022.0, 10585.629502967358, 10693.839592405964, 10753.892461075602, 10804.0], "unit": "score", "name": "jquery.html", "value": 9109.252104261266}, {"lowerIsBetter": false, "replicates": [1364.6110858405352, 1536.1090567470867, 1724.3361305897233, 1859.4793457831795, 1902.1250224896546, 7967.402444816633, 8631.870521942175, 8725.301975841934, 8908.599113039905, 8939.374243802937, 7161.749338773144, 7190.424766018719, 8854.203121719043, 8857.51283679399, 8868.625363068735, 2497.7002759668867, 2505.6742623458927, 2509.5482813093636, 2521.936951576216, 2526.077981536735, 2063.659496183128, 2453.889574969122, 2498.462830491444, 2508.39798448372, 2508.849469031855, 2124.808767210951, 2141.6038032963875, 2196.890155492219, 2239.787220214077, 2404.2787163850776, 2428.259380888828, 2445.6698345723366, 2484.763947424992, 2489.514544663791, 2495.263897150336, 2435.8416702914255, 2453.6319552067334, 2476.925692229236, 2479.3677612208953, 2481.2184161988916, 7670.695981683128, 8554.914450855475, 8637.136286371375, 8661.090585488559, 8681.0, 4570.908581828345, 4844.32179494871, 5317.096093664048, 5356.946430535684, 5502.614816962814, 3685.318216129998, 3708.7774733515807, 3749.7562658427387, 3774.622537746231, 3781.621837816224, 910.2263076385086, 941.270515350602, 1065.0095411267519, 1065.7974984752873, 1101.7851518953807, 9628.807423851484, 12055.095867809949, 12063.03495720349, 12066.034717222688, 12089.576864809778, 4831.275308703723, 4929.260610908393, 4977.8302099006705, 4979.925301120486, 5014.997000599895, 10045.648402305884, 10302.845457318146, 10316.071553560216, 10326.535305911251, 10348.965103489742, 4524.9547504524535, 5476.014317422902, 5487.396386397493, 5487.835364939058, 5508.3114610673665, 4619.9076018479445, 4622.791974361162, 4891.461939186686, 4986.875328116754, 5029.069622119846, 3835.022069372292, 3846.74996125251, 3853.460515527828, 3861.9613803861603, 3880.359740642819, 1139.7549526851767, 1213.3387303919208, 1216.1486959128645, 1224.5958833584896, 1226.1110694746417, 1082.3614067700096, 1090.5637744901944, 1122.2144498850837, 1228.2569045727207, 1347.036868638928, 6848.452123830081, 7032.789016329519, 7442.776716698508, 7539.396848252236, 7579.848403032019, 635.7043974551856, 646.890028695123, 648.2447948140458, 648.740503798475, 789.4671097009495, 6012.248468941382, 6159.168512250879, 6226.875462490725, 6279.340669229757, 6317.241930968313, 10285.691429256985, 10714.982076702701, 10951.890481095086, 11008.339499629888, 11201.66395008151, 10363.481825908675, 10381.169506439466, 10464.215183861088, 10567.418791966516, 10585.153187744962, 8077.35381169505, 8220.17798220185, 8253.13342099083, 8260.008798944045, 8295.253427191581, 8072.0, 8093.19068093186, 8108.716194933149, 8148.877766833383, 8157.776333550015, 9297.907020929704, 9304.16262536375, 9586.945436001895, 9612.615495380387, 9627.90372096298, 9589.520523973913, 9877.0, 10043.748906277402, 10103.09072183507, 10118.443485608363, 7584.696612135453, 7587.848243035219, 7701.961490192737, 7720.691172353043, 7721.189275126031, 8042.557659328793, 8129.512229266263, 8156.265936065783, 8277.95861020691, 8388.370872184732, 6939.722411103499, 7670.693172273047, 7841.059072911287, 7863.646135924012, 7909.288164065261, 7591.443754030521, 7633.847323053619, 7664.156942736406, 7783.143854175923, 7836.373090152888, 7750.806229844299, 7815.765527034198, 7817.5309481431295, 7822.491538050009, 7828.80427989282, 6911.654417279216, 6970.302969702989, 7022.894656580258, 7094.793885039452, 7104.431645468453, 5954.940450595439, 6022.367651396716, 7141.64291785419, 7314.08573928259, 7323.157836848831], "unit": "score", "name": "mootools.html", "value": 4820.400109696754}, {"lowerIsBetter": false, "replicates": [323.45497836146086, 328.76657573123083, 328.83065221410965, 332.6307798343839, 335.795164949381, 5154.664946778462, 5347.946520534793, 5350.2777125088105, 6875.521762820992, 6908.378245957862, 6840.076589660394, 6873.690683919223, 6907.929270962996, 6913.585184888898, 6945.548539344939, 4095.8771236862794, 4197.328427451608, 5000.149974504343, 5109.284700141983, 5132.332796736419, 5103.183490641498, 5103.923441148368, 5117.692938423706, 5118.6416950813455, 5143.4599367066485, 4693.366395536593, 4880.023995200956, 4881.682690625115, 4890.657653964224, 4917.680350777206, 4876.9268460972935, 4879.682820616648, 4891.241857512091, 4898.118338699032, 4902.994886048352, 3938.074552480165, 4126.195391898581, 4148.066684995882, 4150.83396664133, 4157.189348077126, 5258.0, 6322.936770632326, 6615.669216539154, 6628.5691430056895, 6635.469162466991, 5870.412958704138, 5951.22634057574, 5963.344032156503, 5967.49276311514, 5973.671448070354, 5709.74306156224, 6116.785912493041, 6693.196816382017, 7373.963130184368, 7508.849823003564, 4643.6517261205545, 4789.425268967711, 4851.854444366674, 4861.440934292566, 4902.436219834729, 7813.101493328227, 7892.131865494791, 7895.289423951815, 7901.170377110436, 7922.920770792333, 4975.577075948512, 4982.227754698028, 4992.850214493571, 5000.074986127505, 5001.7499125043605, 3925.9607403926166, 5096.006278775677, 5102.668326558762, 5107.284980102789, 5111.233315002779, 5987.461128498456, 6001.12983617373, 6002.639841609517, 6014.398560144038, 6019.4883434908525, 7468.0, 7478.177400485943, 7488.9625551871895, 7503.699852005859, 7517.301686445971, 1528.4115615488117, 1747.2923465996291, 1765.5850875044355, 1768.0717623247897, 1770.1060964213248, 1103.4372470040337, 1106.9723256918642, 1132.230083543182, 1147.4778975566098, 1150.4017910686396, 6775.864482710417, 6795.0, 6820.556663816936, 6824.624645644537, 6894.24163342032, 6886.655667216619, 7690.807729806799, 7703.653335599912, 7710.074791025113, 7722.92277077222, 5836.0, 6238.500919926395, 6476.935230647728, 6777.525573209828, 6836.863262734817, 4049.4128351388886, 4071.267171909085, 4083.0, 4089.20260549196, 4106.815193316308, 7970.242826931432, 7975.2423519765525, 7980.4812687175145, 8007.639656215484, 8022.237887400687, 6212.378762123842, 7939.722109726132, 7954.284114429729, 8090.029196496458, 8126.2686358226865, 8130.59347032646, 8134.877976830352, 8148.633311500997, 8166.183381661786, 8167.0, 7486.5508069516, 7673.577953212627, 7803.336716379172, 7807.921920780719, 7883.369330453665, 7687.923120768721, 7702.845943081219, 7717.845643087219, 7718.305352518076, 7742.7677169685, 7813.3749300057, 8137.0, 8153.062397824327, 8156.959215203886, 8161.224683655043, 3870.9419358710206, 4790.95209047919, 4797.928031079467, 4824.396950381202, 4824.541668541483, 7821.569813660303, 7822.491538050009, 7824.452288339761, 7828.80427989282, 7857.253560911704, 7254.056972593529, 7513.8497230054, 7525.623718814147, 7566.470347075652, 7584.241575842371, 6462.870742585216, 7502.774916752506, 7506.587137707478, 7538.434617403607, 7544.547327160388, 7305.634718264172, 7321.487495875238, 7326.084239470067, 7335.77992660221, 7341.632918353954, 7267.7819665410125, 7462.10454745434, 7480.139783924918, 7488.850222995618, 7496.887546686695, 7172.601342738325, 7290.9635451822405, 7314.6708398121145, 7317.707291708272, 7329.0], "unit": "score", "name": "prototype.html", "value": 5346.798882917558}, {"lowerIsBetter": false, "replicates": [601.4351075338183, 648.7340190521884, 681.1281559603707, 702.395939492037, 743.8995735575695, 14646.34091465884, 14748.557543273719, 14883.702325953474, 14922.0, 14924.4776432825, 13519.864801351983, 13546.932265338684, 13552.119112257697, 13579.0, 13588.456461741518, 665.314725832391, 816.930560902324, 829.261956858395, 848.2323497235012, 849.647396330522, 832.5046597274612, 836.2390224895346, 838.4927119092953, 842.9367797415188, 843.0473564871686, 894.2398960883262, 897.7890195803981, 898.191627535217, 899.2626046641757, 899.9910000899972, 873.1268731268731, 874.2175752701329, 886.9512176830304, 888.9599968001423, 890.1187824054205, 652.1131261484378, 654.9639769812659, 658.4008552217459, 660.2769966886252, 660.6465540935625, 14471.565853024425, 14534.781978270334, 14618.195999220039, 14703.97072204946, 14721.190334531597, 10357.964203579657, 11101.666949991513, 12506.562270320586, 12565.0, 12932.612021639367, 8327.249067493136, 10158.492075396201, 10214.08073273409, 10240.74398140045, 10372.688819335432, 2971.272038350596, 3456.343294773985, 3561.2521370511963, 3577.8550863723617, 3692.1877187018813, 50481.999999999636, 83924.90187745355, 84161.73757393644, 84425.0, 85170.29659406777, 8173.591320433955, 8921.0, 9255.583498742573, 9357.877054753337, 9546.42721436716, 20967.0, 21028.89485552593, 21255.0435230415, 21275.574488510145, 21362.679559806616, 7355.301246381585, 7459.552426854406, 7555.886661700079, 7654.961725191339, 7786.454948153688, 3403.761736678409, 4155.91688166235, 4163.7293575917465, 4196.475440569929, 4202.768847713344, 3504.789712617251, 3550.5916819565564, 3577.5349204603235, 3589.5513060867393, 3591.4612808078473, 656.7077650445601, 661.5435349608755, 672.6838385958591, 677.0893148714971, 677.116363146099, 570.7089384413979, 577.9683265371292, 600.2376981233808, 626.4706323156925, 635.675805339271, 8248.628811703487, 8473.788155296044, 8519.148085191431, 8578.0, 8627.956860215785, 493.44980346912934, 515.3274976156152, 571.0577547047405, 603.8912995660735, 622.9314775374705, 3775.5846856845724, 3777.0295548073327, 3876.2247550490015, 4041.8383264669674, 4105.630493255561, 88091.0, 88497.67253491202, 89020.10979890247, 89155.55422222847, 89223.0, 76485.6175719129, 77246.0, 77537.0, 77700.0, 78332.0, 70506.64746676336, 70820.0, 70879.0, 70885.58228835497, 71228.0, 8126.36350475017, 8198.713045043394, 8201.13888041747, 8353.0, 8392.74963554149, 48639.0, 48966.51033489762, 49481.0, 50748.0, 51362.74318628533, 65787.0, 70098.0, 70364.0, 70602.64698676474, 70901.0, 9926.428582073566, 9947.433871215588, 10029.04724051214, 10105.090541851268, 10362.533685983997, 11026.558937642405, 11039.006489415991, 11410.885891140982, 11879.465424055765, 12016.699582510508, 10371.325863818827, 10601.787964240826, 10791.0, 10791.676249712522, 10959.06847917936, 8259.83480330402, 10168.186545076524, 10402.635907743193, 10756.946215269187, 10762.623308184176, 8372.581370931552, 9681.854772178282, 9702.75743106428, 10286.228532859916, 10522.736931576772, 8604.698835540727, 8881.339480708659, 8881.467111973303, 8914.0, 9041.50271735061, 6412.61524308543, 8603.483790972561, 9095.317851161057, 9171.0, 9181.908180918106], "unit": "score", "name": "yui.html", "value": 6658.452403814763}], "name": "dromaeo_css", "value": 7495.741564535978}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 110.0, 127.0, 167.0, 126.0, 138.0, 170.0, 162.0, 114.0, 114.0], "unit": "score", "name": "ai-astar", "value": 134.3}, {"lowerIsBetter": true, "replicates": [159.0, 121.0, 159.0, 158.0, 138.0, 141.0, 126.0, 175.0, 176.0, 157.0], "unit": "score", "name": "audio-beat-detection", "value": 151.0}, {"lowerIsBetter": true, "replicates": [226.0, 282.0, 211.0, 223.0, 201.0, 199.0, 202.0, 202.0, 198.0, 196.0], "unit": "score", "name": "audio-dft", "value": 214.0}, {"lowerIsBetter": true, "replicates": [71.0, 78.0, 71.0, 108.0, 61.0, 83.0, 89.0, 86.0, 142.0, 56.0], "unit": "score", "name": "audio-fft", "value": 84.5}, {"lowerIsBetter": true, "replicates": [83.0, 88.0, 160.0, 107.0, 119.0, 81.0, 118.0, 120.0, 121.0, 146.0], "unit": "score", "name": "audio-oscillator", "value": 114.3}, {"lowerIsBetter": true, "replicates": [89.0, 95.0, 90.0, 96.0, 90.0, 95.0, 87.0, 94.0, 88.0, 95.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 91.9}, {"lowerIsBetter": true, "replicates": [101.0, 154.0, 98.0, 97.0, 96.0, 97.0, 98.0, 97.0, 98.0, 98.0], "unit": "score", "name": "imaging-darkroom", "value": 103.4}, {"lowerIsBetter": true, "replicates": [91.0, 94.0, 92.0, 96.0, 95.0, 91.0, 93.0, 94.0, 92.0, 91.0], "unit": "score", "name": "imaging-desaturate", "value": 92.9}, {"lowerIsBetter": true, "replicates": [58.0, 58.0, 59.0, 55.0, 57.0, 59.0, 57.0, 65.0, 58.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 58.2}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 74.0, 70.0, 76.0, 98.0, 59.0, 90.0, 106.0, 106.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 81.2}, {"lowerIsBetter": true, "replicates": [87.0, 95.0, 86.0, 85.0, 85.0, 85.0, 86.0, 83.0, 89.0, 89.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.0}, {"lowerIsBetter": true, "replicates": [141.0, 136.0, 133.0, 136.0, 120.0, 124.0, 125.0, 132.0, 145.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 131.3}, {"lowerIsBetter": true, "replicates": [131.0, 174.0, 185.0, 183.0, 147.0, 131.0, 142.0, 129.0, 186.0, 184.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 159.2}, {"lowerIsBetter": true, "replicates": [68.0, 66.0, 69.0, 66.0, 68.0, 67.0, 91.0, 105.0, 105.0, 101.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 80.6}], "name": "kraken", "value": 1583.7999999999997}]} 14:34:47 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1583.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7495.74"}}} 14:34:47 INFO - Return code: 0 14:34:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:34:47 INFO - # TBPL SUCCESS # 14:34:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:34:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:34:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:34:47 INFO - 2016-02-08 14:34:47.678 screenresolution[1698:10481] starting screenresolution argv=screenresolution get 14:34:47 INFO - 2016-02-08 14:34:47.680 screenresolution[1698:10481] Display 0: 1600x1200x32@60 14:34:47 INFO - 2016-02-08 14:34:47.685 screenresolution[1699:10484] starting screenresolution argv=screenresolution list 14:34:47 INFO - Available Modes on Display 0 14:34:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:34:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:34:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:34:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:34:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:34:47 INFO - Intel Iris: 14:34:47 INFO - Chipset Model: Intel Iris 14:34:47 INFO - Type: GPU 14:34:47 INFO - Bus: Built-In 14:34:47 INFO - VRAM (Dynamic, Max): 1536 MB 14:34:47 INFO - Vendor: Intel (0x8086) 14:34:47 INFO - Device ID: 0x0a2e 14:34:47 INFO - Revision ID: 0x0009 14:34:47 INFO - Displays: 14:34:47 INFO - Display: 14:34:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:34:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:34:47 INFO - Display Serial Number: 1600x1200 60 14:34:47 INFO - Main Display: Yes 14:34:47 INFO - Mirror: Off 14:34:47 INFO - Online: Yes 14:34:47 INFO - Rotation: Supported 14:34:47 INFO - Return code: 0 14:34:47 INFO - Running post-action listener: _resource_record_post_action 14:34:47 INFO - Running post-run listener: _resource_record_post_run 14:34:48 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 39249408; Write bytes: 713493504; Read time: 427; Write time: 2146 14:34:48 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 406995456; Write bytes: 409099264; Read time: 31183; Write time: 895 14:34:48 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 37422592; Write bytes: 303546368; Read time: 406; Write time: 1250 14:34:48 INFO - Running post-run listener: _upload_blobber_files 14:34:48 INFO - Blob upload gear active. 14:34:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:34:48 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 14:34:48 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:34:48 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:34:49 INFO - (blobuploader) - INFO - Open directory for files ... 14:34:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:34:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:34:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:34:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:34:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:34:50 INFO - (blobuploader) - INFO - Done attempting. 14:34:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:34:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:34:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:34:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:34:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:34:51 INFO - (blobuploader) - INFO - Done attempting. 14:34:51 INFO - (blobuploader) - INFO - Iteration through files over. 14:34:51 INFO - Return code: 0 14:34:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:34:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:34:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e4ec86c07263f1fb1bd0f9475d76bc7e34ee37e7a483b5bc826804103d8d192334165ab8b42895ce2eb670a9fce8e276d92371ea42aaf909af1c4e9fab1b45d1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0eb4a092f092bb0cd4c594a1f4c6ab33c5ba3a7d897ef2591a355d335b8314eb64c32171287c948979165f6d62aef3149d126ec6f08e00d55bac30fe8f804e96"} 14:34:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:34:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:34:51 INFO - Contents: 14:34:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e4ec86c07263f1fb1bd0f9475d76bc7e34ee37e7a483b5bc826804103d8d192334165ab8b42895ce2eb670a9fce8e276d92371ea42aaf909af1c4e9fab1b45d1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0eb4a092f092bb0cd4c594a1f4c6ab33c5ba3a7d897ef2591a355d335b8314eb64c32171287c948979165f6d62aef3149d126ec6f08e00d55bac30fe8f804e96"} 14:34:51 INFO - Running post-run listener: copy_logs_to_upload_dir 14:34:51 INFO - Copying logs to upload dir... 14:34:51 INFO - mkdir: /builds/slave/test/build/upload/logs 14:34:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.288733 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-02-08 14:34:51.635512) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-08 14:34:51.638621) ========= 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.Zvwib7OszM/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.F8o5ofM20u/Listeners TMPDIR=/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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/Fx-Team/sha512/e4ec86c07263f1fb1bd0f9475d76bc7e34ee37e7a483b5bc826804103d8d192334165ab8b42895ce2eb670a9fce8e276d92371ea42aaf909af1c4e9fab1b45d1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0eb4a092f092bb0cd4c594a1f4c6ab33c5ba3a7d897ef2591a355d335b8314eb64c32171287c948979165f6d62aef3149d126ec6f08e00d55bac30fe8f804e96"} build_url:https://queue.taskcluster.net/v1/task/fG9PiljZSSyDVPPeUNVTUg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010982 build_url: 'https://queue.taskcluster.net/v1/task/fG9PiljZSSyDVPPeUNVTUg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e4ec86c07263f1fb1bd0f9475d76bc7e34ee37e7a483b5bc826804103d8d192334165ab8b42895ce2eb670a9fce8e276d92371ea42aaf909af1c4e9fab1b45d1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0eb4a092f092bb0cd4c594a1f4c6ab33c5ba3a7d897ef2591a355d335b8314eb64c32171287c948979165f6d62aef3149d126ec6f08e00d55bac30fe8f804e96"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-08 14:34:51.665754) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 14:34:51.666133) ========= 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.Zvwib7OszM/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.F8o5ofM20u/Listeners TMPDIR=/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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.005040 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 14:34:51.715069) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-08 14:34:51.715482) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-08 14:34:51.715996) ========= ========= Total master_lag: 0.26 =========