builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0104 starttime: 1455227017.34 results: success (0) buildid: 20160211124831 builduid: 1a31346234f7491caac911146d455125 revision: b16a5fa1a25e1f531d8b1164c7a1301a79a4f089 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-11 13:43:37.345288) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-11 13:43:37.345735) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-11 13:43:37.346028) ========= 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.gqaHBBgDUT/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.8POQZf54KY/Listeners TMPDIR=/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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.005502 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-11 13:43:37.368872) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-11 13:43:37.369169) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-11 13:43:37.385553) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 13:43:37.385834) ========= 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.gqaHBBgDUT/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.8POQZf54KY/Listeners TMPDIR=/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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.005455 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 13:43:37.434000) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-11 13:43:37.434291) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-11 13:43:37.434657) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 13:43:37.434935) ========= 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.gqaHBBgDUT/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.8POQZf54KY/Listeners TMPDIR=/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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-11 13:43:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.7M=0.001s 2016-02-11 13:43:37 (19.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.158496 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 13:43:37.608129) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 13:43:37.608468) ========= 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.gqaHBBgDUT/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.8POQZf54KY/Listeners TMPDIR=/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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.026482 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 13:43:37.657197) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 13:43:37.657555) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b16a5fa1a25e1f531d8b1164c7a1301a79a4f089 --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 b16a5fa1a25e1f531d8b1164c7a1301a79a4f089 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.gqaHBBgDUT/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.8POQZf54KY/Listeners TMPDIR=/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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-11 13:43:37,731 truncating revision to first 12 chars 2016-02-11 13:43:37,731 Setting DEBUG logging. 2016-02-11 13:43:37,731 attempt 1/10 2016-02-11 13:43:37,731 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b16a5fa1a25e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-11 13:43:38,376 unpacking tar archive at: fx-team-b16a5fa1a25e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.883316 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 13:43:38.556744) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-11 13:43:38.557104) ========= echo b16a5fa1a25e1f531d8b1164c7a1301a79a4f089 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'b16a5fa1a25e1f531d8b1164c7a1301a79a4f089'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.gqaHBBgDUT/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.8POQZf54KY/Listeners TMPDIR=/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 b16a5fa1a25e1f531d8b1164c7a1301a79a4f089 program finished with exit code 0 elapsedTime=0.005461 script_repo_revision: 'b16a5fa1a25e1f531d8b1164c7a1301a79a4f089' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-11 13:43:38.607153) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-11 13:43:38.607463) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-11 13:43:38.620201) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-02-11 13:43:38.620498) ========= /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.gqaHBBgDUT/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.8POQZf54KY/Listeners TMPDIR=/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 13:43:38 INFO - MultiFileLogger online at 20160211 13:43:38 in /builds/slave/test 13:43:38 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 13:43:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:43:38 INFO - {'append_to_log': False, 13:43:38 INFO - 'base_work_dir': '/builds/slave/test', 13:43:38 INFO - 'blob_upload_branch': 'Fx-Team', 13:43:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:43:38 INFO - 'branch': 'Fx-Team', 13:43:38 INFO - 'buildbot_json_path': 'buildprops.json', 13:43:38 INFO - 'config_files': ('talos/mac_config.py',), 13:43:38 INFO - 'default_actions': ('clobber', 13:43:38 INFO - 'read-buildbot-config', 13:43:38 INFO - 'download-and-extract', 13:43:38 INFO - 'populate-webroot', 13:43:38 INFO - 'create-virtualenv', 13:43:38 INFO - 'install', 13:43:38 INFO - 'run-tests'), 13:43:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:43:38 INFO - 'download_minidump_stackwalk': True, 13:43:38 INFO - 'download_symbols': 'ondemand', 13:43:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:43:38 INFO - 'tooltool.py': '/tools/tooltool.py', 13:43:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:43:38 INFO - '/tools/misc-python/virtualenv.py')}, 13:43:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:43:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:43:38 INFO - 'installer_path': 'installer.exe', 13:43:38 INFO - 'log_level': 'info', 13:43:38 INFO - 'log_name': 'talos', 13:43:38 INFO - 'log_to_console': True, 13:43:38 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:43:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:43:38 INFO - 'opt_config_files': (), 13:43:38 INFO - 'pip_index': False, 13:43:38 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:43:38 INFO - 'cmd': ('bash', 13:43:38 INFO - '-c', 13:43:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:43:38 INFO - 'enabled': True, 13:43:38 INFO - 'halt_on_failure': False, 13:43:38 INFO - 'name': 'check_screen_resolution'},), 13:43:38 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:43:38 INFO - 'cmd': ('bash', 13:43:38 INFO - '-c', 13:43:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:43:38 INFO - 'enabled': True, 13:43:38 INFO - 'halt_on_failure': False, 13:43:38 INFO - 'name': 'check_screen_resolution'},), 13:43:38 INFO - 'run_cmd_checks_enabled': True, 13:43:38 INFO - 'sps_profile': False, 13:43:38 INFO - 'sps_profile_interval': 0, 13:43:38 INFO - 'suite': 'dromaeojs-e10s', 13:43:38 INFO - 'system_bits': '32', 13:43:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:43:38 INFO - 'title': 't-yosemite-r7-0104', 13:43:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:43:38 INFO - 'use_talos_json': True, 13:43:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:43:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:43:38 INFO - 'work_dir': 'build'} 13:43:38 INFO - ##### 13:43:38 INFO - ##### Running clobber step. 13:43:38 INFO - ##### 13:43:38 INFO - Running pre-action listener: _resource_record_pre_action 13:43:38 INFO - Running main action method: clobber 13:43:38 INFO - rmtree: /builds/slave/test/build 13:43:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:43:41 INFO - Running post-action listener: _resource_record_post_action 13:43:41 INFO - ##### 13:43:41 INFO - ##### Running read-buildbot-config step. 13:43:41 INFO - ##### 13:43:41 INFO - Running pre-action listener: _resource_record_pre_action 13:43:41 INFO - Running main action method: read_buildbot_config 13:43:41 INFO - Using buildbot properties: 13:43:41 INFO - { 13:43:41 INFO - "project": "", 13:43:41 INFO - "product": "firefox", 13:43:41 INFO - "script_repo_revision": "production", 13:43:41 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 13:43:41 INFO - "repository": "", 13:43:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 13:43:41 INFO - "buildid": "20160211124831", 13:43:41 INFO - "pgo_build": "False", 13:43:41 INFO - "basedir": "/builds/slave/test", 13:43:41 INFO - "buildnumber": 367, 13:43:41 INFO - "slavename": "t-yosemite-r7-0104", 13:43:41 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 13:43:41 INFO - "platform": "yosemite_r7", 13:43:41 INFO - "scheduler": "tests-fx-team-macosx64-talos", 13:43:41 INFO - "branch": "fx-team", 13:43:41 INFO - "repo_path": "integration/fx-team", 13:43:41 INFO - "revision": "b16a5fa1a25e1f531d8b1164c7a1301a79a4f089", 13:43:41 INFO - "stage_platform": "macosx64", 13:43:41 INFO - "builduid": "1a31346234f7491caac911146d455125", 13:43:41 INFO - "slavebuilddir": "test" 13:43:41 INFO - } 13:43:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/XZjPgHKMRSGf68ZBw0dERg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 13:43:41 INFO - Running post-action listener: _resource_record_post_action 13:43:41 INFO - ##### 13:43:41 INFO - ##### Running download-and-extract step. 13:43:41 INFO - ##### 13:43:41 INFO - Running pre-action listener: _resource_record_pre_action 13:43:41 INFO - Running main action method: download_and_extract 13:43:41 INFO - mkdir: /builds/slave/test/build/tests 13:43:41 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')]} 13:43:41 INFO - https://queue.taskcluster.net/v1/task/XZjPgHKMRSGf68ZBw0dERg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 13:43:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZjPgHKMRSGf68ZBw0dERg/artifacts/public/build/test_packages.json 13:43:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZjPgHKMRSGf68ZBw0dERg/artifacts/public/build/test_packages.json 13:43:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZjPgHKMRSGf68ZBw0dERg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 13:43:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZjPgHKMRSGf68ZBw0dERg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 13:43:42 INFO - Downloaded 1277 bytes. 13:43:42 INFO - Reading from file /builds/slave/test/build/test_packages.json 13:43:42 INFO - Using the following test package requirements: 13:43:42 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 13:43:42 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 13:43:42 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 13:43:42 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 13:43:42 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 13:43:42 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 13:43:42 INFO - u'jsshell-mac.zip'], 13:43:42 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 13:43:42 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 13:43:42 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 13:43:42 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 13:43:42 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 13:43:42 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 13:43:42 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 13:43:42 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 13:43:42 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 13:43:42 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 13:43:42 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 13:43:42 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 13:43:42 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:43:42 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')]} 13:43:42 INFO - https://queue.taskcluster.net/v1/task/XZjPgHKMRSGf68ZBw0dERg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:43:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZjPgHKMRSGf68ZBw0dERg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 13:43:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZjPgHKMRSGf68ZBw0dERg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 13:43:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZjPgHKMRSGf68ZBw0dERg/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 13:43:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZjPgHKMRSGf68ZBw0dERg/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 13:43:43 INFO - Downloaded 17754987 bytes. 13:43:43 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'] 13:43:43 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 13:43:46 INFO - Return code: 0 13:43:46 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 13:43:46 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')]} 13:43:46 INFO - https://queue.taskcluster.net/v1/task/XZjPgHKMRSGf68ZBw0dERg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:43:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZjPgHKMRSGf68ZBw0dERg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 13:43:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZjPgHKMRSGf68ZBw0dERg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 13:43:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZjPgHKMRSGf68ZBw0dERg/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 13:43:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZjPgHKMRSGf68ZBw0dERg/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 13:43:48 INFO - Downloaded 17754987 bytes. 13:43:48 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'] 13:43:48 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 13:43:51 INFO - Return code: 0 13:43: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')]} 13:43:51 INFO - https://queue.taskcluster.net/v1/task/XZjPgHKMRSGf68ZBw0dERg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 13:43:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZjPgHKMRSGf68ZBw0dERg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 13:43:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZjPgHKMRSGf68ZBw0dERg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 13:43:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZjPgHKMRSGf68ZBw0dERg/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 13:43:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZjPgHKMRSGf68ZBw0dERg/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 13:43:52 INFO - Downloaded 10706547 bytes. 13:43:52 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'] 13:43:52 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 13:43:53 INFO - Return code: 0 13:43:53 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')]} 13:43:53 INFO - https://queue.taskcluster.net/v1/task/XZjPgHKMRSGf68ZBw0dERg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 13:43:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZjPgHKMRSGf68ZBw0dERg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 13:43:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZjPgHKMRSGf68ZBw0dERg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 13:43:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZjPgHKMRSGf68ZBw0dERg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 13:43:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZjPgHKMRSGf68ZBw0dERg/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 13:43:56 INFO - Downloaded 111131492 bytes. 13:43:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XZjPgHKMRSGf68ZBw0dERg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 13:43:56 INFO - mkdir: /builds/slave/test/properties 13:43:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:43:56 INFO - Writing to file /builds/slave/test/properties/build_url 13:43:56 INFO - Contents: 13:43:56 INFO - build_url:https://queue.taskcluster.net/v1/task/XZjPgHKMRSGf68ZBw0dERg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 13:43:57 INFO - Running post-action listener: _resource_record_post_action 13:43:57 INFO - Running post-action listener: set_extra_try_arguments 13:43:57 INFO - ##### 13:43:57 INFO - ##### Running populate-webroot step. 13:43:57 INFO - ##### 13:43:57 INFO - Running pre-action listener: _resource_record_pre_action 13:43:57 INFO - Running main action method: populate_webroot 13:43:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:43:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:43:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:43:57 INFO - '--tppagecycles', 13:43:57 INFO - '7'], 13:43:57 INFO - 'tests': ['tsvgm']}}, 13:43:57 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:43:57 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:43:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:43:57 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 13:43:57 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:43:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:43:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:43:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:57 INFO - 'talos_options': ['--e10s'], 13:43:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:43:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:57 INFO - 'tests': ['damp', 'tps']}, 13:43:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:57 INFO - 'talos_options': ['--e10s'], 13:43:57 INFO - 'tests': ['damp', 'tps']}, 13:43:57 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:43:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:43:57 INFO - 'other': {'tests': ['a11yr', 13:43:57 INFO - 'ts_paint', 13:43:57 INFO - 'tpaint', 13:43:57 INFO - 'sessionrestore', 13:43:57 INFO - 'sessionrestore_no_auto_restore']}, 13:43:57 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:43:57 INFO - 'tests': ['a11yr', 13:43:57 INFO - 'ts_paint', 13:43:57 INFO - 'tpaint', 13:43:57 INFO - 'sessionrestore', 13:43:57 INFO - 'sessionrestore_no_auto_restore']}, 13:43:57 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:43:57 INFO - 'tests': ['a11yr', 13:43:57 INFO - 'ts_paint', 13:43:57 INFO - 'tpaint', 13:43:57 INFO - 'sessionrestore', 13:43:57 INFO - 'sessionrestore_no_auto_restore']}, 13:43:57 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:43:57 INFO - 'tests': ['a11yr', 13:43:57 INFO - 'ts_paint', 13:43:57 INFO - 'tpaint', 13:43:57 INFO - 'sessionrestore', 13:43:57 INFO - 'sessionrestore_no_auto_restore']}, 13:43:57 INFO - 'other_l64': {'tests': ['a11yr', 13:43:57 INFO - 'ts_paint', 13:43:57 INFO - 'tpaint', 13:43:57 INFO - 'sessionrestore', 13:43:57 INFO - 'sessionrestore_no_auto_restore']}, 13:43:57 INFO - 'other_nol64': {'tests': ['a11yr', 13:43:57 INFO - 'ts_paint', 13:43:57 INFO - 'tpaint', 13:43:57 INFO - 'sessionrestore', 13:43:57 INFO - 'sessionrestore_no_auto_restore']}, 13:43:57 INFO - 'svgr': {'tests': ['tsvgx', 13:43:57 INFO - 'tsvgr_opacity', 13:43:57 INFO - 'tart', 13:43:57 INFO - 'tscrollx', 13:43:57 INFO - 'cart']}, 13:43:57 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:43:57 INFO - 'tests': ['tsvgx', 13:43:57 INFO - 'tsvgr_opacity', 13:43:57 INFO - 'tart', 13:43:57 INFO - 'tscrollx', 13:43:57 INFO - 'cart']}, 13:43:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:57 INFO - 'tests': ['tp5o']}, 13:43:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:57 INFO - 'talos_options': ['--e10s'], 13:43:57 INFO - 'tests': ['tp5o']}, 13:43:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:57 INFO - 'talos_options': ['--xperf_path', 13:43:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:43:57 INFO - 'tests': ['tp5n']}, 13:43:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:57 INFO - 'talos_options': ['--e10s', 13:43:57 INFO - '--xperf_path', 13:43:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:43:57 INFO - 'tests': ['tp5n']}}, 13:43:57 INFO - 'talos.zip': {'path': '', 13:43:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:43:57 INFO - Running post-action listener: _resource_record_post_action 13:43:57 INFO - ##### 13:43:57 INFO - ##### Running create-virtualenv step. 13:43:57 INFO - ##### 13:43:57 INFO - Running pre-action listener: _resource_record_pre_action 13:43:57 INFO - Running main action method: create_virtualenv 13:43:57 INFO - Creating virtualenv /builds/slave/test/build/venv 13:43:57 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 13:43:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:43:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:43:57 INFO - Using real prefix '/tools/python27' 13:43:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:43:57 INFO - Installing distribute.............................................................................................................................................................................................done. 13:44:00 INFO - Installing pip.................done. 13:44:00 INFO - Return code: 0 13:44:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:44: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')]} 13:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44: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')]} 13:44:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:00 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 0x10ba8ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba934c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1c05bb820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b930d30>, '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 0x10b754db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b927b20>, '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.gqaHBBgDUT/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.8POQZf54KY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 13:44:00 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 13:44:00 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 13:44:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gqaHBBgDUT/Render', 13:44:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:44:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:44:00 INFO - 'HOME': '/Users/cltbld', 13:44:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:44:00 INFO - 'LOGNAME': 'cltbld', 13:44:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:00 INFO - 'MOZ_NO_REMOTE': '1', 13:44:00 INFO - 'NO_EM_RESTART': '1', 13:44:00 INFO - 'PAGER': '/bin/cat', 13:44:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:44:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:00 INFO - 'PWD': '/builds/slave/test', 13:44:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:44:00 INFO - 'SHELL': '/bin/bash', 13:44:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8POQZf54KY/Listeners', 13:44:00 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 13:44:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:44:00 INFO - 'USER': 'cltbld', 13:44:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:44:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:44:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:00 INFO - 'XPC_FLAGS': '0x0', 13:44:00 INFO - 'XPC_SERVICE_NAME': '0', 13:44:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:44:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:01 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 13:44:01 INFO - Cleaning up... 13:44:01 INFO - Return code: 0 13:44:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:44: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')]} 13:44:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44: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')]} 13:44:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:01 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 0x10ba8ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba934c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1c05bb820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b930d30>, '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 0x10b754db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b927b20>, '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.gqaHBBgDUT/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.8POQZf54KY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 13:44:01 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 13:44:01 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 13:44:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gqaHBBgDUT/Render', 13:44:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:44:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:44:01 INFO - 'HOME': '/Users/cltbld', 13:44:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:44:01 INFO - 'LOGNAME': 'cltbld', 13:44:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:01 INFO - 'MOZ_NO_REMOTE': '1', 13:44:01 INFO - 'NO_EM_RESTART': '1', 13:44:01 INFO - 'PAGER': '/bin/cat', 13:44:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:44:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:01 INFO - 'PWD': '/builds/slave/test', 13:44:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:44:01 INFO - 'SHELL': '/bin/bash', 13:44:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8POQZf54KY/Listeners', 13:44:01 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 13:44:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:44:01 INFO - 'USER': 'cltbld', 13:44:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:44:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:44:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:01 INFO - 'XPC_FLAGS': '0x0', 13:44:01 INFO - 'XPC_SERVICE_NAME': '0', 13:44:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:44:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:01 INFO - Downloading/unpacking psutil>=0.7.1 13:44:01 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 13:44:01 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 13:44:01 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 13:44:01 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 13:44:01 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 13:44:01 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 13:44:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:44:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:44:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:44:04 INFO - Installing collected packages: psutil 13:44:04 INFO - Running setup.py install for psutil 13:44:04 INFO - building 'psutil._psutil_osx' extension 13:44:04 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 13:44:04 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 13:44:04 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 13:44:05 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 13:44:05 INFO - building 'psutil._psutil_posix' extension 13:44:05 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 13:44:05 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:44:05 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:44:05 INFO - ^ 13:44:05 INFO - 1 warning generated. 13:44:05 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 13:44:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:44:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:44:05 INFO - Successfully installed psutil 13:44:05 INFO - Cleaning up... 13:44:05 INFO - Return code: 0 13:44:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:44:05 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')]} 13:44:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:05 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')]} 13:44:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:05 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 0x10ba8ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba934c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1c05bb820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b930d30>, '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 0x10b754db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b927b20>, '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.gqaHBBgDUT/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.8POQZf54KY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 13:44:05 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 13:44:05 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 13:44:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gqaHBBgDUT/Render', 13:44:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:44:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:44:05 INFO - 'HOME': '/Users/cltbld', 13:44:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:44:05 INFO - 'LOGNAME': 'cltbld', 13:44:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:05 INFO - 'MOZ_NO_REMOTE': '1', 13:44:05 INFO - 'NO_EM_RESTART': '1', 13:44:05 INFO - 'PAGER': '/bin/cat', 13:44:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:44:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:05 INFO - 'PWD': '/builds/slave/test', 13:44:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:44:05 INFO - 'SHELL': '/bin/bash', 13:44:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8POQZf54KY/Listeners', 13:44:05 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 13:44:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:44:05 INFO - 'USER': 'cltbld', 13:44:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:44:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:44:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:05 INFO - 'XPC_FLAGS': '0x0', 13:44:05 INFO - 'XPC_SERVICE_NAME': '0', 13:44:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:44:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:44:05 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 13:44:05 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 13:44:05 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 13:44:05 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 13:44:05 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 13:44:05 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 13:44:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:44:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:44:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:44:08 INFO - Installing collected packages: mozsystemmonitor 13:44:08 INFO - Running setup.py install for mozsystemmonitor 13:44:08 INFO - Successfully installed mozsystemmonitor 13:44:08 INFO - Cleaning up... 13:44:08 INFO - Return code: 0 13:44:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:44:08 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')]} 13:44:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:08 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')]} 13:44:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:08 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 0x10ba8ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba934c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1c05bb820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b930d30>, '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 0x10b754db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b927b20>, '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.gqaHBBgDUT/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.8POQZf54KY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 13:44:08 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 13:44:08 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 13:44:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gqaHBBgDUT/Render', 13:44:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:44:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:44:08 INFO - 'HOME': '/Users/cltbld', 13:44:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:44:08 INFO - 'LOGNAME': 'cltbld', 13:44:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:08 INFO - 'MOZ_NO_REMOTE': '1', 13:44:08 INFO - 'NO_EM_RESTART': '1', 13:44:08 INFO - 'PAGER': '/bin/cat', 13:44:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:44:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:08 INFO - 'PWD': '/builds/slave/test', 13:44:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:44:08 INFO - 'SHELL': '/bin/bash', 13:44:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8POQZf54KY/Listeners', 13:44:08 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 13:44:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:44:08 INFO - 'USER': 'cltbld', 13:44:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:44:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:44:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:08 INFO - 'XPC_FLAGS': '0x0', 13:44:08 INFO - 'XPC_SERVICE_NAME': '0', 13:44:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:44:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:08 INFO - Downloading/unpacking blobuploader==1.2.4 13:44:08 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 13:44:08 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 13:44:08 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 13:44:08 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 13:44:08 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 13:44:08 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 13:44:10 INFO - Downloading blobuploader-1.2.4.tar.gz 13:44:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:44:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:44: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 13:44: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 13:44: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 13:44: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 13:44: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 13:44: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 13:44:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:44:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:44:11 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 13:44:11 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 13:44:11 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 13:44:11 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 13:44:11 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 13:44:11 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 13:44:11 INFO - Downloading docopt-0.6.1.tar.gz 13:44:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:44:12 INFO - Installing collected packages: blobuploader, requests, docopt 13:44:12 INFO - Running setup.py install for blobuploader 13:44:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:44:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:44:12 INFO - Running setup.py install for requests 13:44:12 INFO - Running setup.py install for docopt 13:44:12 INFO - Successfully installed blobuploader requests docopt 13:44:12 INFO - Cleaning up... 13:44:13 INFO - Return code: 0 13:44:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:44:13 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')]} 13:44:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:13 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')]} 13:44:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:13 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 0x10ba8ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba934c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1c05bb820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b930d30>, '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 0x10b754db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b927b20>, '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.gqaHBBgDUT/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.8POQZf54KY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 13:44:13 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 13:44:13 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 13:44:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gqaHBBgDUT/Render', 13:44:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:44:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:44:13 INFO - 'HOME': '/Users/cltbld', 13:44:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:44:13 INFO - 'LOGNAME': 'cltbld', 13:44:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:13 INFO - 'MOZ_NO_REMOTE': '1', 13:44:13 INFO - 'NO_EM_RESTART': '1', 13:44:13 INFO - 'PAGER': '/bin/cat', 13:44:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:44:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:13 INFO - 'PWD': '/builds/slave/test', 13:44:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:44:13 INFO - 'SHELL': '/bin/bash', 13:44:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8POQZf54KY/Listeners', 13:44:13 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 13:44:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:44:13 INFO - 'USER': 'cltbld', 13:44:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:44:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:44:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:13 INFO - 'XPC_FLAGS': '0x0', 13:44:13 INFO - 'XPC_SERVICE_NAME': '0', 13:44:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:44:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:44:13 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-TtSzl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:44:13 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-GeFJlc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:44:13 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-ymaGCK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:44:13 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-CT348z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:44:13 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-v0s3CY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:44:13 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-kRgcvZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:44:13 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-ztlOAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:44:13 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-gmKmkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:44:14 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-wl66pC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:44:14 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-o03yuc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:44:14 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-Y7Fpjy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:44:14 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-NgVV_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:44:14 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-72Jm0o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:44:14 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-oziGcc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:44:14 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-2WQ8ye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:44:14 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-7xttHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:44:14 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-Z7D31l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:44:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:44:15 INFO - Running setup.py install for manifestparser 13:44:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:44:15 INFO - Running setup.py install for mozcrash 13:44:15 INFO - Running setup.py install for mozdebug 13:44:15 INFO - Running setup.py install for mozdevice 13:44:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:44:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:44:15 INFO - Running setup.py install for mozfile 13:44:15 INFO - Running setup.py install for mozhttpd 13:44:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:44:15 INFO - Running setup.py install for mozinfo 13:44:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:44:16 INFO - Running setup.py install for mozInstall 13:44:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:44:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:44:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:44:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:44:16 INFO - Running setup.py install for mozleak 13:44:16 INFO - Running setup.py install for mozlog 13:44:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:44:16 INFO - Running setup.py install for moznetwork 13:44:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:44:16 INFO - Running setup.py install for mozprocess 13:44:16 INFO - Running setup.py install for mozprofile 13:44:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:44:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:44:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:44:16 INFO - Running setup.py install for mozrunner 13:44:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:44:17 INFO - Running setup.py install for mozscreenshot 13:44:17 INFO - Running setup.py install for moztest 13:44:17 INFO - Running setup.py install for mozversion 13:44:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:44:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:44:17 INFO - Cleaning up... 13:44:17 INFO - Return code: 0 13:44:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:44: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')]} 13:44:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44: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')]} 13:44:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:17 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 0x10ba8ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba934c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1c05bb820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b930d30>, '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 0x10b754db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b927b20>, '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.gqaHBBgDUT/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.8POQZf54KY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 13:44:17 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 13:44:17 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 13:44:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gqaHBBgDUT/Render', 13:44:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:44:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:44:17 INFO - 'HOME': '/Users/cltbld', 13:44:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:44:17 INFO - 'LOGNAME': 'cltbld', 13:44:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:17 INFO - 'MOZ_NO_REMOTE': '1', 13:44:17 INFO - 'NO_EM_RESTART': '1', 13:44:17 INFO - 'PAGER': '/bin/cat', 13:44:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:44:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:17 INFO - 'PWD': '/builds/slave/test', 13:44:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:44:17 INFO - 'SHELL': '/bin/bash', 13:44:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8POQZf54KY/Listeners', 13:44:17 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 13:44:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:44:17 INFO - 'USER': 'cltbld', 13:44:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:44:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:44:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:17 INFO - 'XPC_FLAGS': '0x0', 13:44:17 INFO - 'XPC_SERVICE_NAME': '0', 13:44:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:44:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:44:17 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-_BCjZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:44:17 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)) 13:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:44:17 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-N_V2PT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:44:18 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)) 13:44:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:44:18 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-60BUcy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:44:18 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)) 13:44:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:44:18 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-rm495T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:44:18 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)) 13:44:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:44:18 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-zgC6Wk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:44:18 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)) 13:44:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:44:18 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-TZV_U6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:44:18 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)) 13:44:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:44:18 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-0mSVbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:44:18 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)) 13:44:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:44:18 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-4blusq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:44:18 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)) 13:44:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:44:18 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-MJWoqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:44:18 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)) 13:44:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:44:18 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-kgEEMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:44:18 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)) 13:44:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:44:18 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-aB5B2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:44:18 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)) 13:44:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:44:19 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-F2aqfD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:44:19 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)) 13:44:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:44:19 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-M5ixZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:44:19 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)) 13:44:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:44:19 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-pxHsk0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:44:19 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)) 13:44:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:44:19 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-RAvXmq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:44:19 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)) 13:44:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:44:19 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-XbnT3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:44:19 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)) 13:44:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:44:19 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-0FJi_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:44:19 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)) 13:44:19 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)) 13:44:19 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)) 13:44:19 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)) 13:44:19 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)) 13:44:19 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)) 13:44:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:44: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 13:44: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 13:44: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 13:44: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 13:44: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 13:44: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 13:44:21 INFO - Downloading blessings-1.6.tar.gz 13:44:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:44:22 INFO - Installing collected packages: blessings 13:44:22 INFO - Running setup.py install for blessings 13:44:22 INFO - Successfully installed blessings 13:44:22 INFO - Cleaning up... 13:44:22 INFO - Return code: 0 13:44:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:44:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:44:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:44:22 INFO - Reading from file tmpfile_stdout 13:44:22 INFO - Current package versions: 13:44:22 INFO - blessings == 1.6 13:44:22 INFO - blobuploader == 1.2.4 13:44:22 INFO - docopt == 0.6.1 13:44:22 INFO - manifestparser == 1.1 13:44:22 INFO - mozInstall == 1.12 13:44:22 INFO - mozcrash == 0.16 13:44:22 INFO - mozdebug == 0.1 13:44:22 INFO - mozdevice == 0.48 13:44:22 INFO - mozfile == 1.2 13:44:22 INFO - mozhttpd == 0.7 13:44:22 INFO - mozinfo == 0.9 13:44:22 INFO - mozleak == 0.1 13:44:22 INFO - mozlog == 3.1 13:44:22 INFO - moznetwork == 0.27 13:44:22 INFO - mozprocess == 0.22 13:44:22 INFO - mozprofile == 0.28 13:44:22 INFO - mozrunner == 6.11 13:44:22 INFO - mozscreenshot == 0.1 13:44:22 INFO - mozsystemmonitor == 0.0 13:44:22 INFO - moztest == 0.7 13:44:22 INFO - mozversion == 1.4 13:44:22 INFO - psutil == 3.1.1 13:44:22 INFO - requests == 1.2.3 13:44:22 INFO - wsgiref == 0.1.2 13:44:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:44:22 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')]} 13:44:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:22 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')]} 13:44:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:22 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 0x10ba8ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba934c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1c05bb820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b930d30>, '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 0x10b754db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b927b20>, '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.gqaHBBgDUT/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.8POQZf54KY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 13:44:22 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 13:44:22 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 13:44:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gqaHBBgDUT/Render', 13:44:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:44:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:44:22 INFO - 'HOME': '/Users/cltbld', 13:44:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:44:22 INFO - 'LOGNAME': 'cltbld', 13:44:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:22 INFO - 'MOZ_NO_REMOTE': '1', 13:44:22 INFO - 'NO_EM_RESTART': '1', 13:44:22 INFO - 'PAGER': '/bin/cat', 13:44:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:44:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:22 INFO - 'PWD': '/builds/slave/test', 13:44:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:44:22 INFO - 'SHELL': '/bin/bash', 13:44:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8POQZf54KY/Listeners', 13:44:22 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 13:44:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:44:22 INFO - 'USER': 'cltbld', 13:44:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:44:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:44:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:22 INFO - 'XPC_FLAGS': '0x0', 13:44:22 INFO - 'XPC_SERVICE_NAME': '0', 13:44:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:44:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:22 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)) 13:44:22 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)) 13:44:22 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)) 13:44:22 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)) 13:44:22 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)) 13:44:22 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)) 13:44:22 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)) 13:44:22 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)) 13:44:22 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)) 13:44:22 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)) 13:44:22 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)) 13:44:22 INFO - Cleaning up... 13:44:22 INFO - Return code: 0 13:44:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:44:22 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')]} 13:44:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:22 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')]} 13:44:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:22 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 0x10ba8ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba934c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1c05bb820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b930d30>, '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 0x10b754db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b927b20>, '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.gqaHBBgDUT/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.8POQZf54KY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 13:44:22 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 13:44:22 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 13:44:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gqaHBBgDUT/Render', 13:44:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:44:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:44:22 INFO - 'HOME': '/Users/cltbld', 13:44:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:44:22 INFO - 'LOGNAME': 'cltbld', 13:44:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:22 INFO - 'MOZ_NO_REMOTE': '1', 13:44:22 INFO - 'NO_EM_RESTART': '1', 13:44:22 INFO - 'PAGER': '/bin/cat', 13:44:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:44:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:22 INFO - 'PWD': '/builds/slave/test', 13:44:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:44:22 INFO - 'SHELL': '/bin/bash', 13:44:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8POQZf54KY/Listeners', 13:44:22 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 13:44:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:44:22 INFO - 'USER': 'cltbld', 13:44:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:44:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:44:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:22 INFO - 'XPC_FLAGS': '0x0', 13:44:22 INFO - 'XPC_SERVICE_NAME': '0', 13:44:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:44:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:23 INFO - Downloading/unpacking jsonschema 13:44:23 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 13:44:23 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 13:44:23 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 13:44:23 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 13:44:23 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 13:44:23 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 13:44:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:44:25 INFO - Downloading/unpacking functools32 (from jsonschema) 13:44:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:25 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 13:44:25 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 13:44:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:25 INFO - Downloading functools32-3.2.3-2.tar.gz 13:44:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:44:25 INFO - warning: no files found matching '*.txt' 13:44:25 INFO - no previously-included directories found matching 'build' 13:44:25 INFO - no previously-included directories found matching 'dist' 13:44:25 INFO - no previously-included directories found matching '.git*' 13:44:25 INFO - Installing collected packages: jsonschema, functools32 13:44:25 INFO - Running setup.py install for functools32 13:44:26 INFO - warning: no files found matching '*.txt' 13:44:26 INFO - no previously-included directories found matching 'build' 13:44:26 INFO - no previously-included directories found matching 'dist' 13:44:26 INFO - no previously-included directories found matching '.git*' 13:44:26 INFO - Successfully installed jsonschema functools32 13:44:26 INFO - Cleaning up... 13:44:26 INFO - Return code: 0 13:44:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:44: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')]} 13:44:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44: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')]} 13:44:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba934c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1c05bb820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b930d30>, '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 0x10b754db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b927b20>, '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.gqaHBBgDUT/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.8POQZf54KY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 13:44:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 13:44:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 13:44:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gqaHBBgDUT/Render', 13:44:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:44:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:44:26 INFO - 'HOME': '/Users/cltbld', 13:44:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:44:26 INFO - 'LOGNAME': 'cltbld', 13:44:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:26 INFO - 'MOZ_NO_REMOTE': '1', 13:44:26 INFO - 'NO_EM_RESTART': '1', 13:44:26 INFO - 'PAGER': '/bin/cat', 13:44:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:44:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:26 INFO - 'PWD': '/builds/slave/test', 13:44:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:44:26 INFO - 'SHELL': '/bin/bash', 13:44:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8POQZf54KY/Listeners', 13:44:26 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 13:44:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:44:26 INFO - 'USER': 'cltbld', 13:44:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:44:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:44:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:26 INFO - 'XPC_FLAGS': '0x0', 13:44:26 INFO - 'XPC_SERVICE_NAME': '0', 13:44:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:44:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:26 INFO - Downloading/unpacking flake8 13:44:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:44:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:44: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 13:44: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 13:44: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 13:44: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 13:44: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 13:44: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 13:44:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:44:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:44:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:29 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 13:44:29 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 13:44:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:44:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:29 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 13:44:29 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 13:44:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:44:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:44:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:44:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:44:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:44:29 INFO - no previously-included directories found matching 'docs/_build' 13:44:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:44:30 INFO - Running setup.py install for pep8 13:44:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:44:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:44:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:44:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:44:30 INFO - no previously-included directories found matching 'docs/_build' 13:44:30 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:44:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:44:30 INFO - Cleaning up... 13:44:30 INFO - Return code: 0 13:44:30 INFO - Running post-action listener: _resource_record_post_action 13:44:30 INFO - Running post-action listener: _start_resource_monitoring 13:44:30 INFO - Starting resource monitoring. 13:44:30 INFO - ##### 13:44:30 INFO - ##### Running install step. 13:44:30 INFO - ##### 13:44:30 INFO - Running pre-action listener: _resource_record_pre_action 13:44:30 INFO - Running main action method: install 13:44:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:44:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:44:30 INFO - Reading from file tmpfile_stdout 13:44:30 INFO - Detecting whether we're running mozinstall >=1.0... 13:44:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:44:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:44:30 INFO - Reading from file tmpfile_stdout 13:44:30 INFO - Output received: 13:44:30 INFO - Usage: mozinstall [options] installer 13:44:30 INFO - Options: 13:44:30 INFO - -h, --help show this help message and exit 13:44:30 INFO - -d DEST, --destination=DEST 13:44:30 INFO - Directory to install application into. [default: 13:44:30 INFO - "/builds/slave/test"] 13:44:30 INFO - --app=APP Application being installed. [default: firefox] 13:44:30 INFO - mkdir: /builds/slave/test/build/application 13:44:30 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'] 13:44:30 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 13:45:04 INFO - Reading from file tmpfile_stdout 13:45:04 INFO - Output received: 13:45:04 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:45:04 INFO - Running post-action listener: _resource_record_post_action 13:45:04 INFO - ##### 13:45:04 INFO - ##### Running run-tests step. 13:45:04 INFO - ##### 13:45:04 INFO - Running pre-action listener: _resource_record_pre_action 13:45:04 INFO - Running main action method: run_tests 13:45:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:45:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:45:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:45:04 INFO - 2016-02-11 13:45:04.283 screenresolution[1649:7530] starting screenresolution argv=screenresolution get 13:45:04 INFO - 2016-02-11 13:45:04.286 screenresolution[1649:7530] Display 0: 1600x1200x32@60 13:45:04 INFO - 2016-02-11 13:45:04.292 screenresolution[1650:7532] starting screenresolution argv=screenresolution list 13:45:04 INFO - Available Modes on Display 0 13:45:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:45:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:45:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:45:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:45:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:45:04 INFO - Intel Iris: 13:45:04 INFO - Chipset Model: Intel Iris 13:45:04 INFO - Type: GPU 13:45:04 INFO - Bus: Built-In 13:45:04 INFO - VRAM (Dynamic, Max): 1536 MB 13:45:04 INFO - Vendor: Intel (0x8086) 13:45:04 INFO - Device ID: 0x0a2e 13:45:04 INFO - Revision ID: 0x0009 13:45:04 INFO - Displays: 13:45:04 INFO - Display: 13:45:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:45:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:45:04 INFO - Display Serial Number: 1600x1200 60 13:45:04 INFO - Main Display: Yes 13:45:04 INFO - Mirror: Off 13:45:04 INFO - Online: Yes 13:45:04 INFO - Rotation: Supported 13:45:04 INFO - Return code: 0 13:45:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:45:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:45:04 INFO - Python 2.7.3 13:45:04 INFO - Return code: 0 13:45:04 INFO - grabbing minidump binary from tooltool 13:45:04 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')]} 13:45:04 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 0x10b930d30>, '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 0x10b754db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b927b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:45:04 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 13:45:04 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 13:45:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:45:04 INFO - Return code: 0 13:45:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:45:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:45:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:45:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:45:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:45:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:45:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:45:05 INFO - Return code: 0 13:45:05 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/XZjPgHKMRSGf68ZBw0dERg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0104', '--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 13:45:05 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/XZjPgHKMRSGf68ZBw0dERg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0104 --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 13:45:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gqaHBBgDUT/Render', 13:45:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:45:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:45:05 INFO - 'HOME': '/Users/cltbld', 13:45:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:45:05 INFO - 'LOGNAME': 'cltbld', 13:45:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:45:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:45:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:05 INFO - 'MOZ_NO_REMOTE': '1', 13:45:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:45:05 INFO - 'NO_EM_RESTART': '1', 13:45:05 INFO - 'PAGER': '/bin/cat', 13:45:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:45:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:05 INFO - 'PWD': '/builds/slave/test', 13:45:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:45:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:45:05 INFO - 'SHELL': '/bin/bash', 13:45:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8POQZf54KY/Listeners', 13:45:05 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 13:45:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:45:05 INFO - 'USER': 'cltbld', 13:45:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:45:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:45:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:05 INFO - 'XPC_FLAGS': '0x0', 13:45:05 INFO - 'XPC_SERVICE_NAME': '0', 13:45:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:45:05 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/XZjPgHKMRSGf68ZBw0dERg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0104', '--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 13:45:06 INFO - mozversion application_buildid: 20160211124831 13:45:06 INFO - mozversion application_changeset: b16a5fa1a25e1f531d8b1164c7a1301a79a4f089 13:45:06 INFO - mozversion application_display_name: Nightly 13:45:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:45:06 INFO - mozversion application_name: Firefox 13:45:06 INFO - mozversion application_remotingname: firefox 13:45:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:45:06 INFO - mozversion application_vendor: Mozilla 13:45:06 INFO - mozversion application_version: 47.0a1 13:45:06 INFO - mozversion platform_buildid: 20160211124831 13:45:06 INFO - mozversion platform_changeset: b16a5fa1a25e1f531d8b1164c7a1301a79a4f089 13:45:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:45:06 INFO - mozversion platform_version: 47.0a1 13:45:06 INFO - using testdate: 1455227106 13:45:06 INFO - actual date: 1455227106 13:45:06 INFO - starting webserver on 'localhost:49279' 13:45:06 INFO - SUITE-START | Running 2 tests 13:45:06 INFO - TEST-START | dromaeo_css 13:45:06 INFO - operating with platform_type : mac_ 13:45:06 INFO - Initialising browser for dromaeo_css test... 13:45:06 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/tmpTYou2g/profile http://localhost:49279/getInfo.html) 13:45:09 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 13:45:09 INFO - PROCESS | 1668 | colorDepth:24 13:45:09 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 13:45:09 INFO - PROCESS | 1668 | __metrics 13:45:09 INFO - PROCESS | 1668 | 13:45:09 INFO - PROCESS | 1668 | ###!!! [Child][MessageChannel] Error: (msgtype=0x2A0045,name=PBrowser::Msg___delete__) Channel closing: too late to send/recv, messages will be lost 13:45:09 INFO - PROCESS | 1668 | 13:45:09 INFO - TEST-INFO | 1668: exit 0 13:45:09 INFO - Browser initialized. 13:45:09 INFO - Running cycle 1/1 for dromaeo_css test... 13:45:09 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/tmpTYou2g/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:45:21 INFO - PROCESS | 1672 | RSS: Main: 257810432 13:45:21 INFO - PROCESS | 1672 | 13:46:11 INFO - PROCESS | 1672 | 1455227171542 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] 13:48:21 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49279/tests/dromaeo/cssquery-ext.html) 13:48:23 INFO - PROCESS | 1672 | RSS: Main: 270884864 13:48:23 INFO - PROCESS | 1672 | 13:51:25 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-ext.html (next: http://localhost:49279/tests/dromaeo/cssquery-jquery.html) 13:51:25 INFO - PROCESS | 1672 | RSS: Main: 282972160 13:51:25 INFO - PROCESS | 1672 | 13:54:27 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49279/tests/dromaeo/cssquery-mootools.html) 13:54:28 INFO - PROCESS | 1672 | RSS: Main: 283762688 13:54:28 INFO - PROCESS | 1672 | 13:57:30 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49279/tests/dromaeo/cssquery-prototype.html) 13:57:30 INFO - PROCESS | 1672 | RSS: Main: 286797824 13:57:30 INFO - PROCESS | 1672 | 14:00:33 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49279/tests/dromaeo/cssquery-yui.html) 14:00:33 INFO - PROCESS | 1672 | RSS: Main: 289005568 14:00:33 INFO - PROCESS | 1672 | 14:03:36 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-yui.html (next: http://localhost:49279/tests/dromaeo/cssquery-dojo.html) 14:03:36 INFO - PROCESS | 1672 | RSS: Main: 291082240 14:03:36 INFO - PROCESS | 1672 | 14:03:36 INFO - PROCESS | 1672 | __start_tp_report 14:03:36 INFO - PROCESS | 1672 | _x_x_mozilla_page_load 14:03:36 INFO - PROCESS | 1672 | _x_x_mozilla_page_load_details 14:03:36 INFO - PROCESS | 1672 | |i|pagename|runs| 14:03:36 INFO - PROCESS | 1672 | |0;dojo.html;3445.3109378124373;3478.9652103478975;3504.5093686883824;3534.1694701745087;3550.5561804774397;5604.271444712187;5645.943540564593;5676.205331253628;5689;5701.74342154603;4767.833125840596;5534.640248383852;5661.122526008465;5722.685252311132;5743.569232307583;5084.3644544431945;5129.692218466886;5190.792368305263;5194.55846253067;5204.661696989702;4569.446165283112;5191.688498690071;5231.267622532849;5235.214717792323;5238.502342277497;5055.9747201263945;5058.544730974211;5197.29836472079;5198.142306519458;5232.555232805178;5117.948820511784;5181.171012637959;5182.041322355376;5182.922256166123;5227.686338819683;4954.331165292675;5107.923381149286;5143.408508021588;5176.352955880515;5184.585233181337;4555.521670224612;5396.379416367129;5558.972205138948;5593.888122237573;5595.804146854881;5121.103806833789;6161.938380616181;6201.96899015502;6212.87574248517;6219.067139929047;5254.973725131388;6094.96952515239;6193.628382297076;6246.937530624681;6296.89804284253;4752.881177970544;5785.30576330843;5826.184334193216;5836.678982655994;5862.589618726691;5401.108817045222;5657.773689052392;6140.964409184426;6274.1843560336865;6282.089097080898;5086.23706444029;6078.300995385499;6131.254333328352;6135.846603834851;6148.6925653717135;6148.661823599745;6151.661658608819;6166.167567378437;6175.722092505848;6245.531585131133;5031.949680503221;6068.180795592539;6125.632462052291;6128.080787881764;6262.029385445263;6178.62928224308;6189.319174890758;6203.96898015516;6228.252609686867;6252.74989000444;4837.443693975168;4844.15227335215;4870.561649451566;4887.04702583;4913.901721965541;4323.221820072355;4332.523422423531;4361.389405483234;4386.232409328355;4438.178936896685;5676.943230567724;5731.0543760279925;5739.512141468022;5742.13867919807;5779.219805326227;6104.246950856077;6202.4417802398;6262.373762623702;6266.686665666698;6270.2789179244055;5683.914741278884;5717.828465146053;5745.454181852718;5746;5770.538356931435;5321.521063104339;5332.306800116037;5357.303550538405;5381.7578208980685;5388.892222155613;6169;6191.19514463135;6253;6267.373262673696;6282.717277722513;6222.253329600296;6250.874982500415;6269.216347956505;6286.905696414466;6305.747770089145;6277.96861015692;6287.119803227643;6314.810555683337;6322.36776322364;6327.303996560467;6012.609180403259;6134.865219626364;6209.937900620936;6226.937730622636;6236.594621349598;6230.906536401867;6251.093591429127;6261.718222680081;6283.465905397909;6287.308396076336;5315;5798.303788738257;6128.785492507741;6136.018237082046;6154.876902461836;5979.252593425822;6005.849853753516;6047.5464340173785;6074.848128796815;6136.386361363828;5760.654360738369;5948.524118070631;5952.5237980960555;5958.791442299499;6000;5397.487238712316;5864.827034593013;5899.793507227227;6059.545534084873;6074.51403887679;5779.422057794355;5888.263967004124;5937.168796368598;5938.138969849261;5952.8809423812145 14:03:36 INFO - PROCESS | 1672 | |1;ext.html;459.5175066180512;493.4621262823522;498.05369797384964;549.5548605629438;567.3277166557629;28185.577216341746;37374.25251494969;37493.81253093737;37519.81240093799;37572;38454;38862.611373886255;38968.61031389693;39001.804990975004;39098;9512.667056653036;9712.70861874145;9747.415155090683;9760.511974401286;9764.414135151877;9549.522523873813;9667.468289244089;9682.177014953737;9684.225261979025;9686;9639.518024098803;9713.95143024284;9740.074692904163;9742.853857192147;9763.902360976406;9630.036996300349;9706.61173553057;9707.757306067335;9721.90278097217;9724.75688107796;9559.952200239024;9696.660616878375;9707.369021013683;9708.223342132613;9722.222222222275;37512.87461376163;37807.05482362963;37856.621433785585;37862.62137378618;37935.62064379348;2762.4613200425924;3089.7373723233554;3618.1678214010662;3800.429935509668;4004.4593979812644;28031.439371212666;28047.018354357704;28212.858935705397;28272.71727282742;28285.85857070722;2779.9722002780118;2795.3151477887845;2804.719528047199;2942.3968086542422;3008.8044277122135;415448;416311;416440;417588;417632;54376;59333.40666593365;62843.6857815708;63481.682591586745;63761;59976;60293;60363.698181508815;60626.4843378919;61163.694181529696;15901.602459938364;15950.521484355488;16011.439599613957;16060.919695401448;16098.356065757238;12284.508619655293;12298.385080745928;12306.015518758479;12348.320842353756;12589.992800575932;17650.646987060187;18945.43163705091;19439.416817495498;19807.405777826687;20039.59920801576;6945.652717364112;7181.06646135999;7893.486923349964;7952.880706789403;8209.13804050578;926.9768255793659;944.593824655391;967.2407160379069;1078.6925726168004;1094.1848322999417;24519.877400612884;28048.439031219263;29128.126156214923;29434.852825735736;30973.69026309753;1038.937663740178;1058.5871510111062;1082.155918383662;1120.8486854274568;1152.2970987697497;14671.266436678123;14706.63233419173;14761.785732140264;14774.26128693561;15120;538724;545119;547754;549049;550599;57119.14321285184;57176;57478.137827932616;57624.71187644035;58156.12765808432;1381.3645722967347;1394.2680092951282;1394.5188909826093;1408.3240044778563;1413.4204975960013;28815.56776648394;28828.567571486026;28947.85526072356;29342.706572933996;29596.408071838872;49703.25445118399;49716.50850474492;49826.50173498219;49832.501674982785;49938.25092623686;444423;505240;508754;509500;509724;31949.68050319467;32808;32891;32944.84693035732;32951.835240823646;41876.371854421595;42724.78637606792;44059.89850253769;44569.331460027475;46839.06321873475;34436.48345274773;35088;35682.28635427225;36181.27637447184;36331;34613.30773384468;35157;35348.82325588356;35352.29295414129;35473.467897981034;35412;35503.46744798779;35624;35766.28467430585;36088;24204.91077901534;29856.253593659465;31446.52830207503;31738.04785856428;31767.52348714725;24365.634515482638;24385.75614243906;24474.63288050645;24855.751442485343;25239 14:03:36 INFO - PROCESS | 1672 | |2;jquery.html;346.77979483028287;351.0119014972851;366.9853205871765;367.1024345475314;368.3627324728221;15705.764413533807;19084.141213645384;19114.42656720299;19720.408387748354;19849.60300793985;11691.532338706442;12040.698982525419;12043.277403355805;12085.818712719316;19426;4472.686911916167;5153.56194723449;5265.183896496049;5396.568274538047;5416.350037995427;5281.603879709018;5355.4912283333215;5409.5672346212405;5424.864378390552;5512.779488820443;3949.624785645359;4433.379326894237;5729.169270455782;5730.885382292352;5751.597388182829;5854.560907931901;5916.674582897939;5975.133605627181;5976.551758618078;5992.64044157352;5549.833504994856;5610.7194640268235;5681;5690.430956904318;5690.430956904318;13018;16808.915955420267;22741;23673.053077876863;23941.760582394127;2008.8192062714427;2186.431527802767;2291.3698732848434;2361.515889242701;2612.781579839969;8525.190106939894;9785.755356116155;9987.051230133126;12006.879931200663;14039.157650540898;1611.4762702121857;1673.2554013464014;1691.1966815762414;1769.8584113270908;1798.8291112344307;93648;93749.53125234398;95145;99411;100606.99393006049;10814.405207713651;11242.831357529643;11266.493007814668;11413.543458261576;11547.480363383667;13432.865671343161;13485.393157307944;13553.59339219825;13558.661033474242;13578.728425431633;7328.706851725978;8224.38317126218;8370.665173392996;8438.113998030241;8454.61954212062;8493.490390576586;8575.442596231225;8659.523726194993;8712.259457946018;8757.868631970525;4467.039586488855;4519.887002824956;4539.273716205457;4567.1779079765965;4574.794134263966;1864.0959134819602;1901.6481950839138;1917.8945158016163;1919.4433614251711;1947.3476385411045;398.7826634484213;403.4654083339587;412.18387592566285;416.81832006262584;436.75978211983283;11651.242669226473;12191.573294934813;12217.877821221851;12220.572279970158;12238.694032649077;439.85924504159004;457.2295681776218;457.5561705146003;467.74975388167167;491.4004914004908;6005.579609427386;6171;6282.308946015934;6323.5889667172405;6334.809955701244;751869.0163729534;752885.2355738187;763355;771156;775556;101481;117353.413232935;118072;123179;124148.75851241373;489.59363728106297;498.86281272649586;499.40321316027;499.48303505871974;500.0673743468405;11495.885041149815;11596.536138554364;11616.651500455;11647.59233426826;11677.532898683958;46890;46970;50150.74924625354;50514.49485505098;52214.73892630512;67882;68149.63700725859;68438.65780671065;68874.31125688879;69109.65445172742;7497.250274972459;7807.6096195188875;7809.375249979875;7824.334931530883;7846.764597062097;9881;10799.244052916534;10850.565977360817;10901.01890829829;11935.403229838299;7615.390768738598;8414.45306055129;9308.906910930804;10452.634157804441;10717.464126793786;9074.820273364421;9398.154166125081;10073.798524029331;10317.27779055459;10665.573377064831;7580.635485612643;10344.844827327446;10930.890691093306;10942.507587158756;10952.123830093733;7375.373093286916;7425.628718563942;7602.695892164252;7716.305532502101;7720.189380115007;9985.500724963867;10304.278700490893;10605.681829545127;10656.946715266375;10718.89281107179 14:03:36 INFO - PROCESS | 1672 | |3;mootools.html;1553.2311505804628;1570.8900376973613;1817.8545716342694;1857;1912.3498010676367;7846.489978151416;8491.023532293788;8681.696140635071;8825.735227943163;8861.202491775746;8537.786555336119;8618.181272779091;8665.523396213206;8690.956545217281;8743.86884196736;2470.468849197422;2477.0339567568617;2498.4378514834198;2501.487195124995;2501.87490625468;2451.521953219123;2522.4324526981372;2528.190978886757;2528.5448619248527;2533.8606376649277;1907.7806052303954;2174.5759576882515;2282.543491301738;2445.8165637577163;2509.498100379931;2435.7929575986063;2443.621238708003;2481.1192026830577;2487.5398051360557;2494.7006359236916;2150.3871396652034;2467.469494058768;2473.8515689058713;2501.499700059995;2518.156417600106;8012.799680007988;8420.915790842135;8482.279006284472;8541.017782954978;8552.358573107042;4462.330650402466;5498.092814685572;5539.446055394468;5540.722963851832;5552.08390615548;3601.549806274216;3676.099355657881;3727.310447567209;3735.383661695817;3749.212665340282;911.895132059815;1049.6011515624014;1071.9142468602492;1087.6030248959073;1103;11436.19946603738;11551.826722599168;11633.36016519091;11687.590934317343;11721.824172637418;4165.229432554987;4924.212126059813;4966.453690094087;4976.303317535548;5047.343845300161;10140.543675534618;10166.440845753554;10182.032706892833;10186.745331366626;10208.642697505551;5485.232067510552;5536.501714845684;5536.8062117826485;5553.666779993213;5571.693556854412;4920.852374428773;4971.651984361132;4980.228064649985;5009.373828271466;5015.14742493777;3857.903552411156;3890.3775395936514;3907.3943538751537;3914.080191155076;3942.3692209246956;1244.5146392906775;1282.6985658370463;1300.518808041031;1309.7773378525674;1318.4396631431603;1092.2627226621998;1094.4910616563336;1119.0991252042184;1215.914885957992;1260.1997731440601;7884.881726774103;7894.171112033154;7953.0456345238945;7991.920080799234;8006.319462845723;624.8750249950028;635.0949896397615;641.2049059166693;643.8712257548509;782.2920257167273;6100.054491553817;6167.383261673796;6243.656598887105;6248.187735594434;6275.6862156891975;10245.641402550875;10566.366018038942;10595.629152979764;10642.73393165177;10725.785484290427;10594.735131621772;10620;10640.255182137176;10669.519871605797;10744.355338679705;8090.919090809134;8186.631601577943;8219.1369906159;8223.259906608433;8352.58237088131;7777.922220777946;7800.180980996914;7829;7864.960675196817;7878.960605196938;9359.532023398666;9447.52762361893;9704.417734935927;9706.126448619658;9748.073932976356;9729.075737804897;9813.165880900204;9848.310618256653;9852.605895764089;9939.850902236616;7459.776206713807;7500.1374841893885;7503.362214211853;7535.397168226638;7539;7740.612969351398;7962.243586859239;8144.226298501633;8175.79560510992;8250.917490825015;6988.510804243654;7552.282533159341;7553.433492488195;7615.238476152341;7688.384929205762;7308;7485;7495.962520187364;7527.473076884566;7541.208173141741;7561;7623.313901748869;7655.655495502604;7657.731979380695;7677.500962437423;6048.879022419439;6869.741344729951;6882.346177113166;6923.792286231421;6951.7914462566205;7031.648417579203;7123.85752284941;7127.287271272831;7147.571145731273;7197.820054498679 14:03:36 INFO - PROCESS | 1672 | |4;prototype.html;259.99220023399306;324.14587561774727;330.2519792669604;338.16979315779764;338.3166004670564;6704.798856034315;6758.695858686358;6852.246252912176;6952.339527744869;6988;5571.888562228753;5626.943730562693;6040.42615951485;6778.830529236771;6888.448924086074;4947.1342515059905;4979.950200497985;5003.524665156822;5004.322687362262;5011.824586139486;3992.6406623403886;5008.048470790538;5019.196928491442;5022.221555658879;5031.345925029741;4690.601298889598;4868.56182943535;4879.072976134541;4882.829100981467;4890.193118135521;4858.611311095104;4867.586255168315;4868.172410690191;4870.245112007627;4881.731504767236;3990.201959608061;4071.97964010181;4135.193637240739;4135.441715368417;4161.708680392374;6470.93529064708;6473.352664733536;6491.350864913518;6571.342865713438;6577.835554111138;5882.411758824126;5885.470307672287;5914.733836977346;5917.970410147965;5924.496417804492;5329.920051199235;7012.439004879649;7102.112235970504;7291.869760187179;7400.777976660709;4687.9765601171775;4688.343631891538;4690.0854333405;4691.577758001797;4692.178868697964;7735;7821.21787821219;7834.138244793011;7846.979892613981;7854.861045148478;4155.97922010388;4746.928796068062;4748.95251047492;4758.547937945889;4765.475797662254;4055.858044968412;4806.95193048072;4832.565069143794;4874.975625121851;4878.243872199815;4765.7140571565815;5807.8548036299435;5844.503217226498;5862.091375836752;5868.383819698955;7418.258174182646;7418.925810741932;7452.254774522505;7454.701811927463;7475.551466911894;1608.6702226043867;1666.3501234518546;1672.3227093027344;1675.581104723819;1677.0776073159714;1052.7420781908481;1059.4490666640245;1067.1729409707539;1070.4112737994071;1071.892810718922;6815.318468153244;6837.692303846339;6844.828879278058;6845.178578570603;6855.006024126474;6090.543209259324;6168.506519478431;7602.961985190039;7622.352100071556;7651.1583725790115;6623.668816559153;6817.250102488722;6851.657417129124;6880.415164711056;6882.139732533434;3929.9214015719526;3971.5035620547433;4057.2899742544937;4077.510698716173;4091.6317531422314;7876.0548734151125;7929.722459713882;7932.127465978738;7937.761867143995;7941.36469082472;7999.880001799977;8021.2379823916635;8027.759167224993;8028.678852845937;8044.1955804419085;7808.84382312362;8051.436399451982;8074.555899425588;8081.83836323282;8090.190980901981;7734.961325193338;7757.456978011485;7763.534187948741;7769.572673502786;7789.182135875878;5736.512396446182;7461.253874612496;7605.847883042419;7616.69533218665;7619.390448763975;6777.661116944035;7276.890846637199;8119.5534245617055;8121.187881211831;8131.430799843954;4790.856274311776;4832.275158726219;4834.8791280218275;4845.345878306383;4847.079054979543;7565.205653406313;7757.689692412466;7796.220377962159;7823.765287041398;7832.647530861011;5349.876525929599;6093.177421048102;6825.761098361533;7451.14311854122;7521.962390188014;7472.9626351870065;7475.36459400957;7477.14012888503;7484.631915638093;7496.58768767723;5709;5921.555883308855;7316.670749816165;7324.780256592311;7334.743283985035;5990.850228744316;5993.3706960768495;6841.350071743375;6905.756963746574;7505.512141710771;5969.522438204846;7007.509474336747;7358.742444014434;7359.595222262827;7365.631718413951 14:03:36 INFO - PROCESS | 1672 | |5;yui.html;537.4383768961435;657.3656421553203;674.5109795398336;714.3142583120205;735.2794261623609;12207.755844883108;15116.924415377907;15212.087274763508;15253.69492610147;15276.312565934531;14077.71844563108;14104.224267665275;14124.858751412483;14150.221737804417;14184;687.2337343861608;841.520333409955;857.1985193843744;863.7667829685981;884.0364003236471;859.1923591823697;865.8614621660536;877.3814460805118;883.7525492862009;887.8135591525787;896.9461832290051;914.2457472585144;921.3044151665516;921.5254144115786;924.5977999570175;906.0531744327194;908.341452446974;908.6819613135416;908.9590968406404;915.7344370132654;675.4022689919408;683.255251775567;685.4173952140691;686.0738003695021;688.9871888324155;14742.557723268319;14862.405503779944;14916.62708432287;14953.775693364609;14969.700605987819;12769;12928.28894410807;12941.48234070636;12972.870271297355;13074.04801469083;8800.911990880073;9714.639950406949;10246.692599222035;10291.228157888114;10614.097801686867;3600.7839529628304;3618.8371523281517;3619.6380361963593;3628.1473853644375;3728.422094575345;79547;80222;80982.59508702478;81086;81472.59263703703;9484.857727134098;9801.803963920682;9932.851007234898;9937.65218217359;10260.333078349884;21457.356279311647;22062.88968555147;22065;22084.558308833733;22133.66799498009;7606.9619651901385;7608.657610407434;7609.315161635479;7685.269899359552;7712.807179820549;4112.383142528584;4153.54311025787;4154.273002224599;4168.854090106832;4169.249535083653;3437.5874895012257;3565.625609311037;3571.964280357215;3588.766730162531;3598.820058997092;630.8990561510228;642.5598465051455;643.1927930447258;662.6156829039146;665.7203974330793;507.7994192294023;597.2951916738291;620.4911227011258;625.0998562070604;626.9749210031548;7540.736074237485;8318.209770071833;8401.70594029206;8484.703035393855;8519.659213631385;516.4628786062453;595.6604735300837;617.9803324514587;622.710439645567;625.974961001564;3167.4773662345915;3330.6502817204328;3777.8866634001024;3987.805060600494;4050.9594904051173;75636;91250.54374728216;92707;96059;96483;76539.23460765321;76965.46069078587;78500.21499785043;79357;81663.59168204121;69044.6547767268;69205.65397172981;69275;69282;69515.65242173757;8710.956445217987;8788.780280493038;8798.272535514012;8890.86663700058;9048.864267035868;49921.75039124781;49981.75009124931;50086.740892205795;50113.498865010886;50766;69335.95996059962;70089.64955175192;70102.64948675224;70109.64945175445;70665;10798.838017429902;10891.346519208873;10986.230963832455;11005.669829905115;11033.834492482458;10115.797684046425;11562.76874462523;12080.939595301967;12659.177153484994;12666.430010649727;11094.833577496505;11671;11715.297082175097;11726.824097638713;12330.938345308216;11282.774344513227;11611.6516504505;11636.94181529087;11663;12336.753264934472;11087.05760010408;11522.82715759281;11529;11551.133664975328;12152;9083.364164508685;9119.954400227956;9182.219511341611;9199.080091990747;10151.7462063449;8792.516411597167;8859.202671759573;9271.721848344561;10013.847459561955;10083.092521673085 14:03:36 INFO - PROCESS | 1672 | __end_tp_report 14:03:36 INFO - PROCESS | 1672 | __start_cc_report 14:03:36 INFO - PROCESS | 1672 | _x_x_mozilla_cycle_collect,364 14:03:36 INFO - PROCESS | 1672 | __end_cc_report 14:03:36 INFO - PROCESS | 1672 | __startTimestamp1455228216552__endTimestamp 14:03:36 INFO - PROCESS | 1672 | 14:03:36 INFO - PROCESS | 1672 | ------- Summary: start ------- 14:03:36 INFO - PROCESS | 1672 | Number of tests: 6 14:03:36 INFO - PROCESS | 1672 | 14:03:36 INFO - PROCESS | 1672 | [#0] dojo.html Cycles:165 Average:5655.52 Median:5798.30 stddev:643.93 (11.1%) stddev-sans-first:622.13 14:03:36 INFO - PROCESS | 1672 | Values: 3445.3 3479.0 3504.5 3534.2 3550.6 5604.3 5645.9 5676.2 5689.0 5701.7 4767.8 5534.6 5661.1 5722.7 5743.6 5084.4 5129.7 5190.8 5194.6 5204.7 4569.4 5191.7 5231.3 5235.2 5238.5 5056.0 5058.5 5197.3 5198.1 5232.6 5117.9 5181.2 5182.0 5182.9 5227.7 4954.3 5107.9 5143.4 5176.4 5184.6 4555.5 5396.4 5559.0 5593.9 5595.8 5121.1 6161.9 6202.0 6212.9 6219.1 5255.0 6095.0 6193.6 6246.9 6296.9 4752.9 5785.3 5826.2 5836.7 5862.6 5401.1 5657.8 6141.0 6274.2 6282.1 5086.2 6078.3 6131.3 6135.8 6148.7 6148.7 6151.7 6166.2 6175.7 6245.5 5031.9 6068.2 6125.6 6128.1 6262.0 6178.6 6189.3 6204.0 6228.3 6252.7 4837.4 4844.2 4870.6 4887.0 4913.9 4323.2 4332.5 4361.4 4386.2 4438.2 5676.9 5731.1 5739.5 5742.1 5779.2 6104.2 6202.4 6262.4 6266.7 6270.3 5683.9 5717.8 5745.5 5746.0 5770.5 5321.5 5332.3 5357.3 5381.8 5388.9 6169.0 6191.2 6253.0 6267.4 6282.7 6222.3 6250.9 6269.2 6286.9 6305.7 6278.0 6287.1 6314.8 6322.4 6327.3 6012.6 6134.9 6209.9 6226.9 6236.6 6230.9 6251.1 6261.7 6283.5 6287.3 5315.0 5798.3 6128.8 6136.0 6154.9 5979.3 6005.8 6047.5 6074.8 6136.4 5760.7 5948.5 5952.5 5958.8 6000.0 5397.5 5864.8 5899.8 6059.5 6074.5 5779.4 5888.3 5937.2 5938.1 5952.9 14:03:36 INFO - PROCESS | 1672 | 14:03:36 INFO - PROCESS | 1672 | [#1] ext.html Cycles:180 Average:62538.47 Median:37689.53 stddev:130223.75 (345.5%) stddev-sans-first:130505.65 14:03:36 INFO - PROCESS | 1672 | Values: 459.5 493.5 498.1 549.6 567.3 28185.6 37374.3 37493.8 37519.8 37572.0 38454.0 38862.6 38968.6 39001.8 39098.0 9512.7 9712.7 9747.4 9760.5 9764.4 9549.5 9667.5 9682.2 9684.2 9686.0 9639.5 9714.0 9740.1 9742.9 9763.9 9630.0 9706.6 9707.8 9721.9 9724.8 9560.0 9696.7 9707.4 9708.2 9722.2 37512.9 37807.1 37856.6 37862.6 37935.6 2762.5 3089.7 3618.2 3800.4 4004.5 28031.4 28047.0 28212.9 28272.7 28285.9 2780.0 2795.3 2804.7 2942.4 3008.8 415448.0 416311.0 416440.0 417588.0 417632.0 54376.0 59333.4 62843.7 63481.7 63761.0 59976.0 60293.0 60363.7 60626.5 61163.7 15901.6 15950.5 16011.4 16060.9 16098.4 12284.5 12298.4 12306.0 12348.3 12590.0 17650.6 18945.4 19439.4 19807.4 20039.6 6945.7 7181.1 7893.5 7952.9 8209.1 927.0 944.6 967.2 1078.7 1094.2 24519.9 28048.4 29128.1 29434.9 30973.7 1038.9 1058.6 1082.2 1120.8 1152.3 14671.3 14706.6 14761.8 14774.3 15120.0 538724.0 545119.0 547754.0 549049.0 550599.0 57119.1 57176.0 57478.1 57624.7 58156.1 1381.4 1394.3 1394.5 1408.3 1413.4 28815.6 28828.6 28947.9 29342.7 29596.4 49703.3 49716.5 49826.5 49832.5 49938.3 444423.0 505240.0 508754.0 509500.0 509724.0 31949.7 32808.0 32891.0 32944.8 32951.8 41876.4 42724.8 44059.9 44569.3 46839.1 34436.5 35088.0 35682.3 36181.3 36331.0 34613.3 35157.0 35348.8 35352.3 35473.5 35412.0 35503.5 35624.0 35766.3 36088.0 24204.9 29856.3 31446.5 31738.0 31767.5 24365.6 24385.8 24474.6 24855.8 25239.0 14:03:36 INFO - PROCESS | 1672 | 14:03:36 INFO - PROCESS | 1672 | [#2] jquery.html Cycles:180 Average:37060.26 Median:4529.58 stddev:125694.52 (2775.0%) stddev-sans-first:126016.89 14:03:36 INFO - PROCESS | 1672 | Values: 346.8 351.0 367.0 367.1 368.4 15705.8 19084.1 19114.4 19720.4 19849.6 11691.5 12040.7 12043.3 12085.8 19426.0 4472.7 5153.6 5265.2 5396.6 5416.4 5281.6 5355.5 5409.6 5424.9 5512.8 3949.6 4433.4 5729.2 5730.9 5751.6 5854.6 5916.7 5975.1 5976.6 5992.6 5549.8 5610.7 5681.0 5690.4 5690.4 13018.0 16808.9 22741.0 23673.1 23941.8 2008.8 2186.4 2291.4 2361.5 2612.8 8525.2 9785.8 9987.1 12006.9 14039.2 1611.5 1673.3 1691.2 1769.9 1798.8 93648.0 93749.5 95145.0 99411.0 100607.0 10814.4 11242.8 11266.5 11413.5 11547.5 13432.9 13485.4 13553.6 13558.7 13578.7 7328.7 8224.4 8370.7 8438.1 8454.6 8493.5 8575.4 8659.5 8712.3 8757.9 4467.0 4519.9 4539.3 4567.2 4574.8 1864.1 1901.6 1917.9 1919.4 1947.3 398.8 403.5 412.2 416.8 436.8 11651.2 12191.6 12217.9 12220.6 12238.7 439.9 457.2 457.6 467.7 491.4 6005.6 6171.0 6282.3 6323.6 6334.8 751869.0 752885.2 763355.0 771156.0 775556.0 101481.0 117353.4 118072.0 123179.0 124148.8 489.6 498.9 499.4 499.5 500.1 11495.9 11596.5 11616.7 11647.6 11677.5 46890.0 46970.0 50150.7 50514.5 52214.7 67882.0 68149.6 68438.7 68874.3 69109.7 7497.3 7807.6 7809.4 7824.3 7846.8 9881.0 10799.2 10850.6 10901.0 11935.4 7615.4 8414.5 9308.9 10452.6 10717.5 9074.8 9398.2 10073.8 10317.3 10665.6 7580.6 10344.8 10930.9 10942.5 10952.1 7375.4 7425.6 7602.7 7716.3 7720.2 9985.5 10304.3 10605.7 10656.9 10718.9 14:03:36 INFO - PROCESS | 1672 | 14:03:36 INFO - PROCESS | 1672 | [#3] mootools.html Cycles:180 Average:6014.78 Median:5546.40 stddev:3170.10 (57.2%) stddev-sans-first:3161.26 14:03:36 INFO - PROCESS | 1672 | Values: 1553.2 1570.9 1817.9 1857.0 1912.3 7846.5 8491.0 8681.7 8825.7 8861.2 8537.8 8618.2 8665.5 8691.0 8743.9 2470.5 2477.0 2498.4 2501.5 2501.9 2451.5 2522.4 2528.2 2528.5 2533.9 1907.8 2174.6 2282.5 2445.8 2509.5 2435.8 2443.6 2481.1 2487.5 2494.7 2150.4 2467.5 2473.9 2501.5 2518.2 8012.8 8420.9 8482.3 8541.0 8552.4 4462.3 5498.1 5539.4 5540.7 5552.1 3601.5 3676.1 3727.3 3735.4 3749.2 911.9 1049.6 1071.9 1087.6 1103.0 11436.2 11551.8 11633.4 11687.6 11721.8 4165.2 4924.2 4966.5 4976.3 5047.3 10140.5 10166.4 10182.0 10186.7 10208.6 5485.2 5536.5 5536.8 5553.7 5571.7 4920.9 4971.7 4980.2 5009.4 5015.1 3857.9 3890.4 3907.4 3914.1 3942.4 1244.5 1282.7 1300.5 1309.8 1318.4 1092.3 1094.5 1119.1 1215.9 1260.2 7884.9 7894.2 7953.0 7991.9 8006.3 624.9 635.1 641.2 643.9 782.3 6100.1 6167.4 6243.7 6248.2 6275.7 10245.6 10566.4 10595.6 10642.7 10725.8 10594.7 10620.0 10640.3 10669.5 10744.4 8090.9 8186.6 8219.1 8223.3 8352.6 7777.9 7800.2 7829.0 7865.0 7879.0 9359.5 9447.5 9704.4 9706.1 9748.1 9729.1 9813.2 9848.3 9852.6 9939.9 7459.8 7500.1 7503.4 7535.4 7539.0 7740.6 7962.2 8144.2 8175.8 8250.9 6988.5 7552.3 7553.4 7615.2 7688.4 7308.0 7485.0 7496.0 7527.5 7541.2 7561.0 7623.3 7655.7 7657.7 7677.5 6048.9 6869.7 6882.3 6923.8 6951.8 7031.6 7123.9 7127.3 7147.6 7197.8 14:03:36 INFO - PROCESS | 1672 | 14:03:36 INFO - PROCESS | 1672 | [#4] prototype.html Cycles:180 Average:5896.40 Median:6482.35 stddev:1946.67 (30.0%) stddev-sans-first:1905.61 14:03:36 INFO - PROCESS | 1672 | Values: 260.0 324.1 330.3 338.2 338.3 6704.8 6758.7 6852.2 6952.3 6988.0 5571.9 5626.9 6040.4 6778.8 6888.4 4947.1 4980.0 5003.5 5004.3 5011.8 3992.6 5008.0 5019.2 5022.2 5031.3 4690.6 4868.6 4879.1 4882.8 4890.2 4858.6 4867.6 4868.2 4870.2 4881.7 3990.2 4072.0 4135.2 4135.4 4161.7 6470.9 6473.4 6491.4 6571.3 6577.8 5882.4 5885.5 5914.7 5918.0 5924.5 5329.9 7012.4 7102.1 7291.9 7400.8 4688.0 4688.3 4690.1 4691.6 4692.2 7735.0 7821.2 7834.1 7847.0 7854.9 4156.0 4746.9 4749.0 4758.5 4765.5 4055.9 4807.0 4832.6 4875.0 4878.2 4765.7 5807.9 5844.5 5862.1 5868.4 7418.3 7418.9 7452.3 7454.7 7475.6 1608.7 1666.4 1672.3 1675.6 1677.1 1052.7 1059.4 1067.2 1070.4 1071.9 6815.3 6837.7 6844.8 6845.2 6855.0 6090.5 6168.5 7603.0 7622.4 7651.2 6623.7 6817.3 6851.7 6880.4 6882.1 3929.9 3971.5 4057.3 4077.5 4091.6 7876.1 7929.7 7932.1 7937.8 7941.4 7999.9 8021.2 8027.8 8028.7 8044.2 7808.8 8051.4 8074.6 8081.8 8090.2 7735.0 7757.5 7763.5 7769.6 7789.2 5736.5 7461.3 7605.8 7616.7 7619.4 6777.7 7276.9 8119.6 8121.2 8131.4 4790.9 4832.3 4834.9 4845.3 4847.1 7565.2 7757.7 7796.2 7823.8 7832.6 5349.9 6093.2 6825.8 7451.1 7522.0 7473.0 7475.4 7477.1 7484.6 7496.6 5709.0 5921.6 7316.7 7324.8 7334.7 5990.9 5993.4 6841.4 6905.8 7505.5 5969.5 7007.5 7358.7 7359.6 7365.6 14:03:36 INFO - PROCESS | 1672 | 14:03:36 INFO - PROCESS | 1672 | [#5] yui.html Cycles:180 Average:18347.19 Median:625.54 stddev:25688.65 (4106.7%) stddev-sans-first:25725.90 14:03:36 INFO - PROCESS | 1672 | Values: 537.4 657.4 674.5 714.3 735.3 12207.8 15116.9 15212.1 15253.7 15276.3 14077.7 14104.2 14124.9 14150.2 14184.0 687.2 841.5 857.2 863.8 884.0 859.2 865.9 877.4 883.8 887.8 896.9 914.2 921.3 921.5 924.6 906.1 908.3 908.7 909.0 915.7 675.4 683.3 685.4 686.1 689.0 14742.6 14862.4 14916.6 14953.8 14969.7 12769.0 12928.3 12941.5 12972.9 13074.0 8800.9 9714.6 10246.7 10291.2 10614.1 3600.8 3618.8 3619.6 3628.1 3728.4 79547.0 80222.0 80982.6 81086.0 81472.6 9484.9 9801.8 9932.9 9937.7 10260.3 21457.4 22062.9 22065.0 22084.6 22133.7 7607.0 7608.7 7609.3 7685.3 7712.8 4112.4 4153.5 4154.3 4168.9 4169.2 3437.6 3565.6 3572.0 3588.8 3598.8 630.9 642.6 643.2 662.6 665.7 507.8 597.3 620.5 625.1 627.0 7540.7 8318.2 8401.7 8484.7 8519.7 516.5 595.7 618.0 622.7 626.0 3167.5 3330.7 3777.9 3987.8 4051.0 75636.0 91250.5 92707.0 96059.0 96483.0 76539.2 76965.5 78500.2 79357.0 81663.6 69044.7 69205.7 69275.0 69282.0 69515.7 8711.0 8788.8 8798.3 8890.9 9048.9 49921.8 49981.8 50086.7 50113.5 50766.0 69336.0 70089.6 70102.6 70109.6 70665.0 10798.8 10891.3 10986.2 11005.7 11033.8 10115.8 11562.8 12080.9 12659.2 12666.4 11094.8 11671.0 11715.3 11726.8 12330.9 11282.8 11611.7 11636.9 11663.0 12336.8 11087.1 11522.8 11529.0 11551.1 12152.0 9083.4 9120.0 9182.2 9199.1 10151.7 8792.5 8859.2 9271.7 10013.8 10083.1 14:03:36 INFO - PROCESS | 1672 | -------- Summary: end -------- 14:03:36 INFO - PROCESS | 1672 | 14:03:37 INFO - TEST-INFO | 1672: exit 0 14:03:37 INFO - TEST-OK | dromaeo_css | took 1110870ms 14:03:37 INFO - TEST-START | kraken 14:03:37 INFO - operating with platform_type : mac_ 14:03:37 INFO - Initialising browser for kraken test... 14:03:37 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/tmpTnMLPF/profile http://localhost:49279/getInfo.html) 14:03:40 INFO - PROCESS | 1683 | __metrics Screen width/height:1600/1200 14:03:40 INFO - PROCESS | 1683 | colorDepth:24 14:03:40 INFO - PROCESS | 1683 | Browser inner width/height: 1024/689 14:03:40 INFO - PROCESS | 1683 | __metrics 14:03:40 INFO - PROCESS | 1683 | 14:03:40 INFO - PROCESS | 1683 | ###!!! [Child][MessageChannel] Error: (msgtype=0x2A0045,name=PBrowser::Msg___delete__) Channel closing: too late to send/recv, messages will be lost 14:03:40 INFO - PROCESS | 1683 | 14:03:40 INFO - TEST-INFO | 1683: exit 0 14:03:40 INFO - Browser initialized. 14:03:40 INFO - Running cycle 1/1 for kraken test... 14:03:40 INFO - TEST-INFO | started process 1686 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/tmpTnMLPF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:03:52 INFO - PROCESS | 1686 | RSS: Main: 256978944 14:03:52 INFO - PROCESS | 1686 | 14:03:55 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection) 14:03:56 INFO - PROCESS | 1686 | RSS: Main: 270249984 14:03:56 INFO - PROCESS | 1686 | 14:03:58 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-dft) 14:03:59 INFO - PROCESS | 1686 | RSS: Main: 278380544 14:03:59 INFO - PROCESS | 1686 | 14:04:02 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-fft) 14:04:03 INFO - PROCESS | 1686 | RSS: Main: 282849280 14:04:03 INFO - PROCESS | 1686 | 14:04:05 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator) 14:04:05 INFO - PROCESS | 1686 | RSS: Main: 281997312 14:04:05 INFO - PROCESS | 1686 | 14:04:07 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:04:08 INFO - PROCESS | 1686 | RSS: Main: 284524544 14:04:08 INFO - PROCESS | 1686 | 14:04:11 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom) 14:04:11 INFO - PROCESS | 1686 | RSS: Main: 285782016 14:04:11 INFO - PROCESS | 1686 | 14:04:14 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate) 14:04:15 INFO - PROCESS | 1686 | RSS: Main: 286035968 14:04:15 INFO - PROCESS | 1686 | 14:04:18 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial) 14:04:18 INFO - PROCESS | 1686 | RSS: Main: 286117888 14:04:18 INFO - PROCESS | 1686 | 14:04:20 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:04:21 INFO - PROCESS | 1686 | RSS: Main: 284971008 14:04:21 INFO - PROCESS | 1686 | 14:04:22 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:04:23 INFO - PROCESS | 1686 | RSS: Main: 284516352 14:04:23 INFO - PROCESS | 1686 | 14:04:25 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:04:26 INFO - PROCESS | 1686 | RSS: Main: 285265920 14:04:26 INFO - PROCESS | 1686 | 14:04:28 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:04:29 INFO - PROCESS | 1686 | RSS: Main: 284856320 14:04:29 INFO - PROCESS | 1686 | 14:04:31 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:04:32 INFO - PROCESS | 1686 | RSS: Main: 284913664 14:04:32 INFO - PROCESS | 1686 | 14:04:34 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49279/tests/kraken/driver.html?testName=ai-astar) 14:04:34 INFO - PROCESS | 1686 | RSS: Main: 287014912 14:04:34 INFO - PROCESS | 1686 | 14:04:34 INFO - PROCESS | 1686 | __start_tp_report 14:04:34 INFO - PROCESS | 1686 | _x_x_mozilla_page_load 14:04:34 INFO - PROCESS | 1686 | _x_x_mozilla_page_load_details 14:04:34 INFO - PROCESS | 1686 | |i|pagename|runs| 14:04:34 INFO - PROCESS | 1686 | |0;ai-astar;114;107;116;115;117;126;116;115;115;114 14:04:34 INFO - PROCESS | 1686 | |1;audio-beat-detection;150;121;147;177;156;146;138;123;157;121 14:04:34 INFO - PROCESS | 1686 | |2;audio-dft;203;199;198;201;203;207;215;195;208;200 14:04:34 INFO - PROCESS | 1686 | |3;audio-fft;63;66;89;65;119;71;83;89;85;64 14:04:34 INFO - PROCESS | 1686 | |4;audio-oscillator;99;126;155;82;79;80;116;81;79;111 14:04:34 INFO - PROCESS | 1686 | |5;imaging-gaussian-blur;86;91;86;92;102;114;131;126;86;93 14:04:34 INFO - PROCESS | 1686 | |6;imaging-darkroom;96;96;95;96;96;95;99;93;96;96 14:04:34 INFO - PROCESS | 1686 | |7;imaging-desaturate;122;149;84;135;141;125;92;107;93;90 14:04:34 INFO - PROCESS | 1686 | |8;json-parse-financial;56;54;55;55;56;55;55;63;52;53 14:04:34 INFO - PROCESS | 1686 | |9;json-stringify-tinderbox;56;90;103;104;102;71;63;64;64;66 14:04:34 INFO - PROCESS | 1686 | |10;stanford-crypto-aes;85;88;86;84;83;85;84;84;87;87 14:04:34 INFO - PROCESS | 1686 | |11;stanford-crypto-ccm;130;147;119;129;123;140;152;125;146;119 14:04:34 INFO - PROCESS | 1686 | |12;stanford-crypto-pbkdf2;141;138;140;139;139;137;140;139;136;127 14:04:34 INFO - PROCESS | 1686 | |13;stanford-crypto-sha256-iterative;69;69;68;68;67;65;68;69;70;76 14:04:34 INFO - PROCESS | 1686 | __end_tp_report 14:04:34 INFO - PROCESS | 1686 | __start_cc_report 14:04:34 INFO - PROCESS | 1686 | _x_x_mozilla_cycle_collect,927 14:04:34 INFO - PROCESS | 1686 | __end_cc_report 14:04:34 INFO - PROCESS | 1686 | __startTimestamp1455228274519__endTimestamp 14:04:34 INFO - PROCESS | 1686 | 14:04:34 INFO - PROCESS | 1686 | ------- Summary: start ------- 14:04:34 INFO - PROCESS | 1686 | Number of tests: 14 14:04:34 INFO - PROCESS | 1686 | 14:04:34 INFO - PROCESS | 1686 | [#0] ai-astar Cycles:10 Average:115.50 Median:115.50 stddev:4.60 (4.0%) stddev-sans-first:4.85 14:04:34 INFO - PROCESS | 1686 | Values: 114.0 107.0 116.0 115.0 117.0 126.0 116.0 115.0 115.0 114.0 14:04:34 INFO - PROCESS | 1686 | 14:04:34 INFO - PROCESS | 1686 | [#1] audio-beat-detection Cycles:10 Average:143.60 Median:148.50 stddev:18.21 (12.3%) stddev-sans-first:19.17 14:04:34 INFO - PROCESS | 1686 | Values: 150.0 121.0 147.0 177.0 156.0 146.0 138.0 123.0 157.0 121.0 14:04:34 INFO - PROCESS | 1686 | 14:04:34 INFO - PROCESS | 1686 | [#2] audio-dft Cycles:10 Average:202.90 Median:203.00 stddev:5.80 (2.9%) stddev-sans-first:6.15 14:04:34 INFO - PROCESS | 1686 | Values: 203.0 199.0 198.0 201.0 203.0 207.0 215.0 195.0 208.0 200.0 14:04:34 INFO - PROCESS | 1686 | 14:04:34 INFO - PROCESS | 1686 | [#3] audio-fft Cycles:10 Average:79.40 Median:77.00 stddev:17.51 (22.7%) stddev-sans-first:17.54 14:04:34 INFO - PROCESS | 1686 | Values: 63.0 66.0 89.0 65.0 119.0 71.0 83.0 89.0 85.0 64.0 14:04:34 INFO - PROCESS | 1686 | 14:04:34 INFO - PROCESS | 1686 | [#4] audio-oscillator Cycles:10 Average:100.80 Median:79.50 stddev:25.90 (32.6%) stddev-sans-first:27.47 14:04:34 INFO - PROCESS | 1686 | Values: 99.0 126.0 155.0 82.0 79.0 80.0 116.0 81.0 79.0 111.0 14:04:34 INFO - PROCESS | 1686 | 14:04:34 INFO - PROCESS | 1686 | [#5] imaging-gaussian-blur Cycles:10 Average:100.70 Median:86.00 stddev:17.04 (19.8%) stddev-sans-first:17.23 14:04:34 INFO - PROCESS | 1686 | Values: 86.0 91.0 86.0 92.0 102.0 114.0 131.0 126.0 86.0 93.0 14:04:34 INFO - PROCESS | 1686 | 14:04:34 INFO - PROCESS | 1686 | [#6] imaging-darkroom Cycles:10 Average:95.80 Median:96.00 stddev:1.48 (1.5%) stddev-sans-first:1.56 14:04:34 INFO - PROCESS | 1686 | Values: 96.0 96.0 95.0 96.0 96.0 95.0 99.0 93.0 96.0 96.0 14:04:34 INFO - PROCESS | 1686 | 14:04:34 INFO - PROCESS | 1686 | [#7] imaging-desaturate Cycles:10 Average:113.80 Median:116.50 stddev:23.64 (20.3%) stddev-sans-first:24.89 14:04:34 INFO - PROCESS | 1686 | Values: 122.0 149.0 84.0 135.0 141.0 125.0 92.0 107.0 93.0 90.0 14:04:34 INFO - PROCESS | 1686 | 14:04:34 INFO - PROCESS | 1686 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.00 stddev:2.95 (5.4%) stddev-sans-first:3.12 14:04:34 INFO - PROCESS | 1686 | Values: 56.0 54.0 55.0 55.0 56.0 55.0 55.0 63.0 52.0 53.0 14:04:34 INFO - PROCESS | 1686 | 14:04:34 INFO - PROCESS | 1686 | [#9] json-stringify-tinderbox Cycles:10 Average:78.30 Median:64.00 stddev:19.19 (30.0%) stddev-sans-first:18.58 14:04:34 INFO - PROCESS | 1686 | Values: 56.0 90.0 103.0 104.0 102.0 71.0 63.0 64.0 64.0 66.0 14:04:34 INFO - PROCESS | 1686 | 14:04:34 INFO - PROCESS | 1686 | [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:85.50 stddev:1.64 (1.9%) stddev-sans-first:1.73 14:04:34 INFO - PROCESS | 1686 | Values: 85.0 88.0 86.0 84.0 83.0 85.0 84.0 84.0 87.0 87.0 14:04:34 INFO - PROCESS | 1686 | 14:04:34 INFO - PROCESS | 1686 | [#11] stanford-crypto-ccm Cycles:10 Average:133.00 Median:135.00 stddev:12.27 (9.1%) stddev-sans-first:12.97 14:04:34 INFO - PROCESS | 1686 | Values: 130.0 147.0 119.0 129.0 123.0 140.0 152.0 125.0 146.0 119.0 14:04:34 INFO - PROCESS | 1686 | 14:04:34 INFO - PROCESS | 1686 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.60 Median:139.00 stddev:4.01 (2.9%) stddev-sans-first:4.06 14:04:34 INFO - PROCESS | 1686 | Values: 141.0 138.0 140.0 139.0 139.0 137.0 140.0 139.0 136.0 127.0 14:04:34 INFO - PROCESS | 1686 | 14:04:34 INFO - PROCESS | 1686 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:2.85 (4.1%) stddev-sans-first:3.02 14:04:34 INFO - PROCESS | 1686 | Values: 69.0 69.0 68.0 68.0 67.0 65.0 68.0 69.0 70.0 76.0 14:04:34 INFO - PROCESS | 1686 | -------- Summary: end -------- 14:04:34 INFO - PROCESS | 1686 | 14:04:35 INFO - TEST-INFO | 1686: exit 0 14:04:35 INFO - TEST-OK | kraken | took 58248ms 14:04:35 INFO - SUITE-END | took 1169s 14:04:35 INFO - Completed test suite (00:19:29) 14:04:35 INFO - Working with test: dromaeo_css 14:04:35 INFO - Generating results file: dromaeo_css 14:04:35 INFO - Working with test: kraken 14:04:35 INFO - Generating results file: kraken 14:04:35 INFO - javascript benchmark 14:04:35 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:04:35 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 14:04:35 INFO - process_Request line: dromaeo_css 7322.69 graph.html#tests=[[72,64,61]] 14:04:35 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:04:35 INFO - process_Request line: kraken 1511.00 graph.html#tests=[[232,64,61]] 14:04:35 INFO - RETURN: dromaeo_css: 7322.69 14:04:35 INFO - RETURN: kraken: 1511.00 14:04:35 INFO - javascript benchmark 14:04:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3445.3109378124373, 3478.9652103478975, 3504.5093686883824, 3534.1694701745087, 3550.5561804774397, 5604.271444712187, 5645.943540564593, 5676.205331253628, 5689.0, 5701.74342154603, 4767.833125840596, 5534.640248383852, 5661.122526008465, 5722.685252311132, 5743.569232307583, 5084.3644544431945, 5129.692218466886, 5190.792368305263, 5194.55846253067, 5204.661696989702, 4569.446165283112, 5191.688498690071, 5231.267622532849, 5235.214717792323, 5238.502342277497, 5055.9747201263945, 5058.544730974211, 5197.29836472079, 5198.142306519458, 5232.555232805178, 5117.948820511784, 5181.171012637959, 5182.041322355376, 5182.922256166123, 5227.686338819683, 4954.331165292675, 5107.923381149286, 5143.408508021588, 5176.352955880515, 5184.585233181337, 4555.521670224612, 5396.379416367129, 5558.972205138948, 5593.888122237573, 5595.804146854881, 5121.103806833789, 6161.938380616181, 6201.96899015502, 6212.87574248517, 6219.067139929047, 5254.973725131388, 6094.96952515239, 6193.628382297076, 6246.937530624681, 6296.89804284253, 4752.881177970544, 5785.30576330843, 5826.184334193216, 5836.678982655994, 5862.589618726691, 5401.108817045222, 5657.773689052392, 6140.964409184426, 6274.1843560336865, 6282.089097080898, 5086.23706444029, 6078.300995385499, 6131.254333328352, 6135.846603834851, 6148.6925653717135, 6148.661823599745, 6151.661658608819, 6166.167567378437, 6175.722092505848, 6245.531585131133, 5031.949680503221, 6068.180795592539, 6125.632462052291, 6128.080787881764, 6262.029385445263, 6178.62928224308, 6189.319174890758, 6203.96898015516, 6228.252609686867, 6252.74989000444, 4837.443693975168, 4844.15227335215, 4870.561649451566, 4887.04702583, 4913.901721965541, 4323.221820072355, 4332.523422423531, 4361.389405483234, 4386.232409328355, 4438.178936896685, 5676.943230567724, 5731.0543760279925, 5739.512141468022, 5742.13867919807, 5779.219805326227, 6104.246950856077, 6202.4417802398, 6262.373762623702, 6266.686665666698, 6270.2789179244055, 5683.914741278884, 5717.828465146053, 5745.454181852718, 5746.0, 5770.538356931435, 5321.521063104339, 5332.306800116037, 5357.303550538405, 5381.7578208980685, 5388.892222155613, 6169.0, 6191.19514463135, 6253.0, 6267.373262673696, 6282.717277722513, 6222.253329600296, 6250.874982500415, 6269.216347956505, 6286.905696414466, 6305.747770089145, 6277.96861015692, 6287.119803227643, 6314.810555683337, 6322.36776322364, 6327.303996560467, 6012.609180403259, 6134.865219626364, 6209.937900620936, 6226.937730622636, 6236.594621349598, 6230.906536401867, 6251.093591429127, 6261.718222680081, 6283.465905397909, 6287.308396076336, 5315.0, 5798.303788738257, 6128.785492507741, 6136.018237082046, 6154.876902461836, 5979.252593425822, 6005.849853753516, 6047.5464340173785, 6074.848128796815, 6136.386361363828, 5760.654360738369, 5948.524118070631, 5952.5237980960555, 5958.791442299499, 6000.0, 5397.487238712316, 5864.827034593013, 5899.793507227227, 6059.545534084873, 6074.51403887679, 5779.422057794355, 5888.263967004124, 5937.168796368598, 5938.138969849261, 5952.8809423812145], "unit": "score", "name": "dojo.html", "value": 5618.357288954432}, {"lowerIsBetter": false, "replicates": [459.5175066180512, 493.4621262823522, 498.05369797384964, 549.5548605629438, 567.3277166557629, 28185.577216341746, 37374.25251494969, 37493.81253093737, 37519.81240093799, 37572.0, 38454.0, 38862.611373886255, 38968.61031389693, 39001.804990975004, 39098.0, 9512.667056653036, 9712.70861874145, 9747.415155090683, 9760.511974401286, 9764.414135151877, 9549.522523873813, 9667.468289244089, 9682.177014953737, 9684.225261979025, 9686.0, 9639.518024098803, 9713.95143024284, 9740.074692904163, 9742.853857192147, 9763.902360976406, 9630.036996300349, 9706.61173553057, 9707.757306067335, 9721.90278097217, 9724.75688107796, 9559.952200239024, 9696.660616878375, 9707.369021013683, 9708.223342132613, 9722.222222222275, 37512.87461376163, 37807.05482362963, 37856.621433785585, 37862.62137378618, 37935.62064379348, 2762.4613200425924, 3089.7373723233554, 3618.1678214010662, 3800.429935509668, 4004.4593979812644, 28031.439371212666, 28047.018354357704, 28212.858935705397, 28272.71727282742, 28285.85857070722, 2779.9722002780118, 2795.3151477887845, 2804.719528047199, 2942.3968086542422, 3008.8044277122135, 415448.0, 416311.0, 416440.0, 417588.0, 417632.0, 54376.0, 59333.40666593365, 62843.6857815708, 63481.682591586745, 63761.0, 59976.0, 60293.0, 60363.698181508815, 60626.4843378919, 61163.694181529696, 15901.602459938364, 15950.521484355488, 16011.439599613957, 16060.919695401448, 16098.356065757238, 12284.508619655293, 12298.385080745928, 12306.015518758479, 12348.320842353756, 12589.992800575932, 17650.646987060187, 18945.43163705091, 19439.416817495498, 19807.405777826687, 20039.59920801576, 6945.652717364112, 7181.06646135999, 7893.486923349964, 7952.880706789403, 8209.13804050578, 926.9768255793659, 944.593824655391, 967.2407160379069, 1078.6925726168004, 1094.1848322999417, 24519.877400612884, 28048.439031219263, 29128.126156214923, 29434.852825735736, 30973.69026309753, 1038.937663740178, 1058.5871510111062, 1082.155918383662, 1120.8486854274568, 1152.2970987697497, 14671.266436678123, 14706.63233419173, 14761.785732140264, 14774.26128693561, 15120.0, 538724.0, 545119.0, 547754.0, 549049.0, 550599.0, 57119.14321285184, 57176.0, 57478.137827932616, 57624.71187644035, 58156.12765808432, 1381.3645722967347, 1394.2680092951282, 1394.5188909826093, 1408.3240044778563, 1413.4204975960013, 28815.56776648394, 28828.567571486026, 28947.85526072356, 29342.706572933996, 29596.408071838872, 49703.25445118399, 49716.50850474492, 49826.50173498219, 49832.501674982785, 49938.25092623686, 444423.0, 505240.0, 508754.0, 509500.0, 509724.0, 31949.68050319467, 32808.0, 32891.0, 32944.84693035732, 32951.835240823646, 41876.371854421595, 42724.78637606792, 44059.89850253769, 44569.331460027475, 46839.06321873475, 34436.48345274773, 35088.0, 35682.28635427225, 36181.27637447184, 36331.0, 34613.30773384468, 35157.0, 35348.82325588356, 35352.29295414129, 35473.467897981034, 35412.0, 35503.46744798779, 35624.0, 35766.28467430585, 36088.0, 24204.91077901534, 29856.253593659465, 31446.52830207503, 31738.04785856428, 31767.52348714725, 24365.634515482638, 24385.75614243906, 24474.63288050645, 24855.751442485343, 25239.0], "unit": "score", "name": "ext.html", "value": 19314.705561299244}, {"lowerIsBetter": false, "replicates": [346.77979483028287, 351.0119014972851, 366.9853205871765, 367.1024345475314, 368.3627324728221, 15705.764413533807, 19084.141213645384, 19114.42656720299, 19720.408387748354, 19849.60300793985, 11691.532338706442, 12040.698982525419, 12043.277403355805, 12085.818712719316, 19426.0, 4472.686911916167, 5153.56194723449, 5265.183896496049, 5396.568274538047, 5416.350037995427, 5281.603879709018, 5355.4912283333215, 5409.5672346212405, 5424.864378390552, 5512.779488820443, 3949.624785645359, 4433.379326894237, 5729.169270455782, 5730.885382292352, 5751.597388182829, 5854.560907931901, 5916.674582897939, 5975.133605627181, 5976.551758618078, 5992.64044157352, 5549.833504994856, 5610.7194640268235, 5681.0, 5690.430956904318, 5690.430956904318, 13018.0, 16808.915955420267, 22741.0, 23673.053077876863, 23941.760582394127, 2008.8192062714427, 2186.431527802767, 2291.3698732848434, 2361.515889242701, 2612.781579839969, 8525.190106939894, 9785.755356116155, 9987.051230133126, 12006.879931200663, 14039.157650540898, 1611.4762702121857, 1673.2554013464014, 1691.1966815762414, 1769.8584113270908, 1798.8291112344307, 93648.0, 93749.53125234398, 95145.0, 99411.0, 100606.99393006049, 10814.405207713651, 11242.831357529643, 11266.493007814668, 11413.543458261576, 11547.480363383667, 13432.865671343161, 13485.393157307944, 13553.59339219825, 13558.661033474242, 13578.728425431633, 7328.706851725978, 8224.38317126218, 8370.665173392996, 8438.113998030241, 8454.61954212062, 8493.490390576586, 8575.442596231225, 8659.523726194993, 8712.259457946018, 8757.868631970525, 4467.039586488855, 4519.887002824956, 4539.273716205457, 4567.1779079765965, 4574.794134263966, 1864.0959134819602, 1901.6481950839138, 1917.8945158016163, 1919.4433614251711, 1947.3476385411045, 398.7826634484213, 403.4654083339587, 412.18387592566285, 416.81832006262584, 436.75978211983283, 11651.242669226473, 12191.573294934813, 12217.877821221851, 12220.572279970158, 12238.694032649077, 439.85924504159004, 457.2295681776218, 457.5561705146003, 467.74975388167167, 491.4004914004908, 6005.579609427386, 6171.0, 6282.308946015934, 6323.5889667172405, 6334.809955701244, 751869.0163729534, 752885.2355738187, 763355.0, 771156.0, 775556.0, 101481.0, 117353.413232935, 118072.0, 123179.0, 124148.75851241373, 489.59363728106297, 498.86281272649586, 499.40321316027, 499.48303505871974, 500.0673743468405, 11495.885041149815, 11596.536138554364, 11616.651500455, 11647.59233426826, 11677.532898683958, 46890.0, 46970.0, 50150.74924625354, 50514.49485505098, 52214.73892630512, 67882.0, 68149.63700725859, 68438.65780671065, 68874.31125688879, 69109.65445172742, 7497.250274972459, 7807.6096195188875, 7809.375249979875, 7824.334931530883, 7846.764597062097, 9881.0, 10799.244052916534, 10850.565977360817, 10901.01890829829, 11935.403229838299, 7615.390768738598, 8414.45306055129, 9308.906910930804, 10452.634157804441, 10717.464126793786, 9074.820273364421, 9398.154166125081, 10073.798524029331, 10317.27779055459, 10665.573377064831, 7580.635485612643, 10344.844827327446, 10930.890691093306, 10942.507587158756, 10952.123830093733, 7375.373093286916, 7425.628718563942, 7602.695892164252, 7716.305532502101, 7720.189380115007, 9985.500724963867, 10304.278700490893, 10605.681829545127, 10656.946715266375, 10718.89281107179], "unit": "score", "name": "jquery.html", "value": 8106.342419395648}, {"lowerIsBetter": false, "replicates": [1553.2311505804628, 1570.8900376973613, 1817.8545716342694, 1857.0, 1912.3498010676367, 7846.489978151416, 8491.023532293788, 8681.696140635071, 8825.735227943163, 8861.202491775746, 8537.786555336119, 8618.181272779091, 8665.523396213206, 8690.956545217281, 8743.86884196736, 2470.468849197422, 2477.0339567568617, 2498.4378514834198, 2501.487195124995, 2501.87490625468, 2451.521953219123, 2522.4324526981372, 2528.190978886757, 2528.5448619248527, 2533.8606376649277, 1907.7806052303954, 2174.5759576882515, 2282.543491301738, 2445.8165637577163, 2509.498100379931, 2435.7929575986063, 2443.621238708003, 2481.1192026830577, 2487.5398051360557, 2494.7006359236916, 2150.3871396652034, 2467.469494058768, 2473.8515689058713, 2501.499700059995, 2518.156417600106, 8012.799680007988, 8420.915790842135, 8482.279006284472, 8541.017782954978, 8552.358573107042, 4462.330650402466, 5498.092814685572, 5539.446055394468, 5540.722963851832, 5552.08390615548, 3601.549806274216, 3676.099355657881, 3727.310447567209, 3735.383661695817, 3749.212665340282, 911.895132059815, 1049.6011515624014, 1071.9142468602492, 1087.6030248959073, 1103.0, 11436.19946603738, 11551.826722599168, 11633.36016519091, 11687.590934317343, 11721.824172637418, 4165.229432554987, 4924.212126059813, 4966.453690094087, 4976.303317535548, 5047.343845300161, 10140.543675534618, 10166.440845753554, 10182.032706892833, 10186.745331366626, 10208.642697505551, 5485.232067510552, 5536.501714845684, 5536.8062117826485, 5553.666779993213, 5571.693556854412, 4920.852374428773, 4971.651984361132, 4980.228064649985, 5009.373828271466, 5015.14742493777, 3857.903552411156, 3890.3775395936514, 3907.3943538751537, 3914.080191155076, 3942.3692209246956, 1244.5146392906775, 1282.6985658370463, 1300.518808041031, 1309.7773378525674, 1318.4396631431603, 1092.2627226621998, 1094.4910616563336, 1119.0991252042184, 1215.914885957992, 1260.1997731440601, 7884.881726774103, 7894.171112033154, 7953.0456345238945, 7991.920080799234, 8006.319462845723, 624.8750249950028, 635.0949896397615, 641.2049059166693, 643.8712257548509, 782.2920257167273, 6100.054491553817, 6167.383261673796, 6243.656598887105, 6248.187735594434, 6275.6862156891975, 10245.641402550875, 10566.366018038942, 10595.629152979764, 10642.73393165177, 10725.785484290427, 10594.735131621772, 10620.0, 10640.255182137176, 10669.519871605797, 10744.355338679705, 8090.919090809134, 8186.631601577943, 8219.1369906159, 8223.259906608433, 8352.58237088131, 7777.922220777946, 7800.180980996914, 7829.0, 7864.960675196817, 7878.960605196938, 9359.532023398666, 9447.52762361893, 9704.417734935927, 9706.126448619658, 9748.073932976356, 9729.075737804897, 9813.165880900204, 9848.310618256653, 9852.605895764089, 9939.850902236616, 7459.776206713807, 7500.1374841893885, 7503.362214211853, 7535.397168226638, 7539.0, 7740.612969351398, 7962.243586859239, 8144.226298501633, 8175.79560510992, 8250.917490825015, 6988.510804243654, 7552.282533159341, 7553.433492488195, 7615.238476152341, 7688.384929205762, 7308.0, 7485.0, 7495.962520187364, 7527.473076884566, 7541.208173141741, 7561.0, 7623.313901748869, 7655.655495502604, 7657.731979380695, 7677.500962437423, 6048.879022419439, 6869.741344729951, 6882.346177113166, 6923.792286231421, 6951.7914462566205, 7031.648417579203, 7123.85752284941, 7127.287271272831, 7147.571145731273, 7197.820054498679], "unit": "score", "name": "mootools.html", "value": 4847.9392357377055}, {"lowerIsBetter": false, "replicates": [259.99220023399306, 324.14587561774727, 330.2519792669604, 338.16979315779764, 338.3166004670564, 6704.798856034315, 6758.695858686358, 6852.246252912176, 6952.339527744869, 6988.0, 5571.888562228753, 5626.943730562693, 6040.42615951485, 6778.830529236771, 6888.448924086074, 4947.1342515059905, 4979.950200497985, 5003.524665156822, 5004.322687362262, 5011.824586139486, 3992.6406623403886, 5008.048470790538, 5019.196928491442, 5022.221555658879, 5031.345925029741, 4690.601298889598, 4868.56182943535, 4879.072976134541, 4882.829100981467, 4890.193118135521, 4858.611311095104, 4867.586255168315, 4868.172410690191, 4870.245112007627, 4881.731504767236, 3990.201959608061, 4071.97964010181, 4135.193637240739, 4135.441715368417, 4161.708680392374, 6470.93529064708, 6473.352664733536, 6491.350864913518, 6571.342865713438, 6577.835554111138, 5882.411758824126, 5885.470307672287, 5914.733836977346, 5917.970410147965, 5924.496417804492, 5329.920051199235, 7012.439004879649, 7102.112235970504, 7291.869760187179, 7400.777976660709, 4687.9765601171775, 4688.343631891538, 4690.0854333405, 4691.577758001797, 4692.178868697964, 7735.0, 7821.21787821219, 7834.138244793011, 7846.979892613981, 7854.861045148478, 4155.97922010388, 4746.928796068062, 4748.95251047492, 4758.547937945889, 4765.475797662254, 4055.858044968412, 4806.95193048072, 4832.565069143794, 4874.975625121851, 4878.243872199815, 4765.7140571565815, 5807.8548036299435, 5844.503217226498, 5862.091375836752, 5868.383819698955, 7418.258174182646, 7418.925810741932, 7452.254774522505, 7454.701811927463, 7475.551466911894, 1608.6702226043867, 1666.3501234518546, 1672.3227093027344, 1675.581104723819, 1677.0776073159714, 1052.7420781908481, 1059.4490666640245, 1067.1729409707539, 1070.4112737994071, 1071.892810718922, 6815.318468153244, 6837.692303846339, 6844.828879278058, 6845.178578570603, 6855.006024126474, 6090.543209259324, 6168.506519478431, 7602.961985190039, 7622.352100071556, 7651.1583725790115, 6623.668816559153, 6817.250102488722, 6851.657417129124, 6880.415164711056, 6882.139732533434, 3929.9214015719526, 3971.5035620547433, 4057.2899742544937, 4077.510698716173, 4091.6317531422314, 7876.0548734151125, 7929.722459713882, 7932.127465978738, 7937.761867143995, 7941.36469082472, 7999.880001799977, 8021.2379823916635, 8027.759167224993, 8028.678852845937, 8044.1955804419085, 7808.84382312362, 8051.436399451982, 8074.555899425588, 8081.83836323282, 8090.190980901981, 7734.961325193338, 7757.456978011485, 7763.534187948741, 7769.572673502786, 7789.182135875878, 5736.512396446182, 7461.253874612496, 7605.847883042419, 7616.69533218665, 7619.390448763975, 6777.661116944035, 7276.890846637199, 8119.5534245617055, 8121.187881211831, 8131.430799843954, 4790.856274311776, 4832.275158726219, 4834.8791280218275, 4845.345878306383, 4847.079054979543, 7565.205653406313, 7757.689692412466, 7796.220377962159, 7823.765287041398, 7832.647530861011, 5349.876525929599, 6093.177421048102, 6825.761098361533, 7451.14311854122, 7521.962390188014, 7472.9626351870065, 7475.36459400957, 7477.14012888503, 7484.631915638093, 7496.58768767723, 5709.0, 5921.555883308855, 7316.670749816165, 7324.780256592311, 7334.743283985035, 5990.850228744316, 5993.3706960768495, 6841.350071743375, 6905.756963746574, 7505.512141710771, 5969.522438204846, 7007.509474336747, 7358.742444014434, 7359.595222262827, 7365.631718413951], "unit": "score", "name": "prototype.html", "value": 5246.177029933326}, {"lowerIsBetter": false, "replicates": [537.4383768961435, 657.3656421553203, 674.5109795398336, 714.3142583120205, 735.2794261623609, 12207.755844883108, 15116.924415377907, 15212.087274763508, 15253.69492610147, 15276.312565934531, 14077.71844563108, 14104.224267665275, 14124.858751412483, 14150.221737804417, 14184.0, 687.2337343861608, 841.520333409955, 857.1985193843744, 863.7667829685981, 884.0364003236471, 859.1923591823697, 865.8614621660536, 877.3814460805118, 883.7525492862009, 887.8135591525787, 896.9461832290051, 914.2457472585144, 921.3044151665516, 921.5254144115786, 924.5977999570175, 906.0531744327194, 908.341452446974, 908.6819613135416, 908.9590968406404, 915.7344370132654, 675.4022689919408, 683.255251775567, 685.4173952140691, 686.0738003695021, 688.9871888324155, 14742.557723268319, 14862.405503779944, 14916.62708432287, 14953.775693364609, 14969.700605987819, 12769.0, 12928.28894410807, 12941.48234070636, 12972.870271297355, 13074.04801469083, 8800.911990880073, 9714.639950406949, 10246.692599222035, 10291.228157888114, 10614.097801686867, 3600.7839529628304, 3618.8371523281517, 3619.6380361963593, 3628.1473853644375, 3728.422094575345, 79547.0, 80222.0, 80982.59508702478, 81086.0, 81472.59263703703, 9484.857727134098, 9801.803963920682, 9932.851007234898, 9937.65218217359, 10260.333078349884, 21457.356279311647, 22062.88968555147, 22065.0, 22084.558308833733, 22133.66799498009, 7606.9619651901385, 7608.657610407434, 7609.315161635479, 7685.269899359552, 7712.807179820549, 4112.383142528584, 4153.54311025787, 4154.273002224599, 4168.854090106832, 4169.249535083653, 3437.5874895012257, 3565.625609311037, 3571.964280357215, 3588.766730162531, 3598.820058997092, 630.8990561510228, 642.5598465051455, 643.1927930447258, 662.6156829039146, 665.7203974330793, 507.7994192294023, 597.2951916738291, 620.4911227011258, 625.0998562070604, 626.9749210031548, 7540.736074237485, 8318.209770071833, 8401.70594029206, 8484.703035393855, 8519.659213631385, 516.4628786062453, 595.6604735300837, 617.9803324514587, 622.710439645567, 625.974961001564, 3167.4773662345915, 3330.6502817204328, 3777.8866634001024, 3987.805060600494, 4050.9594904051173, 75636.0, 91250.54374728216, 92707.0, 96059.0, 96483.0, 76539.23460765321, 76965.46069078587, 78500.21499785043, 79357.0, 81663.59168204121, 69044.6547767268, 69205.65397172981, 69275.0, 69282.0, 69515.65242173757, 8710.956445217987, 8788.780280493038, 8798.272535514012, 8890.86663700058, 9048.864267035868, 49921.75039124781, 49981.75009124931, 50086.740892205795, 50113.498865010886, 50766.0, 69335.95996059962, 70089.64955175192, 70102.64948675224, 70109.64945175445, 70665.0, 10798.838017429902, 10891.346519208873, 10986.230963832455, 11005.669829905115, 11033.834492482458, 10115.797684046425, 11562.76874462523, 12080.939595301967, 12659.177153484994, 12666.430010649727, 11094.833577496505, 11671.0, 11715.297082175097, 11726.824097638713, 12330.938345308216, 11282.774344513227, 11611.6516504505, 11636.94181529087, 11663.0, 12336.753264934472, 11087.05760010408, 11522.82715759281, 11529.0, 11551.133664975328, 12152.0, 9083.364164508685, 9119.954400227956, 9182.219511341611, 9199.080091990747, 10151.7462063449, 8792.516411597167, 8859.202671759573, 9271.721848344561, 10013.847459561955, 10083.092521673085], "unit": "score", "name": "yui.html", "value": 6890.771051784424}], "name": "dromaeo_css", "value": 7322.688091148096}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 107.0, 116.0, 115.0, 117.0, 126.0, 116.0, 115.0, 115.0, 114.0], "unit": "score", "name": "ai-astar", "value": 115.5}, {"lowerIsBetter": true, "replicates": [150.0, 121.0, 147.0, 177.0, 156.0, 146.0, 138.0, 123.0, 157.0, 121.0], "unit": "score", "name": "audio-beat-detection", "value": 143.6}, {"lowerIsBetter": true, "replicates": [203.0, 199.0, 198.0, 201.0, 203.0, 207.0, 215.0, 195.0, 208.0, 200.0], "unit": "score", "name": "audio-dft", "value": 202.9}, {"lowerIsBetter": true, "replicates": [63.0, 66.0, 89.0, 65.0, 119.0, 71.0, 83.0, 89.0, 85.0, 64.0], "unit": "score", "name": "audio-fft", "value": 79.4}, {"lowerIsBetter": true, "replicates": [99.0, 126.0, 155.0, 82.0, 79.0, 80.0, 116.0, 81.0, 79.0, 111.0], "unit": "score", "name": "audio-oscillator", "value": 100.8}, {"lowerIsBetter": true, "replicates": [86.0, 91.0, 86.0, 92.0, 102.0, 114.0, 131.0, 126.0, 86.0, 93.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 100.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 99.0, 93.0, 96.0, 96.0], "unit": "score", "name": "imaging-darkroom", "value": 95.8}, {"lowerIsBetter": true, "replicates": [122.0, 149.0, 84.0, 135.0, 141.0, 125.0, 92.0, 107.0, 93.0, 90.0], "unit": "score", "name": "imaging-desaturate", "value": 113.8}, {"lowerIsBetter": true, "replicates": [56.0, 54.0, 55.0, 55.0, 56.0, 55.0, 55.0, 63.0, 52.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.4}, {"lowerIsBetter": true, "replicates": [56.0, 90.0, 103.0, 104.0, 102.0, 71.0, 63.0, 64.0, 64.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 78.3}, {"lowerIsBetter": true, "replicates": [85.0, 88.0, 86.0, 84.0, 83.0, 85.0, 84.0, 84.0, 87.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.3}, {"lowerIsBetter": true, "replicates": [130.0, 147.0, 119.0, 129.0, 123.0, 140.0, 152.0, 125.0, 146.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 133.0}, {"lowerIsBetter": true, "replicates": [141.0, 138.0, 140.0, 139.0, 139.0, 137.0, 140.0, 139.0, 136.0, 127.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.6}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 68.0, 68.0, 67.0, 65.0, 68.0, 69.0, 70.0, 76.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.9}], "name": "kraken", "value": 1510.9999999999998}]} 14:04:35 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1511.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7322.69"}}} 14:04:35 INFO - Return code: 0 14:04:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:04:35 INFO - # TBPL SUCCESS # 14:04:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:04:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:04:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:04:35 INFO - 2016-02-11 14:04:35.921 screenresolution[1691:10616] starting screenresolution argv=screenresolution get 14:04:35 INFO - 2016-02-11 14:04:35.924 screenresolution[1691:10616] Display 0: 1600x1200x32@60 14:04:35 INFO - 2016-02-11 14:04:35.930 screenresolution[1692:10619] starting screenresolution argv=screenresolution list 14:04:35 INFO - Available Modes on Display 0 14:04:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:04:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:04:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:04:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:04:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:04:36 INFO - Intel Iris: 14:04:36 INFO - Chipset Model: Intel Iris 14:04:36 INFO - Type: GPU 14:04:36 INFO - Bus: Built-In 14:04:36 INFO - VRAM (Dynamic, Max): 1536 MB 14:04:36 INFO - Vendor: Intel (0x8086) 14:04:36 INFO - Device ID: 0x0a2e 14:04:36 INFO - Revision ID: 0x0009 14:04:36 INFO - Displays: 14:04:36 INFO - Display: 14:04:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:04:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:04:36 INFO - Display Serial Number: 1600x1200 60 14:04:36 INFO - Main Display: Yes 14:04:36 INFO - Mirror: Off 14:04:36 INFO - Online: Yes 14:04:36 INFO - Rotation: Supported 14:04:36 INFO - Return code: 0 14:04:36 INFO - Running post-action listener: _resource_record_post_action 14:04:36 INFO - Running post-run listener: _resource_record_post_run 14:04:37 INFO - Total resource usage - Wall time: 1205s; CPU: 54.0%; Read bytes: 39151104; Write bytes: 709585920; Read time: 422; Write time: 1861 14:04:37 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 384602624; Write bytes: 378148864; Read time: 28437; Write time: 646 14:04:37 INFO - run-tests - Wall time: 1172s; CPU: 54.0%; Read bytes: 38184448; Write bytes: 303969280; Read time: 407; Write time: 1156 14:04:37 INFO - Running post-run listener: _upload_blobber_files 14:04:37 INFO - Blob upload gear active. 14:04:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:04:37 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:04:37 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:04:37 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:04:37 INFO - (blobuploader) - INFO - Open directory for files ... 14:04:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:04:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:04:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:04:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:04:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:04:38 INFO - (blobuploader) - INFO - Done attempting. 14:04:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:04:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:04:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:04:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:04:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:04:39 INFO - (blobuploader) - INFO - Done attempting. 14:04:39 INFO - (blobuploader) - INFO - Iteration through files over. 14:04:39 INFO - Return code: 0 14:04:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:04:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:04:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0443d399e7bd32f59e0db7890468df65b916ac35a253976dcd482843befa26f002351ee42039b4415705c8d74ea5c2bf61a8aca4cafa266cc456c7ac938fce3d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e2895b6a567a900e1975b0428b69a8dac7f4d1e9bf09b73f83850b0f4e564c986dfa6bd4a62d1e8f44743a8a940c55ae50b521ceb1983d520d32477574f20a32"} 14:04:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:04:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:04:39 INFO - Contents: 14:04:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0443d399e7bd32f59e0db7890468df65b916ac35a253976dcd482843befa26f002351ee42039b4415705c8d74ea5c2bf61a8aca4cafa266cc456c7ac938fce3d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e2895b6a567a900e1975b0428b69a8dac7f4d1e9bf09b73f83850b0f4e564c986dfa6bd4a62d1e8f44743a8a940c55ae50b521ceb1983d520d32477574f20a32"} 14:04:39 INFO - Running post-run listener: copy_logs_to_upload_dir 14:04:39 INFO - Copying logs to upload dir... 14:04:39 INFO - mkdir: /builds/slave/test/build/upload/logs 14:04:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.866433 ========= master_lag: 0.25 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-02-11 14:04:39.733645) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 7 secs) (at 2016-02-11 14:04:39.736789) ========= 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.gqaHBBgDUT/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.8POQZf54KY/Listeners TMPDIR=/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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/0443d399e7bd32f59e0db7890468df65b916ac35a253976dcd482843befa26f002351ee42039b4415705c8d74ea5c2bf61a8aca4cafa266cc456c7ac938fce3d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e2895b6a567a900e1975b0428b69a8dac7f4d1e9bf09b73f83850b0f4e564c986dfa6bd4a62d1e8f44743a8a940c55ae50b521ceb1983d520d32477574f20a32"} build_url:https://queue.taskcluster.net/v1/task/XZjPgHKMRSGf68ZBw0dERg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010985 build_url: 'https://queue.taskcluster.net/v1/task/XZjPgHKMRSGf68ZBw0dERg/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/0443d399e7bd32f59e0db7890468df65b916ac35a253976dcd482843befa26f002351ee42039b4415705c8d74ea5c2bf61a8aca4cafa266cc456c7ac938fce3d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e2895b6a567a900e1975b0428b69a8dac7f4d1e9bf09b73f83850b0f4e564c986dfa6bd4a62d1e8f44743a8a940c55ae50b521ceb1983d520d32477574f20a32"}' ========= master_lag: 7.56 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 7 secs) (at 2016-02-11 14:04:47.308236) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-02-11 14:04:47.308670) ========= 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.gqaHBBgDUT/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.8POQZf54KY/Listeners TMPDIR=/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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.004834 ========= master_lag: 1.37 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-02-11 14:04:48.685892) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-11 14:04:48.686252) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-11 14:04:49.062217) ========= ========= Total master_lag: 9.34 =========