builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0150 starttime: 1455748872.51 results: success (0) buildid: 20160217120429 builduid: 032ea9cd8b714d22833e875f71b27ac5 revision: 26578a584f861abfa06f02378a233b77f2a1feec ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-17 14:41:12.514906) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-17 14:41:12.515468) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-17 14:41:12.515757) ========= 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.cPDnxHr68F/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.kti4q2ig3T/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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.005523 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-17 14:41:12.539258) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-17 14:41:12.539569) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-17 14:41:12.557362) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 14:41:12.557758) ========= 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.cPDnxHr68F/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.kti4q2ig3T/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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.005208 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 14:41:12.605883) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-17 14:41:12.606221) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-17 14:41:12.606591) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 14:41:12.606860) ========= 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.cPDnxHr68F/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.kti4q2ig3T/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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-17 14:41:12-- 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% 7.66M=0.002s 2016-02-17 14:41:12 (7.66 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.198693 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 14:41:12.820597) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 14:41:12.820907) ========= 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.cPDnxHr68F/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.kti4q2ig3T/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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.018794 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 14:41:12.870464) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 14:41:12.870808) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 26578a584f861abfa06f02378a233b77f2a1feec --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 26578a584f861abfa06f02378a233b77f2a1feec --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cPDnxHr68F/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.kti4q2ig3T/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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-17 14:41:12,948 truncating revision to first 12 chars 2016-02-17 14:41:12,948 Setting DEBUG logging. 2016-02-17 14:41:12,948 attempt 1/10 2016-02-17 14:41:12,948 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/26578a584f86?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-17 14:41:13,215 unpacking tar archive at: fx-team-26578a584f86/testing/mozharness/ program finished with exit code 0 elapsedTime=0.510075 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 14:41:13.396761) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-17 14:41:13.397166) ========= echo 26578a584f861abfa06f02378a233b77f2a1feec in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'26578a584f861abfa06f02378a233b77f2a1feec'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cPDnxHr68F/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.kti4q2ig3T/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 26578a584f861abfa06f02378a233b77f2a1feec program finished with exit code 0 elapsedTime=0.005035 script_repo_revision: '26578a584f861abfa06f02378a233b77f2a1feec' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-17 14:41:13.446987) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-17 14:41:13.447372) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-17 14:41:13.460432) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-02-17 14:41:13.460854) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.cPDnxHr68F/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.kti4q2ig3T/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 14:41:13 INFO - MultiFileLogger online at 20160217 14:41:13 in /builds/slave/test 14:41:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:41:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:41:13 INFO - {'append_to_log': False, 14:41:13 INFO - 'base_work_dir': '/builds/slave/test', 14:41:13 INFO - 'blob_upload_branch': 'Fx-Team', 14:41:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:41:13 INFO - 'branch': 'Fx-Team', 14:41:13 INFO - 'buildbot_json_path': 'buildprops.json', 14:41:13 INFO - 'config_files': ('talos/mac_config.py',), 14:41:13 INFO - 'default_actions': ('clobber', 14:41:13 INFO - 'read-buildbot-config', 14:41:13 INFO - 'download-and-extract', 14:41:13 INFO - 'populate-webroot', 14:41:13 INFO - 'create-virtualenv', 14:41:13 INFO - 'install', 14:41:13 INFO - 'run-tests'), 14:41:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:41:13 INFO - 'download_minidump_stackwalk': True, 14:41:13 INFO - 'download_symbols': 'ondemand', 14:41:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:41:13 INFO - 'tooltool.py': '/tools/tooltool.py', 14:41:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:41:13 INFO - '/tools/misc-python/virtualenv.py')}, 14:41:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:41:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:41:13 INFO - 'installer_path': 'installer.exe', 14:41:13 INFO - 'log_level': 'info', 14:41:13 INFO - 'log_name': 'talos', 14:41:13 INFO - 'log_to_console': True, 14:41:13 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:41:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:41:13 INFO - 'opt_config_files': (), 14:41:13 INFO - 'pip_index': False, 14:41:13 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:41:13 INFO - 'cmd': ('bash', 14:41:13 INFO - '-c', 14:41:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:41:13 INFO - 'enabled': True, 14:41:13 INFO - 'halt_on_failure': False, 14:41:13 INFO - 'name': 'check_screen_resolution'},), 14:41:13 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:41:13 INFO - 'cmd': ('bash', 14:41:13 INFO - '-c', 14:41:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:41:13 INFO - 'enabled': True, 14:41:13 INFO - 'halt_on_failure': False, 14:41:13 INFO - 'name': 'check_screen_resolution'},), 14:41:13 INFO - 'run_cmd_checks_enabled': True, 14:41:13 INFO - 'sps_profile': False, 14:41:13 INFO - 'sps_profile_interval': 0, 14:41:13 INFO - 'suite': 'dromaeojs', 14:41:13 INFO - 'system_bits': '32', 14:41:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:41:13 INFO - 'title': 't-yosemite-r7-0150', 14:41:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:41:13 INFO - 'use_talos_json': True, 14:41:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:41:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:41:13 INFO - 'work_dir': 'build'} 14:41:13 INFO - ##### 14:41:13 INFO - ##### Running clobber step. 14:41:13 INFO - ##### 14:41:13 INFO - Running pre-action listener: _resource_record_pre_action 14:41:13 INFO - Running main action method: clobber 14:41:13 INFO - rmtree: /builds/slave/test/build 14:41:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:41:14 INFO - Running post-action listener: _resource_record_post_action 14:41:14 INFO - ##### 14:41:14 INFO - ##### Running read-buildbot-config step. 14:41:14 INFO - ##### 14:41:14 INFO - Running pre-action listener: _resource_record_pre_action 14:41:14 INFO - Running main action method: read_buildbot_config 14:41:14 INFO - Using buildbot properties: 14:41:14 INFO - { 14:41:14 INFO - "project": "", 14:41:14 INFO - "product": "firefox", 14:41:14 INFO - "script_repo_revision": "production", 14:41:14 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 14:41:14 INFO - "repository": "", 14:41:14 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 14:41:14 INFO - "buildid": "20160217120429", 14:41:14 INFO - "pgo_build": "False", 14:41:14 INFO - "basedir": "/builds/slave/test", 14:41:14 INFO - "buildnumber": 387, 14:41:14 INFO - "slavename": "t-yosemite-r7-0150", 14:41:14 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 14:41:14 INFO - "platform": "yosemite_r7", 14:41:14 INFO - "scheduler": "tests-fx-team-macosx64-talos", 14:41:14 INFO - "branch": "fx-team", 14:41:14 INFO - "repo_path": "integration/fx-team", 14:41:14 INFO - "revision": "26578a584f861abfa06f02378a233b77f2a1feec", 14:41:14 INFO - "stage_platform": "macosx64", 14:41:14 INFO - "builduid": "032ea9cd8b714d22833e875f71b27ac5", 14:41:14 INFO - "slavebuilddir": "test" 14:41:14 INFO - } 14:41:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/GrXjYC9AQc-KXlZUeJSs-A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 14:41:14 INFO - Running post-action listener: _resource_record_post_action 14:41:14 INFO - ##### 14:41:14 INFO - ##### Running download-and-extract step. 14:41:14 INFO - ##### 14:41:14 INFO - Running pre-action listener: _resource_record_pre_action 14:41:14 INFO - Running main action method: download_and_extract 14:41:14 INFO - mkdir: /builds/slave/test/build/tests 14:41:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:41:14 INFO - https://queue.taskcluster.net/v1/task/GrXjYC9AQc-KXlZUeJSs-A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:41:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrXjYC9AQc-KXlZUeJSs-A/artifacts/public/build/test_packages.json 14:41:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrXjYC9AQc-KXlZUeJSs-A/artifacts/public/build/test_packages.json 14:41:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrXjYC9AQc-KXlZUeJSs-A/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 14:41:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrXjYC9AQc-KXlZUeJSs-A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 14:41:16 INFO - Downloaded 1277 bytes. 14:41:16 INFO - Reading from file /builds/slave/test/build/test_packages.json 14:41:16 INFO - Using the following test package requirements: 14:41:16 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 14:41:16 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:41:16 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 14:41:16 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:41:16 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 14:41:16 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:41:16 INFO - u'jsshell-mac.zip'], 14:41:16 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:41:16 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 14:41:16 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 14:41:16 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:41:16 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 14:41:16 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:41:16 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 14:41:16 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:41:16 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 14:41:16 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 14:41:16 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:41:16 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 14:41:16 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:41:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:41:16 INFO - https://queue.taskcluster.net/v1/task/GrXjYC9AQc-KXlZUeJSs-A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:41:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrXjYC9AQc-KXlZUeJSs-A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 14:41:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrXjYC9AQc-KXlZUeJSs-A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 14:41:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrXjYC9AQc-KXlZUeJSs-A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 14:41:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrXjYC9AQc-KXlZUeJSs-A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:41:17 INFO - Downloaded 17806608 bytes. 14:41:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:41:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 14:41:20 INFO - Return code: 0 14:41:20 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 14:41:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:41:20 INFO - https://queue.taskcluster.net/v1/task/GrXjYC9AQc-KXlZUeJSs-A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:41:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrXjYC9AQc-KXlZUeJSs-A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 14:41:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrXjYC9AQc-KXlZUeJSs-A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 14:41:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrXjYC9AQc-KXlZUeJSs-A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 14:41:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrXjYC9AQc-KXlZUeJSs-A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:41:21 INFO - Downloaded 17806608 bytes. 14:41:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:41:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 14:41:24 INFO - Return code: 0 14:41:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:41:24 INFO - https://queue.taskcluster.net/v1/task/GrXjYC9AQc-KXlZUeJSs-A/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 14:41:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrXjYC9AQc-KXlZUeJSs-A/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 14:41:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrXjYC9AQc-KXlZUeJSs-A/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 14:41:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrXjYC9AQc-KXlZUeJSs-A/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 14:41:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrXjYC9AQc-KXlZUeJSs-A/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 14:41:25 INFO - Downloaded 10707071 bytes. 14:41:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:41:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 14:41:25 INFO - Return code: 0 14:41:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:41:25 INFO - https://queue.taskcluster.net/v1/task/GrXjYC9AQc-KXlZUeJSs-A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 14:41:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrXjYC9AQc-KXlZUeJSs-A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 14:41:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrXjYC9AQc-KXlZUeJSs-A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 14:41:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrXjYC9AQc-KXlZUeJSs-A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 14:41:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrXjYC9AQc-KXlZUeJSs-A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 14:41:28 INFO - Downloaded 111225508 bytes. 14:41:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GrXjYC9AQc-KXlZUeJSs-A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 14:41:28 INFO - mkdir: /builds/slave/test/properties 14:41:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:41:28 INFO - Writing to file /builds/slave/test/properties/build_url 14:41:28 INFO - Contents: 14:41:28 INFO - build_url:https://queue.taskcluster.net/v1/task/GrXjYC9AQc-KXlZUeJSs-A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 14:41:29 INFO - Running post-action listener: _resource_record_post_action 14:41:29 INFO - Running post-action listener: set_extra_try_arguments 14:41:29 INFO - ##### 14:41:29 INFO - ##### Running populate-webroot step. 14:41:29 INFO - ##### 14:41:29 INFO - Running pre-action listener: _resource_record_pre_action 14:41:29 INFO - Running main action method: populate_webroot 14:41:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:41:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:41:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:41:29 INFO - '--tppagecycles', 14:41:29 INFO - '7'], 14:41:29 INFO - 'tests': ['tsvgm']}}, 14:41:29 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:41:29 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:41:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:41:29 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 14:41:29 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:41:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:41:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:41:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:41:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:41:29 INFO - 'talos_options': ['--e10s'], 14:41:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:41:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:41:29 INFO - 'tests': ['damp', 'tps']}, 14:41:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:41:29 INFO - 'talos_options': ['--e10s'], 14:41:29 INFO - 'tests': ['damp', 'tps']}, 14:41:29 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:41:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:41:29 INFO - 'other': {'tests': ['a11yr', 14:41:29 INFO - 'ts_paint', 14:41:29 INFO - 'tpaint', 14:41:29 INFO - 'sessionrestore', 14:41:29 INFO - 'sessionrestore_no_auto_restore']}, 14:41:29 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:41:29 INFO - 'tests': ['a11yr', 14:41:29 INFO - 'ts_paint', 14:41:29 INFO - 'tpaint', 14:41:29 INFO - 'sessionrestore', 14:41:29 INFO - 'sessionrestore_no_auto_restore']}, 14:41:29 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:41:29 INFO - 'tests': ['a11yr', 14:41:29 INFO - 'ts_paint', 14:41:29 INFO - 'tpaint', 14:41:29 INFO - 'sessionrestore', 14:41:29 INFO - 'sessionrestore_no_auto_restore']}, 14:41:29 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:41:29 INFO - 'tests': ['a11yr', 14:41:29 INFO - 'ts_paint', 14:41:29 INFO - 'tpaint', 14:41:29 INFO - 'sessionrestore', 14:41:29 INFO - 'sessionrestore_no_auto_restore']}, 14:41:29 INFO - 'other_l64': {'tests': ['a11yr', 14:41:29 INFO - 'ts_paint', 14:41:29 INFO - 'tpaint', 14:41:29 INFO - 'sessionrestore', 14:41:29 INFO - 'sessionrestore_no_auto_restore']}, 14:41:29 INFO - 'other_nol64': {'tests': ['a11yr', 14:41:29 INFO - 'ts_paint', 14:41:29 INFO - 'tpaint', 14:41:29 INFO - 'sessionrestore', 14:41:29 INFO - 'sessionrestore_no_auto_restore']}, 14:41:29 INFO - 'svgr': {'tests': ['tsvgx', 14:41:29 INFO - 'tsvgr_opacity', 14:41:29 INFO - 'tart', 14:41:29 INFO - 'tscrollx', 14:41:29 INFO - 'cart']}, 14:41:29 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:41:29 INFO - 'tests': ['tsvgx', 14:41:29 INFO - 'tsvgr_opacity', 14:41:29 INFO - 'tart', 14:41:29 INFO - 'tscrollx', 14:41:29 INFO - 'cart']}, 14:41:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:41:29 INFO - 'tests': ['tp5o']}, 14:41:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:41:29 INFO - 'talos_options': ['--e10s'], 14:41:29 INFO - 'tests': ['tp5o']}, 14:41:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:41:29 INFO - 'talos_options': ['--xperf_path', 14:41:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:41:29 INFO - 'tests': ['tp5n']}, 14:41:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:41:29 INFO - 'talos_options': ['--e10s', 14:41:29 INFO - '--xperf_path', 14:41:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:41:29 INFO - 'tests': ['tp5n']}}, 14:41:29 INFO - 'talos.zip': {'path': '', 14:41:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:41:29 INFO - Running post-action listener: _resource_record_post_action 14:41:29 INFO - ##### 14:41:29 INFO - ##### Running create-virtualenv step. 14:41:29 INFO - ##### 14:41:29 INFO - Running pre-action listener: _resource_record_pre_action 14:41:29 INFO - Running main action method: create_virtualenv 14:41:29 INFO - Creating virtualenv /builds/slave/test/build/venv 14:41:29 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:41:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:41:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:41:30 INFO - Using real prefix '/tools/python27' 14:41:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:41:30 INFO - Installing distribute.............................................................................................................................................................................................done. 14:41:33 INFO - Installing pip.................done. 14:41:33 INFO - Return code: 0 14:41:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:41:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:41:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:41:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:41:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:41:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103b6da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b754c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fccc2583fe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a11d30>, '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 0x103835db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a08b20>, '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.cPDnxHr68F/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.kti4q2ig3T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:41:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:41:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:41:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cPDnxHr68F/Render', 14:41:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:41:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:41:33 INFO - 'HOME': '/Users/cltbld', 14:41:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:41:33 INFO - 'LOGNAME': 'cltbld', 14:41:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:41:33 INFO - 'MOZ_NO_REMOTE': '1', 14:41:33 INFO - 'NO_EM_RESTART': '1', 14:41:33 INFO - 'PAGER': '/bin/cat', 14:41:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:41:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:41:33 INFO - 'PWD': '/builds/slave/test', 14:41:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:41:33 INFO - 'SHELL': '/bin/bash', 14:41:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kti4q2ig3T/Listeners', 14:41:33 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 14:41:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:41:33 INFO - 'USER': 'cltbld', 14:41:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:41:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:41:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:41:33 INFO - 'XPC_FLAGS': '0x0', 14:41:33 INFO - 'XPC_SERVICE_NAME': '0', 14:41:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:41:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:41:33 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:41:33 INFO - Cleaning up... 14:41:33 INFO - Return code: 0 14:41:33 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:41:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:41:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:41:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:41:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:41:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103b6da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b754c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fccc2583fe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a11d30>, '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 0x103835db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a08b20>, '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.cPDnxHr68F/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.kti4q2ig3T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:41:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 14:41:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:41:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cPDnxHr68F/Render', 14:41:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:41:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:41:33 INFO - 'HOME': '/Users/cltbld', 14:41:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:41:33 INFO - 'LOGNAME': 'cltbld', 14:41:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:41:33 INFO - 'MOZ_NO_REMOTE': '1', 14:41:33 INFO - 'NO_EM_RESTART': '1', 14:41:33 INFO - 'PAGER': '/bin/cat', 14:41:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:41:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:41:33 INFO - 'PWD': '/builds/slave/test', 14:41:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:41:33 INFO - 'SHELL': '/bin/bash', 14:41:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kti4q2ig3T/Listeners', 14:41:33 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 14:41:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:41:33 INFO - 'USER': 'cltbld', 14:41:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:41:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:41:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:41:33 INFO - 'XPC_FLAGS': '0x0', 14:41:33 INFO - 'XPC_SERVICE_NAME': '0', 14:41:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:41:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:41:34 INFO - Downloading/unpacking psutil>=0.7.1 14:41:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:41:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:41:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:41:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:41:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:41:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:41:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:41:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:41:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:41:36 INFO - Installing collected packages: psutil 14:41:36 INFO - Running setup.py install for psutil 14:41:37 INFO - building 'psutil._psutil_osx' extension 14:41:37 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 14:41:37 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 14:41:37 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 14:41:37 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 14:41:37 INFO - building 'psutil._psutil_posix' extension 14:41:37 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 14:41:37 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:41:37 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:41:37 INFO - ^ 14:41:37 INFO - 1 warning generated. 14:41:37 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 14:41:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:41:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:41:37 INFO - Successfully installed psutil 14:41:37 INFO - Cleaning up... 14:41:37 INFO - Return code: 0 14:41:37 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:41:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:41:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:41:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:41:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:41:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:37 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 0x103b6da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b754c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fccc2583fe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a11d30>, '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 0x103835db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a08b20>, '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.cPDnxHr68F/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.kti4q2ig3T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:41:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 14:41:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:41:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cPDnxHr68F/Render', 14:41:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:41:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:41:37 INFO - 'HOME': '/Users/cltbld', 14:41:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:41:37 INFO - 'LOGNAME': 'cltbld', 14:41:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:41:37 INFO - 'MOZ_NO_REMOTE': '1', 14:41:37 INFO - 'NO_EM_RESTART': '1', 14:41:37 INFO - 'PAGER': '/bin/cat', 14:41:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:41:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:41:37 INFO - 'PWD': '/builds/slave/test', 14:41:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:41:37 INFO - 'SHELL': '/bin/bash', 14:41:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kti4q2ig3T/Listeners', 14:41:37 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 14:41:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:41:37 INFO - 'USER': 'cltbld', 14:41:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:41:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:41:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:41:37 INFO - 'XPC_FLAGS': '0x0', 14:41:37 INFO - 'XPC_SERVICE_NAME': '0', 14:41:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:41:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:41:38 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:41:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:41:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:41:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:41:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:41:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:41:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:41:40 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:41:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:41:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:41:40 INFO - Installing collected packages: mozsystemmonitor 14:41:40 INFO - Running setup.py install for mozsystemmonitor 14:41:40 INFO - Successfully installed mozsystemmonitor 14:41:40 INFO - Cleaning up... 14:41:40 INFO - Return code: 0 14:41:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:41:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:41:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:41:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:41:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:41:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:40 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 0x103b6da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b754c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fccc2583fe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a11d30>, '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 0x103835db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a08b20>, '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.cPDnxHr68F/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.kti4q2ig3T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:41:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:41:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:41:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cPDnxHr68F/Render', 14:41:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:41:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:41:40 INFO - 'HOME': '/Users/cltbld', 14:41:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:41:40 INFO - 'LOGNAME': 'cltbld', 14:41:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:41:40 INFO - 'MOZ_NO_REMOTE': '1', 14:41:40 INFO - 'NO_EM_RESTART': '1', 14:41:40 INFO - 'PAGER': '/bin/cat', 14:41:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:41:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:41:40 INFO - 'PWD': '/builds/slave/test', 14:41:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:41:40 INFO - 'SHELL': '/bin/bash', 14:41:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kti4q2ig3T/Listeners', 14:41:40 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 14:41:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:41:40 INFO - 'USER': 'cltbld', 14:41:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:41:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:41:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:41:40 INFO - 'XPC_FLAGS': '0x0', 14:41:40 INFO - 'XPC_SERVICE_NAME': '0', 14:41:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:41:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:41:41 INFO - Downloading/unpacking blobuploader==1.2.4 14:41:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:41:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:41:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:41:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:41:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:41:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:41:43 INFO - Downloading blobuploader-1.2.4.tar.gz 14:41:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:41:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:41:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:41:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:41:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:41:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:41:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:41:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:41:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:41:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:41:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:41:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:41:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:41:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:41:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:41:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:41:44 INFO - Downloading docopt-0.6.1.tar.gz 14:41:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:41:44 INFO - Installing collected packages: blobuploader, requests, docopt 14:41:44 INFO - Running setup.py install for blobuploader 14:41:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:41:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:41:44 INFO - Running setup.py install for requests 14:41:45 INFO - Running setup.py install for docopt 14:41:45 INFO - Successfully installed blobuploader requests docopt 14:41:45 INFO - Cleaning up... 14:41:45 INFO - Return code: 0 14:41:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:41:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:41:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:41:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:41:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:45 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 0x103b6da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b754c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fccc2583fe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a11d30>, '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 0x103835db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a08b20>, '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.cPDnxHr68F/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.kti4q2ig3T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:41:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:41:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:41:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cPDnxHr68F/Render', 14:41:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:41:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:41:45 INFO - 'HOME': '/Users/cltbld', 14:41:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:41:45 INFO - 'LOGNAME': 'cltbld', 14:41:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:41:45 INFO - 'MOZ_NO_REMOTE': '1', 14:41:45 INFO - 'NO_EM_RESTART': '1', 14:41:45 INFO - 'PAGER': '/bin/cat', 14:41:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:41:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:41:45 INFO - 'PWD': '/builds/slave/test', 14:41:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:41:45 INFO - 'SHELL': '/bin/bash', 14:41:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kti4q2ig3T/Listeners', 14:41:45 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 14:41:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:41:45 INFO - 'USER': 'cltbld', 14:41:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:41:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:41:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:41:45 INFO - 'XPC_FLAGS': '0x0', 14:41:45 INFO - 'XPC_SERVICE_NAME': '0', 14:41:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:41:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:41:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:41:45 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-p6R2lc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:41:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:41:45 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-loUQT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:41:46 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-l_eKzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:41:46 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-H1MvXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:41:46 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-gbKx0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:41:46 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-q4_uuO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:41:46 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-D3HWoW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:41:46 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-DYXgGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:41:46 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-J4bKUh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:41:46 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-4oJXt8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:41:46 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-xJerYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:41:46 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-9xlOdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:41:47 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-VJfuE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:41:47 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-z9seg9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:41:47 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-iVl3mN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:41:47 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-vy0mDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:41:47 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-U05rcC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:41:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:41:47 INFO - Running setup.py install for manifestparser 14:41:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:41:47 INFO - Running setup.py install for mozcrash 14:41:47 INFO - Running setup.py install for mozdebug 14:41:48 INFO - Running setup.py install for mozdevice 14:41:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:41:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:41:48 INFO - Running setup.py install for mozfile 14:41:48 INFO - Running setup.py install for mozhttpd 14:41:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:41:48 INFO - Running setup.py install for mozinfo 14:41:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:41:48 INFO - Running setup.py install for mozInstall 14:41:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:41:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:41:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:41:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:41:48 INFO - Running setup.py install for mozleak 14:41:48 INFO - Running setup.py install for mozlog 14:41:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:41:49 INFO - Running setup.py install for moznetwork 14:41:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:41:49 INFO - Running setup.py install for mozprocess 14:41:49 INFO - Running setup.py install for mozprofile 14:41:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:41:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:41:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:41:49 INFO - Running setup.py install for mozrunner 14:41:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:41:49 INFO - Running setup.py install for mozscreenshot 14:41:49 INFO - Running setup.py install for moztest 14:41:50 INFO - Running setup.py install for mozversion 14:41:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:41:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:41:50 INFO - Cleaning up... 14:41:50 INFO - Return code: 0 14:41:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:41:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:41:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:41:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:41:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:41:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:50 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 0x103b6da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b754c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fccc2583fe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a11d30>, '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 0x103835db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a08b20>, '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.cPDnxHr68F/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.kti4q2ig3T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:41:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:41:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:41:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cPDnxHr68F/Render', 14:41:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:41:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:41:50 INFO - 'HOME': '/Users/cltbld', 14:41:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:41:50 INFO - 'LOGNAME': 'cltbld', 14:41:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:41:50 INFO - 'MOZ_NO_REMOTE': '1', 14:41:50 INFO - 'NO_EM_RESTART': '1', 14:41:50 INFO - 'PAGER': '/bin/cat', 14:41:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:41:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:41:50 INFO - 'PWD': '/builds/slave/test', 14:41:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:41:50 INFO - 'SHELL': '/bin/bash', 14:41:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kti4q2ig3T/Listeners', 14:41:50 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 14:41:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:41:50 INFO - 'USER': 'cltbld', 14:41:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:41:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:41:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:41:50 INFO - 'XPC_FLAGS': '0x0', 14:41:50 INFO - 'XPC_SERVICE_NAME': '0', 14:41:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:41:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:41:50 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-gLALmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:41:50 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:41:50 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-8nMSMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:41:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:41:50 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-_IPyPF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:41:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:41:50 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-Hn2dDQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:41:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:41:50 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-y8FfwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:41:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:41:50 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-Kia8Cs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:41:51 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-0IyYAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:41:51 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-07X3Lo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:41:51 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-RlNugb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:41:51 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-zgCrJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:41:51 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-Wp4LZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:41:51 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-XXDWCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:41:51 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-POL9rt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:41:51 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-yQn23Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:41:51 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-HsBbdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:41:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:41:52 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-V_6zy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:41:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:41:52 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-Q6DEWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:41:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:41:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:41:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:41:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:41:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:41:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:41:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:41:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:41:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:41:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:41:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:41:54 INFO - Downloading blessings-1.6.tar.gz 14:41:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:41:54 INFO - Installing collected packages: blessings 14:41:54 INFO - Running setup.py install for blessings 14:41:54 INFO - Successfully installed blessings 14:41:54 INFO - Cleaning up... 14:41:54 INFO - Return code: 0 14:41:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:41:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:41:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:41:55 INFO - Reading from file tmpfile_stdout 14:41:55 INFO - Current package versions: 14:41:55 INFO - blessings == 1.6 14:41:55 INFO - blobuploader == 1.2.4 14:41:55 INFO - docopt == 0.6.1 14:41:55 INFO - manifestparser == 1.1 14:41:55 INFO - mozInstall == 1.12 14:41:55 INFO - mozcrash == 0.16 14:41:55 INFO - mozdebug == 0.1 14:41:55 INFO - mozdevice == 0.48 14:41:55 INFO - mozfile == 1.2 14:41:55 INFO - mozhttpd == 0.7 14:41:55 INFO - mozinfo == 0.9 14:41:55 INFO - mozleak == 0.1 14:41:55 INFO - mozlog == 3.1 14:41:55 INFO - moznetwork == 0.27 14:41:55 INFO - mozprocess == 0.22 14:41:55 INFO - mozprofile == 0.28 14:41:55 INFO - mozrunner == 6.11 14:41:55 INFO - mozscreenshot == 0.1 14:41:55 INFO - mozsystemmonitor == 0.0 14:41:55 INFO - moztest == 0.7 14:41:55 INFO - mozversion == 1.4 14:41:55 INFO - psutil == 3.1.1 14:41:55 INFO - requests == 1.2.3 14:41:55 INFO - wsgiref == 0.1.2 14:41:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:41:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:41:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:41:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:41:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:55 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 0x103b6da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b754c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fccc2583fe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a11d30>, '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 0x103835db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a08b20>, '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.cPDnxHr68F/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.kti4q2ig3T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:41:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:41:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:41:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cPDnxHr68F/Render', 14:41:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:41:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:41:55 INFO - 'HOME': '/Users/cltbld', 14:41:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:41:55 INFO - 'LOGNAME': 'cltbld', 14:41:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:41:55 INFO - 'MOZ_NO_REMOTE': '1', 14:41:55 INFO - 'NO_EM_RESTART': '1', 14:41:55 INFO - 'PAGER': '/bin/cat', 14:41:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:41:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:41:55 INFO - 'PWD': '/builds/slave/test', 14:41:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:41:55 INFO - 'SHELL': '/bin/bash', 14:41:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kti4q2ig3T/Listeners', 14:41:55 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 14:41:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:41:55 INFO - 'USER': 'cltbld', 14:41:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:41:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:41:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:41:55 INFO - 'XPC_FLAGS': '0x0', 14:41:55 INFO - 'XPC_SERVICE_NAME': '0', 14:41:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:41:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:41:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:41:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:41:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:41:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:41:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:41:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:41:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:41:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:41:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:41:55 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:41:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:41:55 INFO - Cleaning up... 14:41:55 INFO - Return code: 0 14:41:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:41:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:41:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:41:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:41:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:55 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 0x103b6da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b754c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fccc2583fe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a11d30>, '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 0x103835db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a08b20>, '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.cPDnxHr68F/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.kti4q2ig3T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:41:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:41:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:41:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cPDnxHr68F/Render', 14:41:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:41:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:41:55 INFO - 'HOME': '/Users/cltbld', 14:41:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:41:55 INFO - 'LOGNAME': 'cltbld', 14:41:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:41:55 INFO - 'MOZ_NO_REMOTE': '1', 14:41:55 INFO - 'NO_EM_RESTART': '1', 14:41:55 INFO - 'PAGER': '/bin/cat', 14:41:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:41:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:41:55 INFO - 'PWD': '/builds/slave/test', 14:41:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:41:55 INFO - 'SHELL': '/bin/bash', 14:41:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kti4q2ig3T/Listeners', 14:41:55 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 14:41:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:41:55 INFO - 'USER': 'cltbld', 14:41:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:41:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:41:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:41:55 INFO - 'XPC_FLAGS': '0x0', 14:41:55 INFO - 'XPC_SERVICE_NAME': '0', 14:41:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:41:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:41:55 INFO - Downloading/unpacking jsonschema 14:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:41:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:41:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:41:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:41:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:41:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:41:58 INFO - Downloading/unpacking functools32 (from jsonschema) 14:41:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:41:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:41:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:41:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:41:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:41:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:41:58 INFO - Downloading functools32-3.2.3-2.tar.gz 14:41:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:41:58 INFO - warning: no files found matching '*.txt' 14:41:58 INFO - no previously-included directories found matching 'build' 14:41:58 INFO - no previously-included directories found matching 'dist' 14:41:58 INFO - no previously-included directories found matching '.git*' 14:41:58 INFO - Installing collected packages: jsonschema, functools32 14:41:58 INFO - Running setup.py install for functools32 14:41:58 INFO - warning: no files found matching '*.txt' 14:41:58 INFO - no previously-included directories found matching 'build' 14:41:58 INFO - no previously-included directories found matching 'dist' 14:41:58 INFO - no previously-included directories found matching '.git*' 14:41:58 INFO - Successfully installed jsonschema functools32 14:41:58 INFO - Cleaning up... 14:41:58 INFO - Return code: 0 14:41:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:41:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:41:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:41:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:41:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:41:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:58 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 0x103b6da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b754c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fccc2583fe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a11d30>, '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 0x103835db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a08b20>, '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.cPDnxHr68F/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.kti4q2ig3T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:41:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:41:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:41:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cPDnxHr68F/Render', 14:41:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:41:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:41:58 INFO - 'HOME': '/Users/cltbld', 14:41:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:41:58 INFO - 'LOGNAME': 'cltbld', 14:41:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:41:58 INFO - 'MOZ_NO_REMOTE': '1', 14:41:58 INFO - 'NO_EM_RESTART': '1', 14:41:58 INFO - 'PAGER': '/bin/cat', 14:41:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:41:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:41:58 INFO - 'PWD': '/builds/slave/test', 14:41:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:41:58 INFO - 'SHELL': '/bin/bash', 14:41:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kti4q2ig3T/Listeners', 14:41:58 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 14:41:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:41:58 INFO - 'USER': 'cltbld', 14:41:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:41:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:41:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:41:58 INFO - 'XPC_FLAGS': '0x0', 14:41:58 INFO - 'XPC_SERVICE_NAME': '0', 14:41:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:41:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:41:59 INFO - Downloading/unpacking flake8 14:41:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:41:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:41:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:41:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:41:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:41:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:42:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:42:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:42: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 14:42: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 14:42: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 14:42: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 14:42: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 14:42: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 14:42:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:42:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:42: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 14:42: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 14:42: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 14:42: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 14:42: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 14:42: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 14:42:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:42:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:42:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:42:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:42:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:42:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:42:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:42:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:42:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:42:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:42:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:42:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:42:02 INFO - no previously-included directories found matching 'docs/_build' 14:42:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:42:02 INFO - Running setup.py install for pep8 14:42:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:42:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:42:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:42:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:42:02 INFO - no previously-included directories found matching 'docs/_build' 14:42:02 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:42:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:42:02 INFO - Cleaning up... 14:42:02 INFO - Return code: 0 14:42:02 INFO - Running post-action listener: _resource_record_post_action 14:42:02 INFO - Running post-action listener: _start_resource_monitoring 14:42:02 INFO - Starting resource monitoring. 14:42:02 INFO - ##### 14:42:02 INFO - ##### Running install step. 14:42:02 INFO - ##### 14:42:02 INFO - Running pre-action listener: _resource_record_pre_action 14:42:02 INFO - Running main action method: install 14:42:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:42:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:42:03 INFO - Reading from file tmpfile_stdout 14:42:03 INFO - Detecting whether we're running mozinstall >=1.0... 14:42:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:42:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:42:03 INFO - Reading from file tmpfile_stdout 14:42:03 INFO - Output received: 14:42:03 INFO - Usage: mozinstall [options] installer 14:42:03 INFO - Options: 14:42:03 INFO - -h, --help show this help message and exit 14:42:03 INFO - -d DEST, --destination=DEST 14:42:03 INFO - Directory to install application into. [default: 14:42:03 INFO - "/builds/slave/test"] 14:42:03 INFO - --app=APP Application being installed. [default: firefox] 14:42:03 INFO - mkdir: /builds/slave/test/build/application 14:42:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:42:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 14:42:37 INFO - Reading from file tmpfile_stdout 14:42:37 INFO - Output received: 14:42:37 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:42:37 INFO - Running post-action listener: _resource_record_post_action 14:42:37 INFO - ##### 14:42:37 INFO - ##### Running run-tests step. 14:42:37 INFO - ##### 14:42:37 INFO - Running pre-action listener: _resource_record_pre_action 14:42:37 INFO - Running main action method: run_tests 14:42:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:42:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:42:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:42:37 INFO - 2016-02-17 14:42:37.449 screenresolution[2257:15276] starting screenresolution argv=screenresolution get 14:42:37 INFO - 2016-02-17 14:42:37.451 screenresolution[2257:15276] Display 0: 1600x1200x32@60 14:42:37 INFO - 2016-02-17 14:42:37.457 screenresolution[2258:15278] starting screenresolution argv=screenresolution list 14:42:37 INFO - Available Modes on Display 0 14:42:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:42:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:42:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:42:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:42:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:42:37 INFO - Intel Iris: 14:42:37 INFO - Chipset Model: Intel Iris 14:42:37 INFO - Type: GPU 14:42:37 INFO - Bus: Built-In 14:42:37 INFO - VRAM (Dynamic, Max): 1536 MB 14:42:37 INFO - Vendor: Intel (0x8086) 14:42:37 INFO - Device ID: 0x0a2e 14:42:37 INFO - Revision ID: 0x0009 14:42:37 INFO - Displays: 14:42:37 INFO - Display: 14:42:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:42:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:42:37 INFO - Display Serial Number: 1600x1200 60 14:42:37 INFO - Main Display: Yes 14:42:37 INFO - Mirror: Off 14:42:37 INFO - Online: Yes 14:42:37 INFO - Rotation: Supported 14:42:37 INFO - Return code: 0 14:42:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:42:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:42:37 INFO - Python 2.7.3 14:42:37 INFO - Return code: 0 14:42:37 INFO - grabbing minidump binary from tooltool 14:42:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:42:37 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 0x103a11d30>, '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 0x103835db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a08b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:42:37 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:42:37 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 14:42:37 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:42:37 INFO - Return code: 0 14:42:37 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:42:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:42:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:42:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:42:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:42:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:42:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:42:39 INFO - Return code: 0 14:42:39 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', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GrXjYC9AQc-KXlZUeJSs-A/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0150', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:42:39 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 --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GrXjYC9AQc-KXlZUeJSs-A/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0150 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:42:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cPDnxHr68F/Render', 14:42:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:42:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:42:39 INFO - 'HOME': '/Users/cltbld', 14:42:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:42:39 INFO - 'LOGNAME': 'cltbld', 14:42:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:42:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:42:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:42:39 INFO - 'MOZ_NO_REMOTE': '1', 14:42:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:42:39 INFO - 'NO_EM_RESTART': '1', 14:42:39 INFO - 'PAGER': '/bin/cat', 14:42:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:42:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:42:39 INFO - 'PWD': '/builds/slave/test', 14:42:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:42:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:42:39 INFO - 'SHELL': '/bin/bash', 14:42:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kti4q2ig3T/Listeners', 14:42:39 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 14:42:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:42:39 INFO - 'USER': 'cltbld', 14:42:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:42:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:42:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:42:39 INFO - 'XPC_FLAGS': '0x0', 14:42:39 INFO - 'XPC_SERVICE_NAME': '0', 14:42:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:42:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GrXjYC9AQc-KXlZUeJSs-A/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0150', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:42:39 INFO - mozversion application_buildid: 20160217120429 14:42:39 INFO - mozversion application_changeset: 26578a584f861abfa06f02378a233b77f2a1feec 14:42:39 INFO - mozversion application_display_name: Nightly 14:42:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:42:39 INFO - mozversion application_name: Firefox 14:42:39 INFO - mozversion application_remotingname: firefox 14:42:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:42:39 INFO - mozversion application_vendor: Mozilla 14:42:39 INFO - mozversion application_version: 47.0a1 14:42:39 INFO - mozversion platform_buildid: 20160217120429 14:42:39 INFO - mozversion platform_changeset: 26578a584f861abfa06f02378a233b77f2a1feec 14:42:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:42:39 INFO - mozversion platform_version: 47.0a1 14:42:39 INFO - using testdate: 1455748959 14:42:39 INFO - actual date: 1455748959 14:42:39 INFO - starting webserver on 'localhost:49685' 14:42:39 INFO - SUITE-START | Running 2 tests 14:42:39 INFO - TEST-START | dromaeo_css 14:42:39 INFO - operating with platform_type : mac_ 14:42:39 INFO - Initialising browser for dromaeo_css test... 14:42:39 INFO - TEST-INFO | started process 2276 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/tmp2KCXve/profile http://localhost:49685/getInfo.html) 14:42:41 INFO - PROCESS | 2276 | __metrics Screen width/height:1600/1200 14:42:41 INFO - PROCESS | 2276 | colorDepth:24 14:42:41 INFO - PROCESS | 2276 | Browser inner width/height: 1024/689 14:42:41 INFO - PROCESS | 2276 | __metrics 14:42:42 INFO - PROCESS | 2276 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:42:42 INFO - PROCESS | 2276 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:42:42 INFO - TEST-INFO | 2276: exit 0 14:42:42 INFO - Browser initialized. 14:42:42 INFO - Running cycle 1/1 for dromaeo_css test... 14:42:42 INFO - TEST-INFO | started process 2279 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/tmp2KCXve/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:42:54 INFO - PROCESS | 2279 | RSS: Main: 244445184 14:42:54 INFO - PROCESS | 2279 | 14:43:45 INFO - PROCESS | 2279 | 1455749025545 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:45:55 INFO - PROCESS | 2279 | Cycle 1(1): loaded http://localhost:49685/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49685/tests/dromaeo/cssquery-ext.html) 14:45:57 INFO - PROCESS | 2279 | RSS: Main: 324104192 14:45:57 INFO - PROCESS | 2279 | 14:48:59 INFO - PROCESS | 2279 | Cycle 1(1): loaded http://localhost:49685/tests/dromaeo/cssquery-ext.html (next: http://localhost:49685/tests/dromaeo/cssquery-jquery.html) 14:49:00 INFO - PROCESS | 2279 | RSS: Main: 378015744 14:49:00 INFO - PROCESS | 2279 | 14:52:02 INFO - PROCESS | 2279 | Cycle 1(1): loaded http://localhost:49685/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49685/tests/dromaeo/cssquery-mootools.html) 14:52:03 INFO - PROCESS | 2279 | RSS: Main: 375623680 14:52:03 INFO - PROCESS | 2279 | 14:55:05 INFO - PROCESS | 2279 | Cycle 1(1): loaded http://localhost:49685/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49685/tests/dromaeo/cssquery-prototype.html) 14:55:05 INFO - PROCESS | 2279 | RSS: Main: 369983488 14:55:05 INFO - PROCESS | 2279 | 14:58:08 INFO - PROCESS | 2279 | Cycle 1(1): loaded http://localhost:49685/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49685/tests/dromaeo/cssquery-yui.html) 14:58:09 INFO - PROCESS | 2279 | RSS: Main: 338046976 14:58:09 INFO - PROCESS | 2279 | 15:01:12 INFO - PROCESS | 2279 | Cycle 1(1): loaded http://localhost:49685/tests/dromaeo/cssquery-yui.html (next: http://localhost:49685/tests/dromaeo/cssquery-dojo.html) 15:01:12 INFO - PROCESS | 2279 | RSS: Main: 391892992 15:01:12 INFO - PROCESS | 2279 | 15:01:12 INFO - PROCESS | 2279 | __start_tp_report 15:01:12 INFO - PROCESS | 2279 | _x_x_mozilla_page_load 15:01:12 INFO - PROCESS | 2279 | _x_x_mozilla_page_load_details 15:01:12 INFO - PROCESS | 2279 | |i|pagename|runs| 15:01:12 INFO - PROCESS | 2279 | |0;dojo.html;2981.403719256149;3393.5079413485046;3415.45352743561;3429.988153494719;3475.7566970312087;5486.478784515474;5543.501084902358;5559.777608895644;5563.221149039133;5587;5547.223388725582;5547.472990065938;5564.8052318168775;5689.772409103631;5692.146178073291;4981.452040275567;5015.272785446117;5033;5045;5191.5327620514145;5126.641135120543;5131.435542090367;5145.408278048035;5156.535911767959;5184.248283998818;4985.451600323961;5053.974730126326;5087.364079490082;5108.923366149511;5140.897182056338;5086.92369614456;5099.71951542665;5104.795808167669;5106.183010718267;5132.820351287687;4974.42794078682;5045.5459008689395;5058.165402708549;5066.392032956069;5077.416097148838;5406.567474602022;5498.202760599691;5499.477549632778;5561.63849349791;5598.1322894951345;6089.634621922699;6093.329733729286;6098.481629061535;6133.754649814002;6138.693065346715;6040.607360521596;6109.358517355702;6173.444390004921;6182.010878259502;6183.81448556544;5587.55299576037;5600.52395546379;5673.716314184316;5692.203091567184;5699.116636921284;6062.393760623902;6250.406211409909;6251.3123556408755;6256.280527739277;6265.530085243625;5868.325142608569;5887.411258874078;5960.046392577166;5960.701964901824;5967.16459695643;6010.939890601038;6101.877962440726;6132.478739307119;6157.692115394212;6160.907586386208;6087.043024123353;6113.841195312599;6128.411459112376;6131.804871721949;6132.049587189092;5966.31387390447;6122.846928826815;6130.111133885562;6141.385861413823;6141.57009009374;4781.067691800135;4790.377250957354;4848.12733707936;4853.39332583427;4871.707697538159;4245.68157388191;4255.957440425618;4274.059706864485;4288.871333859989;4317.9136417271475;5573.7770489179975;5634;5656.179853921159;5663.235463212413;5708.942910570924;6001.789937352171;6117.736059405574;6144.463884028993;6186.597871138361;6192.721327540272;5653.4629210225785;5666.291713535808;5669.262995810518;5669.376368599451;5692;5188.481151884781;5277.498637629419;5295.443978382292;5302.655327403706;5311.256424100629;6142.191841058483;6225.906611400742;6231.906521402183;6236.719347629459;6243;6122.714230011569;6165.876682466236;6177.938220617916;6184.072389141665;6212;6149.385061493815;6225.3774622537385;6225.875482490415;6231.844203894939;6261.029540421242;6060.969695151496;6095.634261944298;6103.246756470893;6136.151476879722;6144.631322120687;6117.938820611737;6131.448169664752;6155.138280640804;6176.969115154575;6188.535859810622;4836.975815120902;5823.272090988627;5978.940210597838;6005.849853753691;6019.247594050744;5932.8813423732145;5977.551683623658;5981.551383646331;5989.281286245504;6018.247719035121;5755.165501002415;5811.680357580373;5828.737706803289;5839.299284085937;5849.473547380756;5092.490750924878;5803.535717142703;5863.442972917566;5962.314333851663;6030.336662966983;5807.82576522705;5816.970915145397;5817.0111081115465;5825.679587622722;5826.41735826414 15:01:12 INFO - PROCESS | 2279 | |1;ext.html;458.9948013849669;487.4272729542791;504.04735050754067;554.8653004605582;555.9888802223953;25559.10543130991;29682;29715.702842971565;36975.445368319495;38022.8098859506;40078.799606002;40550.797246013804;40653;40653.18693626133;40794;9464.858027129581;9703.90296097037;9708;9723.319367644268;9743.756406089833;8470.32237421008;9429.952850235773;9474.815648043994;9583.808323833518;9589.472579008152;9668.129868311851;9758.316917815755;9762.609495620167;9767.462789546573;9794.951025244864;9648.614055437809;9718.416894986323;9748.757785709291;9749.951250243703;9751.3661611995;8434.915650843473;9582.90417095827;9650.71047868565;9719.708408747749;9742.707718768377;38745.80627096847;39190.80404597987;39211.019724506834;39246.01884952871;39292.21415571701;3079.507278835398;3158.1315138336913;3585.31878943;3767.3972164453558;3806.4480650305827;27743.306417339525;28265.293367665767;28633.856830715922;28970.27574310638;29164.270893227625;2792.3577577157166;2837.730415610514;2841.4317136572563;2855.271905664042;2982.3140677644046;359798;362038;362345;363079.1846040753;481113.9999999965;45352.54647453549;64626;65245.67377163179;65365.673171634786;65485;62915.370846291866;63400.51297178607;63479;63533.36466635367;63600;14814.925925370304;15015.774763378558;15722.978006429545;16002.75995860063;16009.759853602205;11011.504482298316;11200.719982000515;12527.93736031314;12569.685757856127;12701.428435720414;19865;20210.29263975754;20218.989050547414;20237.797622023885;20252.493687657632;8524.862099288503;8624.956875215585;8630.352723545759;8670.263027642595;8739.344549158839;867.8741582470507;925.8287216864901;931.7577429868147;969.888462826784;1046.9685909422728;27388.863055684593;30394.39211215763;30510;30526.847365763475;31042.223944401117;960.8943016268205;1006.5822683586376;1057.9418132002813;1134.8638163420442;1146.2377518949972;14274.2149181796;14389.78415323771;14408.639784005483;14529.982901196814;14600.634984125481;658989;667453.6627316832;668983;670356;671098;55248.447515525135;55738.44261557414;55772.44227557754;55892.72053639787;55893.720531397084;1276.3363051213316;1373.7183877305129;1389.6664800448023;1398.4895513137835;1411.760000799887;24415.51168976646;28328.866845325956;28862.855685721435;29516.262093447836;29521.85239073791;45387;46464.303035455174;46915.29627055665;47133.29300060433;47188;574022;659120;667341;668124;669101;25887;26243.60634590521;31329.216769580944;32285;32302.676973229965;41985.58014419939;42242;42249.78875105728;42790.57209427866;43589.69230923078;34492.82753586216;35360.46959295561;35892.461613075306;36090;36271.455928161624;35467;35685.1078723034;36391.36238869204;37483.81258093692;37529.6247037537;36582.45126323054;36730.8163459181;37612.05969850776;37646.435303471015;37755.62244377521;29705.10884673463;31256.21859453532;32589.837050814593;33265.83367083246;33274;23508.764912350656;23823.52352952966;23984.52030959406;24123.51752964966;24943.750562494144 15:01:12 INFO - PROCESS | 2279 | |2;jquery.html;307.9276370053037;314.25835029330784;358.61090716572517;359.67269784496114;372.0494137478741;14847.703045939075;15196.31616577254;15510.612234694137;18953.52616184596;19928.302509412173;11622.07023438125;11856.170068095236;16418.589535261624;19091.61816763664;19118.808811911877;5172.19830926207;5362.8123015694455;5371.140617501201;5373.194020896858;5376.1398176291805;3976.741511801738;4138.0689344897455;5332.693490094932;5393.622446428752;5712.742926568294;5887.61730487517;5934.139549765281;5935.28776546815;5947.078202878561;5949.5537834662355;6288.559800813945;6409.327020662833;6457.903131453032;6458.225012998423;6471.3528647135145;5439.836804895859;5606.635568688063;5606.971965140148;5615.2700148980375;5678.9432105678825;23707.28878133659;23982;23997.88001060001;24793.876030619733;24811.751882481305;2032.3801240621603;2051.748433455591;2352.976455241975;2695.3560618129686;2743.670759508872;9527.52362381878;9577.281703872168;10139.54372053252;12385;14587.27063646824;1769.195016267595;1772.3708083630254;1785.3929663914332;1791.1492041280417;1802.4232245681387;102917.48541257321;103473;103808;105591;107303;11167.162462815322;11236.887631123747;11240.437978101063;11297.943510282395;11396.031337336253;13456.932715336361;13619.319034048258;13628.93185534066;13635.522756703665;13650.385732642055;8384.748457546284;8427.662893484314;8446.239838414573;8532.8720069199;8559.957200214083;8546.316294696533;8560.186782255676;8561.143885611513;8651.307895368482;8657.52383618907;4360.781960902005;4398.252297109435;4444.28891377378;4449.354843547732;4456.600912726128;1696.2960371445959;1791.7939436964655;1799.2712951254762;1856.647237024961;1870.1771220662865;792.4730054513799;856.1866227084295;946.5882341181608;946.9819943560562;983.1201075037944;16685.49943501697;19078;19140.712889306673;19158.521036973907;19328.71006934897;776.7863837444748;848.1942154952819;884.8628462588309;885.1148851148852;915.7390143809116;10447.111995480318;10690.144788417063;10726.731831704114;10745.409002504937;10778.29941053829;545509;549067;735527.5895450184;740984;743409;110660;113266;115404.42297788625;117242;120782.99999999824;1122.607087519378;1183.958561450345;1189.7620475904853;1189.9762004759857;1213.150794443893;18831.435056948314;19027.524311892314;19041.42875713731;19245.32641357602;19272.710909336092;40187.59812401838;53842.73078634582;54117.45882541124;54121;54578;76632.23367766252;76955;77163.61418192873;77929;79198;7467.701291948479;7881.684732610632;7910.248526389983;7928.643211055632;7945.20547945224;8125.593720314079;10350.343944968768;12436.564720234748;12649.810252846399;12665.493380265054;10342.586296548054;10734.087602553871;10737.248392612442;10869.184811139354;10994.945025274823;7180.856382872418;10314.535845886803;10674;10723.517441714985;10822.67531974042;10798.352098874093;10997.010269075821;11007.83488247693;11026.724331891766;11109.666709998713;7622.8094297643;7798.454108212371;7817.101033381006;7829.765107046797;7850.960745196237;9994.900050999688;10290.794184116126;10483.318584291997;10898.964598363144;11050.281731687415 15:01:12 INFO - PROCESS | 2279 | |3;mootools.html;1383.3498255819761;1524.9008814427063;1526.9083854968699;1734.7397890316452;1903.2957805611925;7776.883346749803;8384.83230335393;8551.74344769658;8557.871631925525;8563.100874408176;8217.342612590994;8487.618057187427;8491.702790402338;8492.065872753992;8494.235518803307;2100.2544096845627;2137.1237792505076;2171.9022643981057;2366.9763302366973;2435.318110928934;2181.836362272828;2187.048633844283;2189.8467107302495;2402.1952645863657;2437.7196622388387;2341.086976079322;2384.7853693167613;2385.2367242482414;2387.868667223302;2392.760723927611;2403.267003563912;2403.687520622308;2406.38637147528;2406.422458609921;2407.434252950555;2334.97665023351;2343.4610039690965;2401.03958416633;2401.987990060056;2405.795507381875;8554.230119289232;8612.913870861274;8614.353923455703;8617.01808584023;8664.306855451548;5224.085784987612;5411.269478620376;5413.783448662049;5423.891522169534;5426.321709786277;3541.3448512025357;3568.3041806847673;3690.280395322913;3707.925841483182;3711.9814400928094;1036.1400037968467;1049.543448599854;1064.356064580925;1075.1774892207468;1075.9139268858473;11696.47365868538;11702.648920532398;11706.824397634042;11709.765804683944;11710.414479276002;4729.858104256878;4781;4852;4867.634927380461;4876.21980483121;10031.79300553877;10044.899551004542;10049.196064314838;10051.497425128715;10062.245331600014;5354.571634269249;5366.570674346043;5374.167004114369;5378.677279363251;5381.515663590296;4837.322774811459;4882.170031094723;4885.438174609965;4886.780094895738;4889.339939108246;3574.6782789549065;3866.5360156780803;3906.199229158016;3924;3950.111224974358;1188.8038473651923;1250.443552619094;1260.4580030586935;1272.1794442584667;1272.3511009385095;1105.2649987758211;1286.292539103508;1303.302733037839;1326.5025615394227;1331.8867896228735;7945.761627151194;8015.276715506194;8021.997250343707;8031.839363212703;8033.919660803434;1173.3077484284313;1178.776032553812;1184.585395111704;1215.21011342628;1215.6535387414544;6094.695265236721;6187.81436556904;6263.655498947511;6270.9372906270355;6281.811545653638;10093.69718908434;10485.318454300446;10616.787664246673;10727.356358618352;10736.194785391126;10210.387376757419;10513.106385957279;10579.365238085586;10582.047615714622;10606.787864242671;8122.55325957078;8237.423380363318;8256.298214651702;8259.463134896332;8260.752177434686;7610.467267291237;7753.4960227585025;7805.921940780519;7853.842923141619;7864.685412583662;9278.58246378928;9542.236621070437;9636.614535418785;9646.807063858543;9662.275329350186;9633.710988670071;9784.119429251117;9796.804063918824;9939.155171810477;9964.256255155175;6844.589324640538;6902.896456553055;6983.96508017477;7019.403350715246;7041.366277035091;7264.854702906018;7439.293267139613;8016.158303378062;8085.83828323442;8117.350611950912;6624.436922861418;7497.662605182671;7500.8499830002;7513.849723005618;7665.425093117927;7346.96326518364;7489.475736698379;7498.887516687363;7517.812054698457;7615.4669173157345;7406.555606663402;7611.467197296136;7613.238676132342;7620.314171724572;7621;6828.214755303204;6878.415334696607;6897.7585784497305;6969.895451568129;6983.127109111361;7031.718731250693;7078.8938165928585;7146.571205727673;7162.498625096402;7169.7849064528145 15:01:12 INFO - PROCESS | 2279 | |4;prototype.html;315.7631776167874;317.2702783597726;324.1022368040526;328.1877353549964;329.7115024353692;6498.382653647902;6519.21769387673;6559.147310849595;6611.338866113386;6623.470122390209;6133.233345831771;6255.749770009205;6301.054841773736;6353.934971134377;6457.9677101614425;4806.062817750549;4811.663183577151;4829.541193586604;4836.564709176174;4843.249296359052;4818.421789385278;4820.108279968217;4823.614110871122;4828.2274836026245;4845.466998630148;4483.080968401486;4559;4639.164950308943;4672.766361681903;4776.164171270031;4623.352730617717;4665.230237010889;4678.228092364756;4686.554777296168;4716.127516409441;4019.155977244782;4034.11249525104;4040.272750904836;4045.9595404045876;4046.77742724153;6065.181200537915;6161.383861613847;6211.937880621181;6214.0989556514505;6215.658138802364;4527.796249168795;5491.670499770026;5576.944230557683;5585.329760428734;5589.441055894418;6766.120404347453;6777.186737591472;6796.844536428819;6798.728050877959;6799.082123913307;3754.718396120302;4549.044700612875;4551.726896386227;4575.153596584642;4576.405067341258;5793.681347525884;6956.721731130749;7229.1686456057705;7231.421486281085;7238.565686058853;4663.020765639254;4666.416697912761;4670.159371313128;4672.345871577982;4676.3453116563705;4753.714777113384;4754.857354279377;4765.8093676252565;4765.833195838129;4768.332433459318;5609.382967873531;5621.690807005572;5622.32532096151;5624.156376543551;5644.57665675076;6225.719842607094;6604.174478190226;6869.896951545731;6870.828229294208;6891.552049116792;1629.283115429231;1657.2873664324457;1657.8507934285972;1661.252436403599;1668.5661727950578;878.8989266234337;1072.828347464402;1079.924405291622;1088.9509972051276;1102.7408558988632;6473.514486413538;6474.514411419163;6479.708413121421;6484.059811327331;6493.70778314977;7131;7154.642267886585;7158.2483839197175;7165.605891675904;7174.461915356264;5201;6234.848977102893;6420.711068001951;6565.343465653492;6567.277599464151;3791.7914514701406;3800.467934489174;3836.0218144373007;3842.558105817867;3845.538535375773;7387.963060184665;7575.0909890813455;7582.014338136007;7598.696052157962;7616.352610028099;7439.293267139721;7443.85112297751;7466.589337586376;7469.589172595451;7489.925100749032;7572.545647261182;7578.317951384402;7582.952602797214;7585.924140758632;7589.810254743676;7065.6113913735235;7251.1298644163035;7253.8186545336785;7254.455915806441;7254.927450725425;7123.145222573117;7135.785926422215;7143.357097861218;7145.1425828900865;7157.141143062866;6491;7234.55308938204;7547.773566793005;7566.659500322388;7569.962150189434;4620.722756634613;4720.881977950578;4740.9051818962735;4755.928661070156;4771.4512831023485;7202.53183543068;7206.207317195209;7208.71165153388;7216.458765592706;7230.060092187982;6987.336203060701;7004.264552221944;7007.089078419976;7007.614581198083;7011.509194356346;6806.183258008872;6976.372126508639;7004.474664400293;7004.824879378057;7009.474289428212;6841.144856892888;6842.623655698785;6852.040714300102;6853.314668533107;6854.931450685429;6813.557118787263;6961.825954351182;6973.640140172618;6974.442044636518;6991.720331186695;6844.665290268549;6847.315268473312;6853.383195512428;6856.314368563104;6857.177138743184 15:01:12 INFO - PROCESS | 2279 | |5;yui.html;621.7761605821903;627.987440251195;664.9925363074939;704.4118161335285;760.0309605253301;14874.181919994397;14904.850951490482;15068.020578662394;15108.017978831369;15191;13760.243186624732;14005.159690418583;14016.64958376041;14018.228997405138;14027;726.6112629743088;739.9371053460462;872.6334939325483;891.6789955615973;892.4734406700046;862.6118246788939;884.7522693645757;895.1898531828706;896.5786080542135;896.8834051573319;934.4626839567242;936.0452338614609;936.9531523423835;936.9531523423835;943.5848226780229;748.9812754681122;757.4357103957532;919.0717375450776;926.0091701878993;934.9528528048561;673.2157037051828;682.5699809120272;683.480554778367;690.1855810144028;695.8503921656868;14671.77992330116;14704.411823527045;14712.117272963656;14753.631159220999;14764.187969661665;12454.688632784253;12562.246265224116;12572.622821315375;13140.211587304791;13278.66803329915;9990.254380556478;10170.186385089175;10181.79636407275;10184.796304073878;10212.2851400402;3489.8080605566684;3525.5240542526944;3525.770824896399;3540.3804334241663;3542.3446662367546;76776.23223767802;78815.6059219706;80416.99999999942;82688.58655706682;87561.24877502414;9388.436693798394;9417.482038487811;9429.48137852411;9519.666811661558;9787.608495660237;20701.378958631267;20706.171753129707;20706.96465176735;20733;20779.376618701463;7572;7580.8483830324185;7584.469087163846;7660;7819.687212511436;4137.731047481904;4152.563980782034;4174.060836311805;4191.790410479463;4210.494740631083;3486.9128271793406;3548.3790336690977;3551.6093229744706;3552.8045957472586;3553.129483276614;549.4423160492104;625.4777260987127;635.5138319185827;638.0747915522511;656.980290591283;492.6674494716052;519.5531842615347;548.2707998362168;552.1524459953952;610.5817515002237;8507.319414446829;8611.913880861111;8614.18165274298;8621.956890215508;8714.52070136136;506.3746273352407;534.4762133109574;620.5780069552748;621.2762132116125;623.2707731953625;3892.5523564789846;4002.939955900664;4095.180963807191;4152.647025002909;4180.339634034669;92797;93174;95115.52442237745;95315;95523.52238238764;66642.66678666673;74254;81614.59192704117;83896.58051709703;85147;69634.65182674055;70333.64833175801;70894.64552677306;71053.2894671057;72687.27312726805;7305.488615796843;8987.865182022144;9010.729678109667;9062.733994178412;9231.307651925998;48256.517434825204;49824.25263620976;50320.74839625778;52812;53196.46803531915;64427;70031;71545;71610;71623.64188179026;8791.012573469388;9965.35225210359;10076.546555404877;10111.140553052779;10249.846252306072;11405.657830265105;12088.879111208775;12114.818277725664;12398.504059837865;12584.119111662096;10683.465826708789;11245.550177992789;11276.605318813803;11303.92612701792;11594.6521604352;11344.943275283571;11345.092392608736;11386.658400248005;11766.58816941403;11840;11314.60398886035;11581.536738530702;11648.184627076362;11799.941000295286;11889.167758256839;9541.809163816824;9613.182879455046;9842.45866477322;9925.65260215889;9970.700878973643;9797.363171393836;10010.249231307535;10042.9957004299;10051.246156538142;10067.84898226542 15:01:12 INFO - PROCESS | 2279 | __end_tp_report 15:01:12 INFO - PROCESS | 2279 | __start_cc_report 15:01:12 INFO - PROCESS | 2279 | _x_x_mozilla_cycle_collect,1077 15:01:12 INFO - PROCESS | 2279 | __end_cc_report 15:01:12 INFO - PROCESS | 2279 | __startTimestamp1455750072564__endTimestamp 15:01:12 INFO - PROCESS | 2279 | 15:01:12 INFO - PROCESS | 2279 | ------- Summary: start ------- 15:01:12 INFO - PROCESS | 2279 | Number of tests: 6 15:01:12 INFO - PROCESS | 2279 | 15:01:12 INFO - PROCESS | 2279 | [#0] dojo.html Cycles:165 Average:5624.48 Median:5817.01 stddev:637.77 (11.0%) stddev-sans-first:605.08 15:01:12 INFO - PROCESS | 2279 | Values: 2981.4 3393.5 3415.5 3430.0 3475.8 5486.5 5543.5 5559.8 5563.2 5587.0 5547.2 5547.5 5564.8 5689.8 5692.1 4981.5 5015.3 5033.0 5045.0 5191.5 5126.6 5131.4 5145.4 5156.5 5184.2 4985.5 5054.0 5087.4 5108.9 5140.9 5086.9 5099.7 5104.8 5106.2 5132.8 4974.4 5045.5 5058.2 5066.4 5077.4 5406.6 5498.2 5499.5 5561.6 5598.1 6089.6 6093.3 6098.5 6133.8 6138.7 6040.6 6109.4 6173.4 6182.0 6183.8 5587.6 5600.5 5673.7 5692.2 5699.1 6062.4 6250.4 6251.3 6256.3 6265.5 5868.3 5887.4 5960.0 5960.7 5967.2 6010.9 6101.9 6132.5 6157.7 6160.9 6087.0 6113.8 6128.4 6131.8 6132.0 5966.3 6122.8 6130.1 6141.4 6141.6 4781.1 4790.4 4848.1 4853.4 4871.7 4245.7 4256.0 4274.1 4288.9 4317.9 5573.8 5634.0 5656.2 5663.2 5708.9 6001.8 6117.7 6144.5 6186.6 6192.7 5653.5 5666.3 5669.3 5669.4 5692.0 5188.5 5277.5 5295.4 5302.7 5311.3 6142.2 6225.9 6231.9 6236.7 6243.0 6122.7 6165.9 6177.9 6184.1 6212.0 6149.4 6225.4 6225.9 6231.8 6261.0 6061.0 6095.6 6103.2 6136.2 6144.6 6117.9 6131.4 6155.1 6177.0 6188.5 4837.0 5823.3 5978.9 6005.8 6019.2 5932.9 5977.6 5981.6 5989.3 6018.2 5755.2 5811.7 5828.7 5839.3 5849.5 5092.5 5803.5 5863.4 5962.3 6030.3 5807.8 5817.0 5817.0 5825.7 5826.4 15:01:12 INFO - PROCESS | 2279 | 15:01:12 INFO - PROCESS | 2279 | [#1] ext.html Cycles:180 Average:69232.99 Median:20761.51 stddev:156269.82 (752.7%) stddev-sans-first:156622.88 15:01:12 INFO - PROCESS | 2279 | Values: 459.0 487.4 504.0 554.9 556.0 25559.1 29682.0 29715.7 36975.4 38022.8 40078.8 40550.8 40653.0 40653.2 40794.0 9464.9 9703.9 9708.0 9723.3 9743.8 8470.3 9430.0 9474.8 9583.8 9589.5 9668.1 9758.3 9762.6 9767.5 9795.0 9648.6 9718.4 9748.8 9750.0 9751.4 8434.9 9582.9 9650.7 9719.7 9742.7 38745.8 39190.8 39211.0 39246.0 39292.2 3079.5 3158.1 3585.3 3767.4 3806.4 27743.3 28265.3 28633.9 28970.3 29164.3 2792.4 2837.7 2841.4 2855.3 2982.3 359798.0 362038.0 362345.0 363079.2 481114.0 45352.5 64626.0 65245.7 65365.7 65485.0 62915.4 63400.5 63479.0 63533.4 63600.0 14814.9 15015.8 15723.0 16002.8 16009.8 11011.5 11200.7 12527.9 12569.7 12701.4 19865.0 20210.3 20219.0 20237.8 20252.5 8524.9 8625.0 8630.4 8670.3 8739.3 867.9 925.8 931.8 969.9 1047.0 27388.9 30394.4 30510.0 30526.8 31042.2 960.9 1006.6 1057.9 1134.9 1146.2 14274.2 14389.8 14408.6 14530.0 14600.6 658989.0 667453.7 668983.0 670356.0 671098.0 55248.4 55738.4 55772.4 55892.7 55893.7 1276.3 1373.7 1389.7 1398.5 1411.8 24415.5 28328.9 28862.9 29516.3 29521.9 45387.0 46464.3 46915.3 47133.3 47188.0 574022.0 659120.0 667341.0 668124.0 669101.0 25887.0 26243.6 31329.2 32285.0 32302.7 41985.6 42242.0 42249.8 42790.6 43589.7 34492.8 35360.5 35892.5 36090.0 36271.5 35467.0 35685.1 36391.4 37483.8 37529.6 36582.5 36730.8 37612.1 37646.4 37755.6 29705.1 31256.2 32589.8 33265.8 33274.0 23508.8 23823.5 23984.5 24123.5 24943.8 15:01:12 INFO - PROCESS | 2279 | 15:01:12 INFO - PROCESS | 2279 | [#2] jquery.html Cycles:180 Average:35589.85 Median:24395.88 stddev:110759.38 (454.0%) stddev-sans-first:111038.40 15:01:12 INFO - PROCESS | 2279 | Values: 307.9 314.3 358.6 359.7 372.0 14847.7 15196.3 15510.6 18953.5 19928.3 11622.1 11856.2 16418.6 19091.6 19118.8 5172.2 5362.8 5371.1 5373.2 5376.1 3976.7 4138.1 5332.7 5393.6 5712.7 5887.6 5934.1 5935.3 5947.1 5949.6 6288.6 6409.3 6457.9 6458.2 6471.4 5439.8 5606.6 5607.0 5615.3 5678.9 23707.3 23982.0 23997.9 24793.9 24811.8 2032.4 2051.7 2353.0 2695.4 2743.7 9527.5 9577.3 10139.5 12385.0 14587.3 1769.2 1772.4 1785.4 1791.1 1802.4 102917.5 103473.0 103808.0 105591.0 107303.0 11167.2 11236.9 11240.4 11297.9 11396.0 13456.9 13619.3 13628.9 13635.5 13650.4 8384.7 8427.7 8446.2 8532.9 8560.0 8546.3 8560.2 8561.1 8651.3 8657.5 4360.8 4398.3 4444.3 4449.4 4456.6 1696.3 1791.8 1799.3 1856.6 1870.2 792.5 856.2 946.6 947.0 983.1 16685.5 19078.0 19140.7 19158.5 19328.7 776.8 848.2 884.9 885.1 915.7 10447.1 10690.1 10726.7 10745.4 10778.3 545509.0 549067.0 735527.6 740984.0 743409.0 110660.0 113266.0 115404.4 117242.0 120783.0 1122.6 1184.0 1189.8 1190.0 1213.2 18831.4 19027.5 19041.4 19245.3 19272.7 40187.6 53842.7 54117.5 54121.0 54578.0 76632.2 76955.0 77163.6 77929.0 79198.0 7467.7 7881.7 7910.2 7928.6 7945.2 8125.6 10350.3 12436.6 12649.8 12665.5 10342.6 10734.1 10737.2 10869.2 10994.9 7180.9 10314.5 10674.0 10723.5 10822.7 10798.4 10997.0 11007.8 11026.7 11109.7 7622.8 7798.5 7817.1 7829.8 7851.0 9994.9 10290.8 10483.3 10899.0 11050.3 15:01:12 INFO - PROCESS | 2279 | 15:01:12 INFO - PROCESS | 2279 | [#3] mootools.html Cycles:180 Average:5972.78 Median:5289.33 stddev:3141.50 (59.4%) stddev-sans-first:3131.37 15:01:12 INFO - PROCESS | 2279 | Values: 1383.3 1524.9 1526.9 1734.7 1903.3 7776.9 8384.8 8551.7 8557.9 8563.1 8217.3 8487.6 8491.7 8492.1 8494.2 2100.3 2137.1 2171.9 2367.0 2435.3 2181.8 2187.0 2189.8 2402.2 2437.7 2341.1 2384.8 2385.2 2387.9 2392.8 2403.3 2403.7 2406.4 2406.4 2407.4 2335.0 2343.5 2401.0 2402.0 2405.8 8554.2 8612.9 8614.4 8617.0 8664.3 5224.1 5411.3 5413.8 5423.9 5426.3 3541.3 3568.3 3690.3 3707.9 3712.0 1036.1 1049.5 1064.4 1075.2 1075.9 11696.5 11702.6 11706.8 11709.8 11710.4 4729.9 4781.0 4852.0 4867.6 4876.2 10031.8 10044.9 10049.2 10051.5 10062.2 5354.6 5366.6 5374.2 5378.7 5381.5 4837.3 4882.2 4885.4 4886.8 4889.3 3574.7 3866.5 3906.2 3924.0 3950.1 1188.8 1250.4 1260.5 1272.2 1272.4 1105.3 1286.3 1303.3 1326.5 1331.9 7945.8 8015.3 8022.0 8031.8 8033.9 1173.3 1178.8 1184.6 1215.2 1215.7 6094.7 6187.8 6263.7 6270.9 6281.8 10093.7 10485.3 10616.8 10727.4 10736.2 10210.4 10513.1 10579.4 10582.0 10606.8 8122.6 8237.4 8256.3 8259.5 8260.8 7610.5 7753.5 7805.9 7853.8 7864.7 9278.6 9542.2 9636.6 9646.8 9662.3 9633.7 9784.1 9796.8 9939.2 9964.3 6844.6 6902.9 6984.0 7019.4 7041.4 7264.9 7439.3 8016.2 8085.8 8117.4 6624.4 7497.7 7500.8 7513.8 7665.4 7347.0 7489.5 7498.9 7517.8 7615.5 7406.6 7611.5 7613.2 7620.3 7621.0 6828.2 6878.4 6897.8 6969.9 6983.1 7031.7 7078.9 7146.6 7162.5 7169.8 15:01:12 INFO - PROCESS | 2279 | 15:01:12 INFO - PROCESS | 2279 | [#4] prototype.html Cycles:180 Average:5685.16 Median:6477.11 stddev:1811.17 (28.0%) stddev-sans-first:1770.84 15:01:12 INFO - PROCESS | 2279 | Values: 315.8 317.3 324.1 328.2 329.7 6498.4 6519.2 6559.1 6611.3 6623.5 6133.2 6255.7 6301.1 6353.9 6458.0 4806.1 4811.7 4829.5 4836.6 4843.2 4818.4 4820.1 4823.6 4828.2 4845.5 4483.1 4559.0 4639.2 4672.8 4776.2 4623.4 4665.2 4678.2 4686.6 4716.1 4019.2 4034.1 4040.3 4046.0 4046.8 6065.2 6161.4 6211.9 6214.1 6215.7 4527.8 5491.7 5576.9 5585.3 5589.4 6766.1 6777.2 6796.8 6798.7 6799.1 3754.7 4549.0 4551.7 4575.2 4576.4 5793.7 6956.7 7229.2 7231.4 7238.6 4663.0 4666.4 4670.2 4672.3 4676.3 4753.7 4754.9 4765.8 4765.8 4768.3 5609.4 5621.7 5622.3 5624.2 5644.6 6225.7 6604.2 6869.9 6870.8 6891.6 1629.3 1657.3 1657.9 1661.3 1668.6 878.9 1072.8 1079.9 1089.0 1102.7 6473.5 6474.5 6479.7 6484.1 6493.7 7131.0 7154.6 7158.2 7165.6 7174.5 5201.0 6234.8 6420.7 6565.3 6567.3 3791.8 3800.5 3836.0 3842.6 3845.5 7388.0 7575.1 7582.0 7598.7 7616.4 7439.3 7443.9 7466.6 7469.6 7489.9 7572.5 7578.3 7583.0 7585.9 7589.8 7065.6 7251.1 7253.8 7254.5 7254.9 7123.1 7135.8 7143.4 7145.1 7157.1 6491.0 7234.6 7547.8 7566.7 7570.0 4620.7 4720.9 4740.9 4755.9 4771.5 7202.5 7206.2 7208.7 7216.5 7230.1 6987.3 7004.3 7007.1 7007.6 7011.5 6806.2 6976.4 7004.5 7004.8 7009.5 6841.1 6842.6 6852.0 6853.3 6854.9 6813.6 6961.8 6973.6 6974.4 6991.7 6844.7 6847.3 6853.4 6856.3 6857.2 15:01:12 INFO - PROCESS | 2279 | 15:01:12 INFO - PROCESS | 2279 | [#5] yui.html Cycles:180 Average:18486.78 Median:621.53 stddev:26130.69 (4204.3%) stddev-sans-first:26169.56 15:01:12 INFO - PROCESS | 2279 | Values: 621.8 628.0 665.0 704.4 760.0 14874.2 14904.9 15068.0 15108.0 15191.0 13760.2 14005.2 14016.6 14018.2 14027.0 726.6 739.9 872.6 891.7 892.5 862.6 884.8 895.2 896.6 896.9 934.5 936.0 937.0 937.0 943.6 749.0 757.4 919.1 926.0 935.0 673.2 682.6 683.5 690.2 695.9 14671.8 14704.4 14712.1 14753.6 14764.2 12454.7 12562.2 12572.6 13140.2 13278.7 9990.3 10170.2 10181.8 10184.8 10212.3 3489.8 3525.5 3525.8 3540.4 3542.3 76776.2 78815.6 80417.0 82688.6 87561.2 9388.4 9417.5 9429.5 9519.7 9787.6 20701.4 20706.2 20707.0 20733.0 20779.4 7572.0 7580.8 7584.5 7660.0 7819.7 4137.7 4152.6 4174.1 4191.8 4210.5 3486.9 3548.4 3551.6 3552.8 3553.1 549.4 625.5 635.5 638.1 657.0 492.7 519.6 548.3 552.2 610.6 8507.3 8611.9 8614.2 8622.0 8714.5 506.4 534.5 620.6 621.3 623.3 3892.6 4002.9 4095.2 4152.6 4180.3 92797.0 93174.0 95115.5 95315.0 95523.5 66642.7 74254.0 81614.6 83896.6 85147.0 69634.7 70333.6 70894.6 71053.3 72687.3 7305.5 8987.9 9010.7 9062.7 9231.3 48256.5 49824.3 50320.7 52812.0 53196.5 64427.0 70031.0 71545.0 71610.0 71623.6 8791.0 9965.4 10076.5 10111.1 10249.8 11405.7 12088.9 12114.8 12398.5 12584.1 10683.5 11245.6 11276.6 11303.9 11594.7 11344.9 11345.1 11386.7 11766.6 11840.0 11314.6 11581.5 11648.2 11799.9 11889.2 9541.8 9613.2 9842.5 9925.7 9970.7 9797.4 10010.2 10043.0 10051.2 10067.8 15:01:12 INFO - PROCESS | 2279 | -------- Summary: end -------- 15:01:12 INFO - PROCESS | 2279 | 15:01:13 INFO - TEST-INFO | 2279: exit 0 15:01:13 INFO - TEST-OK | dromaeo_css | took 1113431ms 15:01:13 INFO - TEST-START | kraken 15:01:13 INFO - operating with platform_type : mac_ 15:01:13 INFO - Initialising browser for kraken test... 15:01:13 INFO - TEST-INFO | started process 2282 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/tmpvak6xj/profile http://localhost:49685/getInfo.html) 15:01:15 INFO - PROCESS | 2282 | __metrics Screen width/height:1600/1200 15:01:15 INFO - PROCESS | 2282 | colorDepth:24 15:01:15 INFO - PROCESS | 2282 | Browser inner width/height: 1024/689 15:01:15 INFO - PROCESS | 2282 | __metrics 15:01:15 INFO - PROCESS | 2282 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:01:15 INFO - PROCESS | 2282 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:01:16 INFO - TEST-INFO | 2282: exit 0 15:01:16 INFO - Browser initialized. 15:01:16 INFO - Running cycle 1/1 for kraken test... 15:01:16 INFO - TEST-INFO | started process 2284 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/tmpvak6xj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:01:28 INFO - PROCESS | 2284 | RSS: Main: 244539392 15:01:28 INFO - PROCESS | 2284 | 15:01:30 INFO - PROCESS | 2284 | Cycle 1(1): loaded http://localhost:49685/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49685/tests/kraken/driver.html?testName=audio-beat-detection) 15:01:31 INFO - PROCESS | 2284 | RSS: Main: 289955840 15:01:31 INFO - PROCESS | 2284 | 15:01:34 INFO - PROCESS | 2284 | Cycle 1(1): loaded http://localhost:49685/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49685/tests/kraken/driver.html?testName=audio-dft) 15:01:34 INFO - PROCESS | 2284 | RSS: Main: 300593152 15:01:34 INFO - PROCESS | 2284 | 15:01:37 INFO - PROCESS | 2284 | Cycle 1(1): loaded http://localhost:49685/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49685/tests/kraken/driver.html?testName=audio-fft) 15:01:38 INFO - PROCESS | 2284 | RSS: Main: 284819456 15:01:38 INFO - PROCESS | 2284 | 15:01:40 INFO - PROCESS | 2284 | Cycle 1(1): loaded http://localhost:49685/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49685/tests/kraken/driver.html?testName=audio-oscillator) 15:01:41 INFO - PROCESS | 2284 | RSS: Main: 287100928 15:01:41 INFO - PROCESS | 2284 | 15:01:43 INFO - PROCESS | 2284 | Cycle 1(1): loaded http://localhost:49685/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49685/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:01:43 INFO - PROCESS | 2284 | RSS: Main: 288505856 15:01:43 INFO - PROCESS | 2284 | 15:01:46 INFO - PROCESS | 2284 | Cycle 1(1): loaded http://localhost:49685/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49685/tests/kraken/driver.html?testName=imaging-darkroom) 15:01:47 INFO - PROCESS | 2284 | RSS: Main: 287252480 15:01:47 INFO - PROCESS | 2284 | 15:01:50 INFO - PROCESS | 2284 | Cycle 1(1): loaded http://localhost:49685/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49685/tests/kraken/driver.html?testName=imaging-desaturate) 15:01:50 INFO - PROCESS | 2284 | RSS: Main: 288518144 15:01:50 INFO - PROCESS | 2284 | 15:01:53 INFO - PROCESS | 2284 | Cycle 1(1): loaded http://localhost:49685/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49685/tests/kraken/driver.html?testName=json-parse-financial) 15:01:53 INFO - PROCESS | 2284 | RSS: Main: 287989760 15:01:53 INFO - PROCESS | 2284 | 15:01:55 INFO - PROCESS | 2284 | Cycle 1(1): loaded http://localhost:49685/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49685/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:01:56 INFO - PROCESS | 2284 | RSS: Main: 323588096 15:01:56 INFO - PROCESS | 2284 | 15:01:57 INFO - PROCESS | 2284 | Cycle 1(1): loaded http://localhost:49685/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49685/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:01:58 INFO - PROCESS | 2284 | RSS: Main: 322097152 15:01:58 INFO - PROCESS | 2284 | 15:02:00 INFO - PROCESS | 2284 | Cycle 1(1): loaded http://localhost:49685/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49685/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:02:01 INFO - PROCESS | 2284 | RSS: Main: 332881920 15:02:01 INFO - PROCESS | 2284 | 15:02:03 INFO - PROCESS | 2284 | Cycle 1(1): loaded http://localhost:49685/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49685/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:02:04 INFO - PROCESS | 2284 | RSS: Main: 332955648 15:02:04 INFO - PROCESS | 2284 | 15:02:06 INFO - PROCESS | 2284 | Cycle 1(1): loaded http://localhost:49685/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49685/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:02:07 INFO - PROCESS | 2284 | RSS: Main: 333438976 15:02:07 INFO - PROCESS | 2284 | 15:02:09 INFO - PROCESS | 2284 | Cycle 1(1): loaded http://localhost:49685/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49685/tests/kraken/driver.html?testName=ai-astar) 15:02:09 INFO - PROCESS | 2284 | RSS: Main: 393682944 15:02:09 INFO - PROCESS | 2284 | 15:02:09 INFO - PROCESS | 2284 | __start_tp_report 15:02:09 INFO - PROCESS | 2284 | _x_x_mozilla_page_load 15:02:09 INFO - PROCESS | 2284 | _x_x_mozilla_page_load_details 15:02:09 INFO - PROCESS | 2284 | |i|pagename|runs| 15:02:09 INFO - PROCESS | 2284 | |0;ai-astar;112;151;165;110;108;111;114;109;107;111 15:02:09 INFO - PROCESS | 2284 | |1;audio-beat-detection;159;122;148;181;149;173;153;120;159;120 15:02:09 INFO - PROCESS | 2284 | |2;audio-dft;185;183;187;189;184;183;186;181;182;183 15:02:09 INFO - PROCESS | 2284 | |3;audio-fft;77;84;119;67;60;82;84;107;102;55 15:02:09 INFO - PROCESS | 2284 | |4;audio-oscillator;93;96;116;76;75;81;108;77;106;137 15:02:09 INFO - PROCESS | 2284 | |5;imaging-gaussian-blur;87;91;85;92;86;90;85;90;86;92 15:02:09 INFO - PROCESS | 2284 | |6;imaging-darkroom;94;92;93;93;94;93;94;92;94;93 15:02:09 INFO - PROCESS | 2284 | |7;imaging-desaturate;88;85;85;86;88;86;83;86;87;85 15:02:09 INFO - PROCESS | 2284 | |8;json-parse-financial;56;53;53;52;52;52;53;63;51;52 15:02:09 INFO - PROCESS | 2284 | |9;json-stringify-tinderbox;65;66;78;72;71;67;67;68;69;68 15:02:09 INFO - PROCESS | 2284 | |10;stanford-crypto-aes;84;82;84;83;82;84;82;82;82;83 15:02:09 INFO - PROCESS | 2284 | |11;stanford-crypto-ccm;135;130;120;135;126;107;112;146;126;127 15:02:09 INFO - PROCESS | 2284 | |12;stanford-crypto-pbkdf2;138;127;138;164;175;168;135;132;138;137 15:02:09 INFO - PROCESS | 2284 | |13;stanford-crypto-sha256-iterative;67;65;67;68;93;94;94;93;66;67 15:02:09 INFO - PROCESS | 2284 | __end_tp_report 15:02:09 INFO - PROCESS | 2284 | __start_cc_report 15:02:09 INFO - PROCESS | 2284 | _x_x_mozilla_cycle_collect,1130 15:02:09 INFO - PROCESS | 2284 | __end_cc_report 15:02:09 INFO - PROCESS | 2284 | __startTimestamp1455750129595__endTimestamp 15:02:09 INFO - PROCESS | 2284 | 15:02:09 INFO - PROCESS | 2284 | ------- Summary: start ------- 15:02:09 INFO - PROCESS | 2284 | Number of tests: 14 15:02:09 INFO - PROCESS | 2284 | 15:02:09 INFO - PROCESS | 2284 | [#0] ai-astar Cycles:10 Average:119.80 Median:111.50 stddev:20.50 (18.4%) stddev-sans-first:21.55 15:02:09 INFO - PROCESS | 2284 | Values: 112.0 151.0 165.0 110.0 108.0 111.0 114.0 109.0 107.0 111.0 15:02:09 INFO - PROCESS | 2284 | 15:02:09 INFO - PROCESS | 2284 | [#1] audio-beat-detection Cycles:10 Average:148.40 Median:156.00 stddev:21.67 (13.9%) stddev-sans-first:22.64 15:02:09 INFO - PROCESS | 2284 | Values: 159.0 122.0 148.0 181.0 149.0 173.0 153.0 120.0 159.0 120.0 15:02:09 INFO - PROCESS | 2284 | 15:02:09 INFO - PROCESS | 2284 | [#2] audio-dft Cycles:10 Average:184.30 Median:184.50 stddev:2.45 (1.3%) stddev-sans-first:2.59 15:02:09 INFO - PROCESS | 2284 | Values: 185.0 183.0 187.0 189.0 184.0 183.0 186.0 181.0 182.0 183.0 15:02:09 INFO - PROCESS | 2284 | 15:02:09 INFO - PROCESS | 2284 | [#3] audio-fft Cycles:10 Average:83.70 Median:72.00 stddev:20.65 (28.7%) stddev-sans-first:21.75 15:02:09 INFO - PROCESS | 2284 | Values: 77.0 84.0 119.0 67.0 60.0 82.0 84.0 107.0 102.0 55.0 15:02:09 INFO - PROCESS | 2284 | 15:02:09 INFO - PROCESS | 2284 | [#4] audio-oscillator Cycles:10 Average:96.50 Median:76.50 stddev:20.44 (26.7%) stddev-sans-first:21.64 15:02:09 INFO - PROCESS | 2284 | Values: 93.0 96.0 116.0 76.0 75.0 81.0 108.0 77.0 106.0 137.0 15:02:09 INFO - PROCESS | 2284 | 15:02:09 INFO - PROCESS | 2284 | [#5] imaging-gaussian-blur Cycles:10 Average:88.40 Median:90.00 stddev:2.88 (3.2%) stddev-sans-first:3.00 15:02:09 INFO - PROCESS | 2284 | Values: 87.0 91.0 85.0 92.0 86.0 90.0 85.0 90.0 86.0 92.0 15:02:09 INFO - PROCESS | 2284 | 15:02:09 INFO - PROCESS | 2284 | [#6] imaging-darkroom Cycles:10 Average:93.20 Median:93.50 stddev:0.79 (0.8%) stddev-sans-first:0.78 15:02:09 INFO - PROCESS | 2284 | Values: 94.0 92.0 93.0 93.0 94.0 93.0 94.0 92.0 94.0 93.0 15:02:09 INFO - PROCESS | 2284 | 15:02:09 INFO - PROCESS | 2284 | [#7] imaging-desaturate Cycles:10 Average:85.90 Median:86.00 stddev:1.52 (1.8%) stddev-sans-first:1.41 15:02:09 INFO - PROCESS | 2284 | Values: 88.0 85.0 85.0 86.0 88.0 86.0 83.0 86.0 87.0 85.0 15:02:09 INFO - PROCESS | 2284 | 15:02:09 INFO - PROCESS | 2284 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:53.00 stddev:3.53 (6.7%) stddev-sans-first:3.64 15:02:09 INFO - PROCESS | 2284 | Values: 56.0 53.0 53.0 52.0 52.0 52.0 53.0 63.0 51.0 52.0 15:02:09 INFO - PROCESS | 2284 | 15:02:09 INFO - PROCESS | 2284 | [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:68.50 stddev:3.78 (5.5%) stddev-sans-first:3.71 15:02:09 INFO - PROCESS | 2284 | Values: 65.0 66.0 78.0 72.0 71.0 67.0 67.0 68.0 69.0 68.0 15:02:09 INFO - PROCESS | 2284 | 15:02:09 INFO - PROCESS | 2284 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:83.00 stddev:0.92 (1.1%) stddev-sans-first:0.87 15:02:09 INFO - PROCESS | 2284 | Values: 84.0 82.0 84.0 83.0 82.0 84.0 82.0 82.0 82.0 83.0 15:02:09 INFO - PROCESS | 2284 | 15:02:09 INFO - PROCESS | 2284 | [#11] stanford-crypto-ccm Cycles:10 Average:126.40 Median:128.50 stddev:11.40 (8.9%) stddev-sans-first:11.66 15:02:09 INFO - PROCESS | 2284 | Values: 135.0 130.0 120.0 135.0 126.0 107.0 112.0 146.0 126.0 127.0 15:02:09 INFO - PROCESS | 2284 | 15:02:09 INFO - PROCESS | 2284 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.20 Median:138.00 stddev:16.98 (12.3%) stddev-sans-first:17.80 15:02:09 INFO - PROCESS | 2284 | Values: 138.0 127.0 138.0 164.0 175.0 168.0 135.0 132.0 138.0 137.0 15:02:09 INFO - PROCESS | 2284 | 15:02:09 INFO - PROCESS | 2284 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.40 Median:80.50 stddev:13.88 (17.2%) stddev-sans-first:14.20 15:02:09 INFO - PROCESS | 2284 | Values: 67.0 65.0 67.0 68.0 93.0 94.0 94.0 93.0 66.0 67.0 15:02:09 INFO - PROCESS | 2284 | -------- Summary: end -------- 15:02:09 INFO - PROCESS | 2284 | 15:02:10 INFO - TEST-INFO | 2284: exit 0 15:02:10 INFO - TEST-OK | kraken | took 57224ms 15:02:10 INFO - SUITE-END | took 1170s 15:02:10 INFO - Completed test suite (00:19:31) 15:02:10 INFO - Working with test: dromaeo_css 15:02:10 INFO - Generating results file: dromaeo_css 15:02:10 INFO - Working with test: kraken 15:02:10 INFO - Generating results file: kraken 15:02:10 INFO - javascript benchmark 15:02:10 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:02:11 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 15:02:11 INFO - process_Request line: dromaeo_css 7442.73 graph.html#tests=[[72,64,59]] 15:02:11 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:02:11 INFO - process_Request line: kraken 1454.80 graph.html#tests=[[232,64,59]] 15:02:11 INFO - RETURN: dromaeo_css: 7442.73 15:02:11 INFO - RETURN: kraken: 1454.80 15:02:11 INFO - javascript benchmark 15:02:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2981.403719256149, 3393.5079413485046, 3415.45352743561, 3429.988153494719, 3475.7566970312087, 5486.478784515474, 5543.501084902358, 5559.777608895644, 5563.221149039133, 5587.0, 5547.223388725582, 5547.472990065938, 5564.8052318168775, 5689.772409103631, 5692.146178073291, 4981.452040275567, 5015.272785446117, 5033.0, 5045.0, 5191.5327620514145, 5126.641135120543, 5131.435542090367, 5145.408278048035, 5156.535911767959, 5184.248283998818, 4985.451600323961, 5053.974730126326, 5087.364079490082, 5108.923366149511, 5140.897182056338, 5086.92369614456, 5099.71951542665, 5104.795808167669, 5106.183010718267, 5132.820351287687, 4974.42794078682, 5045.5459008689395, 5058.165402708549, 5066.392032956069, 5077.416097148838, 5406.567474602022, 5498.202760599691, 5499.477549632778, 5561.63849349791, 5598.1322894951345, 6089.634621922699, 6093.329733729286, 6098.481629061535, 6133.754649814002, 6138.693065346715, 6040.607360521596, 6109.358517355702, 6173.444390004921, 6182.010878259502, 6183.81448556544, 5587.55299576037, 5600.52395546379, 5673.716314184316, 5692.203091567184, 5699.116636921284, 6062.393760623902, 6250.406211409909, 6251.3123556408755, 6256.280527739277, 6265.530085243625, 5868.325142608569, 5887.411258874078, 5960.046392577166, 5960.701964901824, 5967.16459695643, 6010.939890601038, 6101.877962440726, 6132.478739307119, 6157.692115394212, 6160.907586386208, 6087.043024123353, 6113.841195312599, 6128.411459112376, 6131.804871721949, 6132.049587189092, 5966.31387390447, 6122.846928826815, 6130.111133885562, 6141.385861413823, 6141.57009009374, 4781.067691800135, 4790.377250957354, 4848.12733707936, 4853.39332583427, 4871.707697538159, 4245.68157388191, 4255.957440425618, 4274.059706864485, 4288.871333859989, 4317.9136417271475, 5573.7770489179975, 5634.0, 5656.179853921159, 5663.235463212413, 5708.942910570924, 6001.789937352171, 6117.736059405574, 6144.463884028993, 6186.597871138361, 6192.721327540272, 5653.4629210225785, 5666.291713535808, 5669.262995810518, 5669.376368599451, 5692.0, 5188.481151884781, 5277.498637629419, 5295.443978382292, 5302.655327403706, 5311.256424100629, 6142.191841058483, 6225.906611400742, 6231.906521402183, 6236.719347629459, 6243.0, 6122.714230011569, 6165.876682466236, 6177.938220617916, 6184.072389141665, 6212.0, 6149.385061493815, 6225.3774622537385, 6225.875482490415, 6231.844203894939, 6261.029540421242, 6060.969695151496, 6095.634261944298, 6103.246756470893, 6136.151476879722, 6144.631322120687, 6117.938820611737, 6131.448169664752, 6155.138280640804, 6176.969115154575, 6188.535859810622, 4836.975815120902, 5823.272090988627, 5978.940210597838, 6005.849853753691, 6019.247594050744, 5932.8813423732145, 5977.551683623658, 5981.551383646331, 5989.281286245504, 6018.247719035121, 5755.165501002415, 5811.680357580373, 5828.737706803289, 5839.299284085937, 5849.473547380756, 5092.490750924878, 5803.535717142703, 5863.442972917566, 5962.314333851663, 6030.336662966983, 5807.82576522705, 5816.970915145397, 5817.0111081115465, 5825.679587622722, 5826.41735826414], "unit": "score", "name": "dojo.html", "value": 5583.395553499033}, {"lowerIsBetter": false, "replicates": [458.9948013849669, 487.4272729542791, 504.04735050754067, 554.8653004605582, 555.9888802223953, 25559.10543130991, 29682.0, 29715.702842971565, 36975.445368319495, 38022.8098859506, 40078.799606002, 40550.797246013804, 40653.0, 40653.18693626133, 40794.0, 9464.858027129581, 9703.90296097037, 9708.0, 9723.319367644268, 9743.756406089833, 8470.32237421008, 9429.952850235773, 9474.815648043994, 9583.808323833518, 9589.472579008152, 9668.129868311851, 9758.316917815755, 9762.609495620167, 9767.462789546573, 9794.951025244864, 9648.614055437809, 9718.416894986323, 9748.757785709291, 9749.951250243703, 9751.3661611995, 8434.915650843473, 9582.90417095827, 9650.71047868565, 9719.708408747749, 9742.707718768377, 38745.80627096847, 39190.80404597987, 39211.019724506834, 39246.01884952871, 39292.21415571701, 3079.507278835398, 3158.1315138336913, 3585.31878943, 3767.3972164453558, 3806.4480650305827, 27743.306417339525, 28265.293367665767, 28633.856830715922, 28970.27574310638, 29164.270893227625, 2792.3577577157166, 2837.730415610514, 2841.4317136572563, 2855.271905664042, 2982.3140677644046, 359798.0, 362038.0, 362345.0, 363079.1846040753, 481113.9999999965, 45352.54647453549, 64626.0, 65245.67377163179, 65365.673171634786, 65485.0, 62915.370846291866, 63400.51297178607, 63479.0, 63533.36466635367, 63600.0, 14814.925925370304, 15015.774763378558, 15722.978006429545, 16002.75995860063, 16009.759853602205, 11011.504482298316, 11200.719982000515, 12527.93736031314, 12569.685757856127, 12701.428435720414, 19865.0, 20210.29263975754, 20218.989050547414, 20237.797622023885, 20252.493687657632, 8524.862099288503, 8624.956875215585, 8630.352723545759, 8670.263027642595, 8739.344549158839, 867.8741582470507, 925.8287216864901, 931.7577429868147, 969.888462826784, 1046.9685909422728, 27388.863055684593, 30394.39211215763, 30510.0, 30526.847365763475, 31042.223944401117, 960.8943016268205, 1006.5822683586376, 1057.9418132002813, 1134.8638163420442, 1146.2377518949972, 14274.2149181796, 14389.78415323771, 14408.639784005483, 14529.982901196814, 14600.634984125481, 658989.0, 667453.6627316832, 668983.0, 670356.0, 671098.0, 55248.447515525135, 55738.44261557414, 55772.44227557754, 55892.72053639787, 55893.720531397084, 1276.3363051213316, 1373.7183877305129, 1389.6664800448023, 1398.4895513137835, 1411.760000799887, 24415.51168976646, 28328.866845325956, 28862.855685721435, 29516.262093447836, 29521.85239073791, 45387.0, 46464.303035455174, 46915.29627055665, 47133.29300060433, 47188.0, 574022.0, 659120.0, 667341.0, 668124.0, 669101.0, 25887.0, 26243.60634590521, 31329.216769580944, 32285.0, 32302.676973229965, 41985.58014419939, 42242.0, 42249.78875105728, 42790.57209427866, 43589.69230923078, 34492.82753586216, 35360.46959295561, 35892.461613075306, 36090.0, 36271.455928161624, 35467.0, 35685.1078723034, 36391.36238869204, 37483.81258093692, 37529.6247037537, 36582.45126323054, 36730.8163459181, 37612.05969850776, 37646.435303471015, 37755.62244377521, 29705.10884673463, 31256.21859453532, 32589.837050814593, 33265.83367083246, 33274.0, 23508.764912350656, 23823.52352952966, 23984.52030959406, 24123.51752964966, 24943.750562494144], "unit": "score", "name": "ext.html", "value": 19461.68072957197}, {"lowerIsBetter": false, "replicates": [307.9276370053037, 314.25835029330784, 358.61090716572517, 359.67269784496114, 372.0494137478741, 14847.703045939075, 15196.31616577254, 15510.612234694137, 18953.52616184596, 19928.302509412173, 11622.07023438125, 11856.170068095236, 16418.589535261624, 19091.61816763664, 19118.808811911877, 5172.19830926207, 5362.8123015694455, 5371.140617501201, 5373.194020896858, 5376.1398176291805, 3976.741511801738, 4138.0689344897455, 5332.693490094932, 5393.622446428752, 5712.742926568294, 5887.61730487517, 5934.139549765281, 5935.28776546815, 5947.078202878561, 5949.5537834662355, 6288.559800813945, 6409.327020662833, 6457.903131453032, 6458.225012998423, 6471.3528647135145, 5439.836804895859, 5606.635568688063, 5606.971965140148, 5615.2700148980375, 5678.9432105678825, 23707.28878133659, 23982.0, 23997.88001060001, 24793.876030619733, 24811.751882481305, 2032.3801240621603, 2051.748433455591, 2352.976455241975, 2695.3560618129686, 2743.670759508872, 9527.52362381878, 9577.281703872168, 10139.54372053252, 12385.0, 14587.27063646824, 1769.195016267595, 1772.3708083630254, 1785.3929663914332, 1791.1492041280417, 1802.4232245681387, 102917.48541257321, 103473.0, 103808.0, 105591.0, 107303.0, 11167.162462815322, 11236.887631123747, 11240.437978101063, 11297.943510282395, 11396.031337336253, 13456.932715336361, 13619.319034048258, 13628.93185534066, 13635.522756703665, 13650.385732642055, 8384.748457546284, 8427.662893484314, 8446.239838414573, 8532.8720069199, 8559.957200214083, 8546.316294696533, 8560.186782255676, 8561.143885611513, 8651.307895368482, 8657.52383618907, 4360.781960902005, 4398.252297109435, 4444.28891377378, 4449.354843547732, 4456.600912726128, 1696.2960371445959, 1791.7939436964655, 1799.2712951254762, 1856.647237024961, 1870.1771220662865, 792.4730054513799, 856.1866227084295, 946.5882341181608, 946.9819943560562, 983.1201075037944, 16685.49943501697, 19078.0, 19140.712889306673, 19158.521036973907, 19328.71006934897, 776.7863837444748, 848.1942154952819, 884.8628462588309, 885.1148851148852, 915.7390143809116, 10447.111995480318, 10690.144788417063, 10726.731831704114, 10745.409002504937, 10778.29941053829, 545509.0, 549067.0, 735527.5895450184, 740984.0, 743409.0, 110660.0, 113266.0, 115404.42297788625, 117242.0, 120782.99999999824, 1122.607087519378, 1183.958561450345, 1189.7620475904853, 1189.9762004759857, 1213.150794443893, 18831.435056948314, 19027.524311892314, 19041.42875713731, 19245.32641357602, 19272.710909336092, 40187.59812401838, 53842.73078634582, 54117.45882541124, 54121.0, 54578.0, 76632.23367766252, 76955.0, 77163.61418192873, 77929.0, 79198.0, 7467.701291948479, 7881.684732610632, 7910.248526389983, 7928.643211055632, 7945.20547945224, 8125.593720314079, 10350.343944968768, 12436.564720234748, 12649.810252846399, 12665.493380265054, 10342.586296548054, 10734.087602553871, 10737.248392612442, 10869.184811139354, 10994.945025274823, 7180.856382872418, 10314.535845886803, 10674.0, 10723.517441714985, 10822.67531974042, 10798.352098874093, 10997.010269075821, 11007.83488247693, 11026.724331891766, 11109.666709998713, 7622.8094297643, 7798.454108212371, 7817.101033381006, 7829.765107046797, 7850.960745196237, 9994.900050999688, 10290.794184116126, 10483.318584291997, 10898.964598363144, 11050.281731687415], "unit": "score", "name": "jquery.html", "value": 9198.006224415072}, {"lowerIsBetter": false, "replicates": [1383.3498255819761, 1524.9008814427063, 1526.9083854968699, 1734.7397890316452, 1903.2957805611925, 7776.883346749803, 8384.83230335393, 8551.74344769658, 8557.871631925525, 8563.100874408176, 8217.342612590994, 8487.618057187427, 8491.702790402338, 8492.065872753992, 8494.235518803307, 2100.2544096845627, 2137.1237792505076, 2171.9022643981057, 2366.9763302366973, 2435.318110928934, 2181.836362272828, 2187.048633844283, 2189.8467107302495, 2402.1952645863657, 2437.7196622388387, 2341.086976079322, 2384.7853693167613, 2385.2367242482414, 2387.868667223302, 2392.760723927611, 2403.267003563912, 2403.687520622308, 2406.38637147528, 2406.422458609921, 2407.434252950555, 2334.97665023351, 2343.4610039690965, 2401.03958416633, 2401.987990060056, 2405.795507381875, 8554.230119289232, 8612.913870861274, 8614.353923455703, 8617.01808584023, 8664.306855451548, 5224.085784987612, 5411.269478620376, 5413.783448662049, 5423.891522169534, 5426.321709786277, 3541.3448512025357, 3568.3041806847673, 3690.280395322913, 3707.925841483182, 3711.9814400928094, 1036.1400037968467, 1049.543448599854, 1064.356064580925, 1075.1774892207468, 1075.9139268858473, 11696.47365868538, 11702.648920532398, 11706.824397634042, 11709.765804683944, 11710.414479276002, 4729.858104256878, 4781.0, 4852.0, 4867.634927380461, 4876.21980483121, 10031.79300553877, 10044.899551004542, 10049.196064314838, 10051.497425128715, 10062.245331600014, 5354.571634269249, 5366.570674346043, 5374.167004114369, 5378.677279363251, 5381.515663590296, 4837.322774811459, 4882.170031094723, 4885.438174609965, 4886.780094895738, 4889.339939108246, 3574.6782789549065, 3866.5360156780803, 3906.199229158016, 3924.0, 3950.111224974358, 1188.8038473651923, 1250.443552619094, 1260.4580030586935, 1272.1794442584667, 1272.3511009385095, 1105.2649987758211, 1286.292539103508, 1303.302733037839, 1326.5025615394227, 1331.8867896228735, 7945.761627151194, 8015.276715506194, 8021.997250343707, 8031.839363212703, 8033.919660803434, 1173.3077484284313, 1178.776032553812, 1184.585395111704, 1215.21011342628, 1215.6535387414544, 6094.695265236721, 6187.81436556904, 6263.655498947511, 6270.9372906270355, 6281.811545653638, 10093.69718908434, 10485.318454300446, 10616.787664246673, 10727.356358618352, 10736.194785391126, 10210.387376757419, 10513.106385957279, 10579.365238085586, 10582.047615714622, 10606.787864242671, 8122.55325957078, 8237.423380363318, 8256.298214651702, 8259.463134896332, 8260.752177434686, 7610.467267291237, 7753.4960227585025, 7805.921940780519, 7853.842923141619, 7864.685412583662, 9278.58246378928, 9542.236621070437, 9636.614535418785, 9646.807063858543, 9662.275329350186, 9633.710988670071, 9784.119429251117, 9796.804063918824, 9939.155171810477, 9964.256255155175, 6844.589324640538, 6902.896456553055, 6983.96508017477, 7019.403350715246, 7041.366277035091, 7264.854702906018, 7439.293267139613, 8016.158303378062, 8085.83828323442, 8117.350611950912, 6624.436922861418, 7497.662605182671, 7500.8499830002, 7513.849723005618, 7665.425093117927, 7346.96326518364, 7489.475736698379, 7498.887516687363, 7517.812054698457, 7615.4669173157345, 7406.555606663402, 7611.467197296136, 7613.238676132342, 7620.314171724572, 7621.0, 6828.214755303204, 6878.415334696607, 6897.7585784497305, 6969.895451568129, 6983.127109111361, 7031.718731250693, 7078.8938165928585, 7146.571205727673, 7162.498625096402, 7169.7849064528145], "unit": "score", "name": "mootools.html", "value": 4870.627979064286}, {"lowerIsBetter": false, "replicates": [315.7631776167874, 317.2702783597726, 324.1022368040526, 328.1877353549964, 329.7115024353692, 6498.382653647902, 6519.21769387673, 6559.147310849595, 6611.338866113386, 6623.470122390209, 6133.233345831771, 6255.749770009205, 6301.054841773736, 6353.934971134377, 6457.9677101614425, 4806.062817750549, 4811.663183577151, 4829.541193586604, 4836.564709176174, 4843.249296359052, 4818.421789385278, 4820.108279968217, 4823.614110871122, 4828.2274836026245, 4845.466998630148, 4483.080968401486, 4559.0, 4639.164950308943, 4672.766361681903, 4776.164171270031, 4623.352730617717, 4665.230237010889, 4678.228092364756, 4686.554777296168, 4716.127516409441, 4019.155977244782, 4034.11249525104, 4040.272750904836, 4045.9595404045876, 4046.77742724153, 6065.181200537915, 6161.383861613847, 6211.937880621181, 6214.0989556514505, 6215.658138802364, 4527.796249168795, 5491.670499770026, 5576.944230557683, 5585.329760428734, 5589.441055894418, 6766.120404347453, 6777.186737591472, 6796.844536428819, 6798.728050877959, 6799.082123913307, 3754.718396120302, 4549.044700612875, 4551.726896386227, 4575.153596584642, 4576.405067341258, 5793.681347525884, 6956.721731130749, 7229.1686456057705, 7231.421486281085, 7238.565686058853, 4663.020765639254, 4666.416697912761, 4670.159371313128, 4672.345871577982, 4676.3453116563705, 4753.714777113384, 4754.857354279377, 4765.8093676252565, 4765.833195838129, 4768.332433459318, 5609.382967873531, 5621.690807005572, 5622.32532096151, 5624.156376543551, 5644.57665675076, 6225.719842607094, 6604.174478190226, 6869.896951545731, 6870.828229294208, 6891.552049116792, 1629.283115429231, 1657.2873664324457, 1657.8507934285972, 1661.252436403599, 1668.5661727950578, 878.8989266234337, 1072.828347464402, 1079.924405291622, 1088.9509972051276, 1102.7408558988632, 6473.514486413538, 6474.514411419163, 6479.708413121421, 6484.059811327331, 6493.70778314977, 7131.0, 7154.642267886585, 7158.2483839197175, 7165.605891675904, 7174.461915356264, 5201.0, 6234.848977102893, 6420.711068001951, 6565.343465653492, 6567.277599464151, 3791.7914514701406, 3800.467934489174, 3836.0218144373007, 3842.558105817867, 3845.538535375773, 7387.963060184665, 7575.0909890813455, 7582.014338136007, 7598.696052157962, 7616.352610028099, 7439.293267139721, 7443.85112297751, 7466.589337586376, 7469.589172595451, 7489.925100749032, 7572.545647261182, 7578.317951384402, 7582.952602797214, 7585.924140758632, 7589.810254743676, 7065.6113913735235, 7251.1298644163035, 7253.8186545336785, 7254.455915806441, 7254.927450725425, 7123.145222573117, 7135.785926422215, 7143.357097861218, 7145.1425828900865, 7157.141143062866, 6491.0, 7234.55308938204, 7547.773566793005, 7566.659500322388, 7569.962150189434, 4620.722756634613, 4720.881977950578, 4740.9051818962735, 4755.928661070156, 4771.4512831023485, 7202.53183543068, 7206.207317195209, 7208.71165153388, 7216.458765592706, 7230.060092187982, 6987.336203060701, 7004.264552221944, 7007.089078419976, 7007.614581198083, 7011.509194356346, 6806.183258008872, 6976.372126508639, 7004.474664400293, 7004.824879378057, 7009.474289428212, 6841.144856892888, 6842.623655698785, 6852.040714300102, 6853.314668533107, 6854.931450685429, 6813.557118787263, 6961.825954351182, 6973.640140172618, 6974.442044636518, 6991.720331186695, 6844.665290268549, 6847.315268473312, 6853.383195512428, 6856.314368563104, 6857.177138743184], "unit": "score", "name": "prototype.html", "value": 5078.865741948745}, {"lowerIsBetter": false, "replicates": [621.7761605821903, 627.987440251195, 664.9925363074939, 704.4118161335285, 760.0309605253301, 14874.181919994397, 14904.850951490482, 15068.020578662394, 15108.017978831369, 15191.0, 13760.243186624732, 14005.159690418583, 14016.64958376041, 14018.228997405138, 14027.0, 726.6112629743088, 739.9371053460462, 872.6334939325483, 891.6789955615973, 892.4734406700046, 862.6118246788939, 884.7522693645757, 895.1898531828706, 896.5786080542135, 896.8834051573319, 934.4626839567242, 936.0452338614609, 936.9531523423835, 936.9531523423835, 943.5848226780229, 748.9812754681122, 757.4357103957532, 919.0717375450776, 926.0091701878993, 934.9528528048561, 673.2157037051828, 682.5699809120272, 683.480554778367, 690.1855810144028, 695.8503921656868, 14671.77992330116, 14704.411823527045, 14712.117272963656, 14753.631159220999, 14764.187969661665, 12454.688632784253, 12562.246265224116, 12572.622821315375, 13140.211587304791, 13278.66803329915, 9990.254380556478, 10170.186385089175, 10181.79636407275, 10184.796304073878, 10212.2851400402, 3489.8080605566684, 3525.5240542526944, 3525.770824896399, 3540.3804334241663, 3542.3446662367546, 76776.23223767802, 78815.6059219706, 80416.99999999942, 82688.58655706682, 87561.24877502414, 9388.436693798394, 9417.482038487811, 9429.48137852411, 9519.666811661558, 9787.608495660237, 20701.378958631267, 20706.171753129707, 20706.96465176735, 20733.0, 20779.376618701463, 7572.0, 7580.8483830324185, 7584.469087163846, 7660.0, 7819.687212511436, 4137.731047481904, 4152.563980782034, 4174.060836311805, 4191.790410479463, 4210.494740631083, 3486.9128271793406, 3548.3790336690977, 3551.6093229744706, 3552.8045957472586, 3553.129483276614, 549.4423160492104, 625.4777260987127, 635.5138319185827, 638.0747915522511, 656.980290591283, 492.6674494716052, 519.5531842615347, 548.2707998362168, 552.1524459953952, 610.5817515002237, 8507.319414446829, 8611.913880861111, 8614.18165274298, 8621.956890215508, 8714.52070136136, 506.3746273352407, 534.4762133109574, 620.5780069552748, 621.2762132116125, 623.2707731953625, 3892.5523564789846, 4002.939955900664, 4095.180963807191, 4152.647025002909, 4180.339634034669, 92797.0, 93174.0, 95115.52442237745, 95315.0, 95523.52238238764, 66642.66678666673, 74254.0, 81614.59192704117, 83896.58051709703, 85147.0, 69634.65182674055, 70333.64833175801, 70894.64552677306, 71053.2894671057, 72687.27312726805, 7305.488615796843, 8987.865182022144, 9010.729678109667, 9062.733994178412, 9231.307651925998, 48256.517434825204, 49824.25263620976, 50320.74839625778, 52812.0, 53196.46803531915, 64427.0, 70031.0, 71545.0, 71610.0, 71623.64188179026, 8791.012573469388, 9965.35225210359, 10076.546555404877, 10111.140553052779, 10249.846252306072, 11405.657830265105, 12088.879111208775, 12114.818277725664, 12398.504059837865, 12584.119111662096, 10683.465826708789, 11245.550177992789, 11276.605318813803, 11303.92612701792, 11594.6521604352, 11344.943275283571, 11345.092392608736, 11386.658400248005, 11766.58816941403, 11840.0, 11314.60398886035, 11581.536738530702, 11648.184627076362, 11799.941000295286, 11889.167758256839, 9541.809163816824, 9613.182879455046, 9842.45866477322, 9925.65260215889, 9970.700878973643, 9797.363171393836, 10010.249231307535, 10042.9957004299, 10051.246156538142, 10067.84898226542], "unit": "score", "name": "yui.html", "value": 6874.386247419171}], "name": "dromaeo_css", "value": 7442.728638804971}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 151.0, 165.0, 110.0, 108.0, 111.0, 114.0, 109.0, 107.0, 111.0], "unit": "score", "name": "ai-astar", "value": 119.8}, {"lowerIsBetter": true, "replicates": [159.0, 122.0, 148.0, 181.0, 149.0, 173.0, 153.0, 120.0, 159.0, 120.0], "unit": "score", "name": "audio-beat-detection", "value": 148.4}, {"lowerIsBetter": true, "replicates": [185.0, 183.0, 187.0, 189.0, 184.0, 183.0, 186.0, 181.0, 182.0, 183.0], "unit": "score", "name": "audio-dft", "value": 184.3}, {"lowerIsBetter": true, "replicates": [77.0, 84.0, 119.0, 67.0, 60.0, 82.0, 84.0, 107.0, 102.0, 55.0], "unit": "score", "name": "audio-fft", "value": 83.7}, {"lowerIsBetter": true, "replicates": [93.0, 96.0, 116.0, 76.0, 75.0, 81.0, 108.0, 77.0, 106.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 96.5}, {"lowerIsBetter": true, "replicates": [87.0, 91.0, 85.0, 92.0, 86.0, 90.0, 85.0, 90.0, 86.0, 92.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 88.4}, {"lowerIsBetter": true, "replicates": [94.0, 92.0, 93.0, 93.0, 94.0, 93.0, 94.0, 92.0, 94.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 93.2}, {"lowerIsBetter": true, "replicates": [88.0, 85.0, 85.0, 86.0, 88.0, 86.0, 83.0, 86.0, 87.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 85.9}, {"lowerIsBetter": true, "replicates": [56.0, 53.0, 53.0, 52.0, 52.0, 52.0, 53.0, 63.0, 51.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 53.7}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 78.0, 72.0, 71.0, 67.0, 67.0, 68.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.1}, {"lowerIsBetter": true, "replicates": [84.0, 82.0, 84.0, 83.0, 82.0, 84.0, 82.0, 82.0, 82.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.8}, {"lowerIsBetter": true, "replicates": [135.0, 130.0, 120.0, 135.0, 126.0, 107.0, 112.0, 146.0, 126.0, 127.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.4}, {"lowerIsBetter": true, "replicates": [138.0, 127.0, 138.0, 164.0, 175.0, 168.0, 135.0, 132.0, 138.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.2}, {"lowerIsBetter": true, "replicates": [67.0, 65.0, 67.0, 68.0, 93.0, 94.0, 94.0, 93.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 77.4}], "name": "kraken", "value": 1454.8000000000004}]} 15:02:11 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1454.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7442.73"}}} 15:02:11 INFO - Return code: 0 15:02:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:02:11 INFO - # TBPL SUCCESS # 15:02:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:02:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:02:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:02:11 INFO - 2016-02-17 15:02:11.343 screenresolution[2288:17410] starting screenresolution argv=screenresolution get 15:02:11 INFO - 2016-02-17 15:02:11.345 screenresolution[2288:17410] Display 0: 1600x1200x32@60 15:02:11 INFO - 2016-02-17 15:02:11.351 screenresolution[2289:17413] starting screenresolution argv=screenresolution list 15:02:11 INFO - Available Modes on Display 0 15:02:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:02:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:02:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:02:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:02:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:02:11 INFO - Intel Iris: 15:02:11 INFO - Chipset Model: Intel Iris 15:02:11 INFO - Type: GPU 15:02:11 INFO - Bus: Built-In 15:02:11 INFO - VRAM (Dynamic, Max): 1536 MB 15:02:11 INFO - Vendor: Intel (0x8086) 15:02:11 INFO - Device ID: 0x0a2e 15:02:11 INFO - Revision ID: 0x0009 15:02:11 INFO - Displays: 15:02:11 INFO - Display: 15:02:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:02:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:02:11 INFO - Display Serial Number: 1600x1200 60 15:02:11 INFO - Main Display: Yes 15:02:11 INFO - Mirror: Off 15:02:11 INFO - Online: Yes 15:02:11 INFO - Rotation: Supported 15:02:11 INFO - Return code: 0 15:02:11 INFO - Running post-action listener: _resource_record_post_action 15:02:11 INFO - Running post-run listener: _resource_record_post_run 15:02:12 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 614400; Write bytes: 707704320; Read time: 10; Write time: 2081 15:02:12 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 397234688; Write bytes: 391157248; Read time: 29805; Write time: 724 15:02:12 INFO - run-tests - Wall time: 1174s; CPU: 52.0%; Read bytes: 614400; Write bytes: 300789760; Read time: 10; Write time: 1320 15:02:12 INFO - Running post-run listener: _upload_blobber_files 15:02:12 INFO - Blob upload gear active. 15:02:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:02:12 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 15:02:12 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'] 15:02:12 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 15:02:13 INFO - (blobuploader) - INFO - Open directory for files ... 15:02:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:02:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:02:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:02:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:02:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:02:14 INFO - (blobuploader) - INFO - Done attempting. 15:02:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:02:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:02:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:02:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:02:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:02:15 INFO - (blobuploader) - INFO - Done attempting. 15:02:15 INFO - (blobuploader) - INFO - Iteration through files over. 15:02:15 INFO - Return code: 0 15:02:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:02:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:02:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/45c092ddd4a635a8652f9a898542d372ca6b78ede56b1cfdc99212c0aaa5f3d9e1b0033722846e46468e5285c334d9b8182d0a6b5d9aaaa04f7f7794c72385e0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d8e853e5603a1113232becfe97980c1453db5dee2c21a1b65febd0e19b39563d9d4330f5d7a3513f27f03976370fafe496888cf508608a177f18de1cca2938da"} 15:02:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:02:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:02:15 INFO - Contents: 15:02:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/45c092ddd4a635a8652f9a898542d372ca6b78ede56b1cfdc99212c0aaa5f3d9e1b0033722846e46468e5285c334d9b8182d0a6b5d9aaaa04f7f7794c72385e0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d8e853e5603a1113232becfe97980c1453db5dee2c21a1b65febd0e19b39563d9d4330f5d7a3513f27f03976370fafe496888cf508608a177f18de1cca2938da"} 15:02:15 INFO - Running post-run listener: copy_logs_to_upload_dir 15:02:15 INFO - Copying logs to upload dir... 15:02:15 INFO - mkdir: /builds/slave/test/build/upload/logs 15:02:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.783206 ========= master_lag: 16.24 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-02-17 15:02:31.482178) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-17 15:02:31.484743) ========= 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.cPDnxHr68F/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.kti4q2ig3T/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/45c092ddd4a635a8652f9a898542d372ca6b78ede56b1cfdc99212c0aaa5f3d9e1b0033722846e46468e5285c334d9b8182d0a6b5d9aaaa04f7f7794c72385e0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d8e853e5603a1113232becfe97980c1453db5dee2c21a1b65febd0e19b39563d9d4330f5d7a3513f27f03976370fafe496888cf508608a177f18de1cca2938da"} build_url:https://queue.taskcluster.net/v1/task/GrXjYC9AQc-KXlZUeJSs-A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011482 build_url: 'https://queue.taskcluster.net/v1/task/GrXjYC9AQc-KXlZUeJSs-A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/45c092ddd4a635a8652f9a898542d372ca6b78ede56b1cfdc99212c0aaa5f3d9e1b0033722846e46468e5285c334d9b8182d0a6b5d9aaaa04f7f7794c72385e0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d8e853e5603a1113232becfe97980c1453db5dee2c21a1b65febd0e19b39563d9d4330f5d7a3513f27f03976370fafe496888cf508608a177f18de1cca2938da"}' ========= master_lag: 0.50 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-17 15:02:32.000043) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 15:02:32.000411) ========= 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.cPDnxHr68F/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.kti4q2ig3T/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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.005038 ========= master_lag: 0.03 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 15:02:32.037906) ========= ========= Started reboot skipped (results: 3, elapsed: 3 secs) (at 2016-02-17 15:02:32.038268) ========= ========= Finished reboot skipped (results: 3, elapsed: 3 secs) (at 2016-02-17 15:02:35.057365) ========= ========= Total master_lag: 16.94 =========