builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0032 starttime: 1455101277.35 results: success (0) buildid: 20160208164823 builduid: 30a40c8c361641e58b7426d55eb90c1e revision: 49945e5fe79e6cf2b083f56fd49d917ca886db0b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-10 02:47:57.348951) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-10 02:47:57.349321) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-10 02:47:57.349617) ========= 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.bRzqGKF7KN/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.dOM7ZMDTJp/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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.005475 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-10 02:47:57.384326) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-10 02:47:57.384600) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-10 02:47:57.411611) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 02:47:57.412004) ========= 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.bRzqGKF7KN/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.dOM7ZMDTJp/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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.005569 ========= master_lag: 0.30 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 02:47:57.718872) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-10 02:47:57.719140) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-10 02:47:57.719459) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 02:47:57.719729) ========= 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.bRzqGKF7KN/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.dOM7ZMDTJp/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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-10 02:47:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 12.9M=0.001s 2016-02-10 02:47:58 (12.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.540059 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 02:47:58.274550) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 02:47:58.274867) ========= 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.bRzqGKF7KN/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.dOM7ZMDTJp/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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.026096 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 02:47:58.323718) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 02:47:58.324083) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 49945e5fe79e6cf2b083f56fd49d917ca886db0b --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 49945e5fe79e6cf2b083f56fd49d917ca886db0b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bRzqGKF7KN/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.dOM7ZMDTJp/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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-10 02:47:58,394 truncating revision to first 12 chars 2016-02-10 02:47:58,394 Setting DEBUG logging. 2016-02-10 02:47:58,394 attempt 1/10 2016-02-10 02:47:58,394 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/49945e5fe79e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-10 02:47:59,036 unpacking tar archive at: fx-team-49945e5fe79e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.885327 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 02:47:59.224732) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-10 02:47:59.225081) ========= echo 49945e5fe79e6cf2b083f56fd49d917ca886db0b in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'49945e5fe79e6cf2b083f56fd49d917ca886db0b'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bRzqGKF7KN/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.dOM7ZMDTJp/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 49945e5fe79e6cf2b083f56fd49d917ca886db0b program finished with exit code 0 elapsedTime=0.005367 script_repo_revision: '49945e5fe79e6cf2b083f56fd49d917ca886db0b' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-10 02:47:59.274308) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-10 02:47:59.274604) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-10 02:47:59.286867) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-02-10 02:47:59.287148) ========= /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.bRzqGKF7KN/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.dOM7ZMDTJp/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 02:47:59 INFO - MultiFileLogger online at 20160210 02:47:59 in /builds/slave/test 02:47:59 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 02:47:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:47:59 INFO - {'append_to_log': False, 02:47:59 INFO - 'base_work_dir': '/builds/slave/test', 02:47:59 INFO - 'blob_upload_branch': 'Fx-Team', 02:47:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:47:59 INFO - 'branch': 'Fx-Team', 02:47:59 INFO - 'buildbot_json_path': 'buildprops.json', 02:47:59 INFO - 'config_files': ('talos/mac_config.py',), 02:47:59 INFO - 'default_actions': ('clobber', 02:47:59 INFO - 'read-buildbot-config', 02:47:59 INFO - 'download-and-extract', 02:47:59 INFO - 'populate-webroot', 02:47:59 INFO - 'create-virtualenv', 02:47:59 INFO - 'install', 02:47:59 INFO - 'run-tests'), 02:47:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:47:59 INFO - 'download_minidump_stackwalk': True, 02:47:59 INFO - 'download_symbols': 'ondemand', 02:47:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:47:59 INFO - 'tooltool.py': '/tools/tooltool.py', 02:47:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:47:59 INFO - '/tools/misc-python/virtualenv.py')}, 02:47:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:47:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:47:59 INFO - 'installer_path': 'installer.exe', 02:47:59 INFO - 'log_level': 'info', 02:47:59 INFO - 'log_name': 'talos', 02:47:59 INFO - 'log_to_console': True, 02:47:59 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:47:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:47:59 INFO - 'opt_config_files': (), 02:47:59 INFO - 'pip_index': False, 02:47:59 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:47:59 INFO - 'cmd': ('bash', 02:47:59 INFO - '-c', 02:47:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:47:59 INFO - 'enabled': True, 02:47:59 INFO - 'halt_on_failure': False, 02:47:59 INFO - 'name': 'check_screen_resolution'},), 02:47:59 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:47:59 INFO - 'cmd': ('bash', 02:47:59 INFO - '-c', 02:47:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:47:59 INFO - 'enabled': True, 02:47:59 INFO - 'halt_on_failure': False, 02:47:59 INFO - 'name': 'check_screen_resolution'},), 02:47:59 INFO - 'run_cmd_checks_enabled': True, 02:47:59 INFO - 'sps_profile': False, 02:47:59 INFO - 'sps_profile_interval': 0, 02:47:59 INFO - 'suite': 'dromaeojs', 02:47:59 INFO - 'system_bits': '32', 02:47:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:47:59 INFO - 'title': 't-yosemite-r7-0032', 02:47:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:47:59 INFO - 'use_talos_json': True, 02:47:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:47:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:47:59 INFO - 'work_dir': 'build'} 02:47:59 INFO - ##### 02:47:59 INFO - ##### Running clobber step. 02:47:59 INFO - ##### 02:47:59 INFO - Running pre-action listener: _resource_record_pre_action 02:47:59 INFO - Running main action method: clobber 02:47:59 INFO - rmtree: /builds/slave/test/build 02:47:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:48:01 INFO - Running post-action listener: _resource_record_post_action 02:48:01 INFO - ##### 02:48:01 INFO - ##### Running read-buildbot-config step. 02:48:01 INFO - ##### 02:48:01 INFO - Running pre-action listener: _resource_record_pre_action 02:48:01 INFO - Running main action method: read_buildbot_config 02:48:01 INFO - Using buildbot properties: 02:48:01 INFO - { 02:48:01 INFO - "project": "", 02:48:01 INFO - "product": "firefox", 02:48:01 INFO - "script_repo_revision": "production", 02:48:01 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 02:48:01 INFO - "repository": "", 02:48:01 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 02:48:01 INFO - "buildid": "20160208164823", 02:48:01 INFO - "pgo_build": "False", 02:48:01 INFO - "basedir": "/builds/slave/test", 02:48:01 INFO - "buildnumber": 362, 02:48:01 INFO - "slavename": "t-yosemite-r7-0032", 02:48:01 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 02:48:01 INFO - "platform": "yosemite_r7", 02:48:01 INFO - "scheduler": "tests-fx-team-macosx64-talos", 02:48:01 INFO - "branch": "fx-team", 02:48:01 INFO - "repo_path": "integration/fx-team", 02:48:01 INFO - "revision": "49945e5fe79e6cf2b083f56fd49d917ca886db0b", 02:48:01 INFO - "stage_platform": "macosx64", 02:48:01 INFO - "builduid": "30a40c8c361641e58b7426d55eb90c1e", 02:48:01 INFO - "slavebuilddir": "test" 02:48:01 INFO - } 02:48:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 02:48:01 INFO - Running post-action listener: _resource_record_post_action 02:48:01 INFO - ##### 02:48:01 INFO - ##### Running download-and-extract step. 02:48:01 INFO - ##### 02:48:01 INFO - Running pre-action listener: _resource_record_pre_action 02:48:01 INFO - Running main action method: download_and_extract 02:48:01 INFO - mkdir: /builds/slave/test/build/tests 02:48:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:01 INFO - https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:48:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/test_packages.json 02:48:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/test_packages.json 02:48:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 02:48:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 02:48:03 INFO - Downloaded 1277 bytes. 02:48:03 INFO - Reading from file /builds/slave/test/build/test_packages.json 02:48:03 INFO - Using the following test package requirements: 02:48:03 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 02:48:03 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:48:03 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 02:48:03 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:48:03 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 02:48:03 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:48:03 INFO - u'jsshell-mac.zip'], 02:48:03 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:48:03 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 02:48:03 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 02:48:03 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:48:03 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 02:48:03 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:48:03 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 02:48:03 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:48:03 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 02:48:03 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 02:48:03 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:48:03 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 02:48:03 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 02:48:03 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')]} 02:48:03 INFO - https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:48:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 02:48:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 02:48:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/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 02:48:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/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 02:48:04 INFO - Downloaded 17753849 bytes. 02:48:04 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'] 02:48:04 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 02:48:07 INFO - Return code: 0 02:48:07 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 02:48:07 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')]} 02:48:07 INFO - https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:48:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 02:48:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 02:48:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/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 02:48:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/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 02:48:08 INFO - Downloaded 17753849 bytes. 02:48:08 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'] 02:48:08 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 02:48:12 INFO - Return code: 0 02:48:12 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')]} 02:48:12 INFO - https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:48:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 02:48:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 02:48:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/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 02:48:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/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 02:48:13 INFO - Downloaded 10706547 bytes. 02:48:13 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'] 02:48:13 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 02:48:13 INFO - Return code: 0 02:48:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:13 INFO - https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 02:48:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 02:48:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 02:48:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 02:48:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/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 02:48:17 INFO - Downloaded 111836573 bytes. 02:48:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 02:48:17 INFO - mkdir: /builds/slave/test/properties 02:48:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:48:17 INFO - Writing to file /builds/slave/test/properties/build_url 02:48:17 INFO - Contents: 02:48:17 INFO - build_url:https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 02:48:18 INFO - Running post-action listener: _resource_record_post_action 02:48:18 INFO - Running post-action listener: set_extra_try_arguments 02:48:18 INFO - ##### 02:48:18 INFO - ##### Running populate-webroot step. 02:48:18 INFO - ##### 02:48:18 INFO - Running pre-action listener: _resource_record_pre_action 02:48:18 INFO - Running main action method: populate_webroot 02:48:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:48:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:48:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:48:18 INFO - '--tppagecycles', 02:48:18 INFO - '7'], 02:48:18 INFO - 'tests': ['tsvgm']}}, 02:48:18 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:48:18 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:48:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:48:18 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 02:48:18 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:48:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:48:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:48:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:18 INFO - 'talos_options': ['--e10s'], 02:48:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:48:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:18 INFO - 'tests': ['damp', 'tps']}, 02:48:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:18 INFO - 'talos_options': ['--e10s'], 02:48:18 INFO - 'tests': ['damp', 'tps']}, 02:48:18 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:48:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:48:18 INFO - 'other': {'tests': ['a11yr', 02:48:18 INFO - 'ts_paint', 02:48:18 INFO - 'tpaint', 02:48:18 INFO - 'sessionrestore', 02:48:18 INFO - 'sessionrestore_no_auto_restore']}, 02:48:18 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:48:18 INFO - 'tests': ['a11yr', 02:48:18 INFO - 'ts_paint', 02:48:18 INFO - 'tpaint', 02:48:18 INFO - 'sessionrestore', 02:48:18 INFO - 'sessionrestore_no_auto_restore']}, 02:48:18 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:48:18 INFO - 'tests': ['a11yr', 02:48:18 INFO - 'ts_paint', 02:48:18 INFO - 'tpaint', 02:48:18 INFO - 'sessionrestore', 02:48:18 INFO - 'sessionrestore_no_auto_restore']}, 02:48:18 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:48:18 INFO - 'tests': ['a11yr', 02:48:18 INFO - 'ts_paint', 02:48:18 INFO - 'tpaint', 02:48:18 INFO - 'sessionrestore', 02:48:18 INFO - 'sessionrestore_no_auto_restore']}, 02:48:18 INFO - 'other_l64': {'tests': ['a11yr', 02:48:18 INFO - 'ts_paint', 02:48:18 INFO - 'tpaint', 02:48:18 INFO - 'sessionrestore', 02:48:18 INFO - 'sessionrestore_no_auto_restore']}, 02:48:18 INFO - 'other_nol64': {'tests': ['a11yr', 02:48:18 INFO - 'ts_paint', 02:48:18 INFO - 'tpaint', 02:48:18 INFO - 'sessionrestore', 02:48:18 INFO - 'sessionrestore_no_auto_restore']}, 02:48:18 INFO - 'svgr': {'tests': ['tsvgx', 02:48:18 INFO - 'tsvgr_opacity', 02:48:18 INFO - 'tart', 02:48:18 INFO - 'tscrollx', 02:48:18 INFO - 'cart']}, 02:48:18 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:48:18 INFO - 'tests': ['tsvgx', 02:48:18 INFO - 'tsvgr_opacity', 02:48:18 INFO - 'tart', 02:48:18 INFO - 'tscrollx', 02:48:18 INFO - 'cart']}, 02:48:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:18 INFO - 'tests': ['tp5o']}, 02:48:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:18 INFO - 'talos_options': ['--e10s'], 02:48:18 INFO - 'tests': ['tp5o']}, 02:48:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:18 INFO - 'talos_options': ['--xperf_path', 02:48:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:48:18 INFO - 'tests': ['tp5n']}, 02:48:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:18 INFO - 'talos_options': ['--e10s', 02:48:18 INFO - '--xperf_path', 02:48:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:48:18 INFO - 'tests': ['tp5n']}}, 02:48:18 INFO - 'talos.zip': {'path': '', 02:48:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:48:18 INFO - Running post-action listener: _resource_record_post_action 02:48:18 INFO - ##### 02:48:18 INFO - ##### Running create-virtualenv step. 02:48:18 INFO - ##### 02:48:18 INFO - Running pre-action listener: _resource_record_pre_action 02:48:18 INFO - Running main action method: create_virtualenv 02:48:18 INFO - Creating virtualenv /builds/slave/test/build/venv 02:48:18 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 02:48:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:48:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:48:18 INFO - Using real prefix '/tools/python27' 02:48:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:48:19 INFO - Installing distribute.............................................................................................................................................................................................done. 02:48:22 INFO - Installing pip.................done. 02:48:22 INFO - Return code: 0 02:48:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:48:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101030a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010384c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc450c84890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ed4d30>, '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 0x100cf8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ecbb20>, '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.bRzqGKF7KN/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.dOM7ZMDTJp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 02:48:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:48:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:48:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bRzqGKF7KN/Render', 02:48:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:22 INFO - 'HOME': '/Users/cltbld', 02:48:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:22 INFO - 'LOGNAME': 'cltbld', 02:48:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:22 INFO - 'MOZ_NO_REMOTE': '1', 02:48:22 INFO - 'NO_EM_RESTART': '1', 02:48:22 INFO - 'PAGER': '/bin/cat', 02:48:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:22 INFO - 'PWD': '/builds/slave/test', 02:48:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:22 INFO - 'SHELL': '/bin/bash', 02:48:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dOM7ZMDTJp/Listeners', 02:48:22 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 02:48:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:22 INFO - 'USER': 'cltbld', 02:48:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:22 INFO - 'XPC_FLAGS': '0x0', 02:48:22 INFO - 'XPC_SERVICE_NAME': '0', 02:48:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:22 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 02:48:22 INFO - Cleaning up... 02:48:22 INFO - Return code: 0 02:48:22 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:48:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101030a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010384c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc450c84890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ed4d30>, '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 0x100cf8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ecbb20>, '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.bRzqGKF7KN/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.dOM7ZMDTJp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 02:48:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:48:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:48:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bRzqGKF7KN/Render', 02:48:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:22 INFO - 'HOME': '/Users/cltbld', 02:48:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:22 INFO - 'LOGNAME': 'cltbld', 02:48:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:22 INFO - 'MOZ_NO_REMOTE': '1', 02:48:22 INFO - 'NO_EM_RESTART': '1', 02:48:22 INFO - 'PAGER': '/bin/cat', 02:48:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:22 INFO - 'PWD': '/builds/slave/test', 02:48:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:22 INFO - 'SHELL': '/bin/bash', 02:48:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dOM7ZMDTJp/Listeners', 02:48:22 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 02:48:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:22 INFO - 'USER': 'cltbld', 02:48:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:22 INFO - 'XPC_FLAGS': '0x0', 02:48:22 INFO - 'XPC_SERVICE_NAME': '0', 02:48:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:22 INFO - Downloading/unpacking psutil>=0.7.1 02:48:22 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 02:48:22 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 02:48:22 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 02:48:22 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 02:48:22 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 02:48:22 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 02:48:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:48:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:48:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:48:25 INFO - Installing collected packages: psutil 02:48:25 INFO - Running setup.py install for psutil 02:48:25 INFO - building 'psutil._psutil_osx' extension 02:48:25 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 02:48:26 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 02:48:26 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 02:48:26 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 02:48:26 INFO - building 'psutil._psutil_posix' extension 02:48:26 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 02:48:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:48:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:48:26 INFO - ^ 02:48:26 INFO - 1 warning generated. 02:48:26 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 02:48:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:48:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:48:26 INFO - Successfully installed psutil 02:48:26 INFO - Cleaning up... 02:48:26 INFO - Return code: 0 02:48:26 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:48:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101030a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010384c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc450c84890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ed4d30>, '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 0x100cf8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ecbb20>, '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.bRzqGKF7KN/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.dOM7ZMDTJp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 02:48:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 02:48:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 02:48:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bRzqGKF7KN/Render', 02:48:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:26 INFO - 'HOME': '/Users/cltbld', 02:48:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:26 INFO - 'LOGNAME': 'cltbld', 02:48:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:26 INFO - 'MOZ_NO_REMOTE': '1', 02:48:26 INFO - 'NO_EM_RESTART': '1', 02:48:26 INFO - 'PAGER': '/bin/cat', 02:48:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:26 INFO - 'PWD': '/builds/slave/test', 02:48:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:26 INFO - 'SHELL': '/bin/bash', 02:48:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dOM7ZMDTJp/Listeners', 02:48:26 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 02:48:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:26 INFO - 'USER': 'cltbld', 02:48:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:26 INFO - 'XPC_FLAGS': '0x0', 02:48:26 INFO - 'XPC_SERVICE_NAME': '0', 02:48:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:27 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:48:27 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 02:48:27 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 02:48:27 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 02:48:27 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 02:48:27 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 02:48:27 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 02:48:29 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:48:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:48:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:48:29 INFO - Installing collected packages: mozsystemmonitor 02:48:29 INFO - Running setup.py install for mozsystemmonitor 02:48:29 INFO - Successfully installed mozsystemmonitor 02:48:29 INFO - Cleaning up... 02:48:29 INFO - Return code: 0 02:48:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:48:29 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')]} 02:48:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:29 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')]} 02:48:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x101030a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010384c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc450c84890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ed4d30>, '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 0x100cf8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ecbb20>, '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.bRzqGKF7KN/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.dOM7ZMDTJp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 02:48:29 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 02:48:29 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 02:48:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bRzqGKF7KN/Render', 02:48:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:29 INFO - 'HOME': '/Users/cltbld', 02:48:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:29 INFO - 'LOGNAME': 'cltbld', 02:48:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:29 INFO - 'MOZ_NO_REMOTE': '1', 02:48:29 INFO - 'NO_EM_RESTART': '1', 02:48:29 INFO - 'PAGER': '/bin/cat', 02:48:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:29 INFO - 'PWD': '/builds/slave/test', 02:48:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:29 INFO - 'SHELL': '/bin/bash', 02:48:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dOM7ZMDTJp/Listeners', 02:48:29 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 02:48:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:29 INFO - 'USER': 'cltbld', 02:48:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:29 INFO - 'XPC_FLAGS': '0x0', 02:48:29 INFO - 'XPC_SERVICE_NAME': '0', 02:48:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:29 INFO - Downloading/unpacking blobuploader==1.2.4 02:48:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:32 INFO - Downloading blobuploader-1.2.4.tar.gz 02:48:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:48:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:32 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 02:48:32 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 02:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:48:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:32 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 02:48:32 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 02:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:33 INFO - Downloading docopt-0.6.1.tar.gz 02:48:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:48:33 INFO - Installing collected packages: blobuploader, requests, docopt 02:48:33 INFO - Running setup.py install for blobuploader 02:48:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:48:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:48:33 INFO - Running setup.py install for requests 02:48:34 INFO - Running setup.py install for docopt 02:48:34 INFO - Successfully installed blobuploader requests docopt 02:48:34 INFO - Cleaning up... 02:48:34 INFO - Return code: 0 02:48:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:48:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:34 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 0x101030a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010384c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc450c84890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ed4d30>, '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 0x100cf8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ecbb20>, '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.bRzqGKF7KN/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.dOM7ZMDTJp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 02:48:34 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 02:48:34 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 02:48:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bRzqGKF7KN/Render', 02:48:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:34 INFO - 'HOME': '/Users/cltbld', 02:48:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:34 INFO - 'LOGNAME': 'cltbld', 02:48:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:34 INFO - 'MOZ_NO_REMOTE': '1', 02:48:34 INFO - 'NO_EM_RESTART': '1', 02:48:34 INFO - 'PAGER': '/bin/cat', 02:48:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:34 INFO - 'PWD': '/builds/slave/test', 02:48:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:34 INFO - 'SHELL': '/bin/bash', 02:48:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dOM7ZMDTJp/Listeners', 02:48:34 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 02:48:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:34 INFO - 'USER': 'cltbld', 02:48:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:34 INFO - 'XPC_FLAGS': '0x0', 02:48:34 INFO - 'XPC_SERVICE_NAME': '0', 02:48:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:48:34 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-4umxX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:48:34 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-Mz58tT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:48:34 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-D2jiKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:48:34 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-6ewChk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:48:35 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-LC1gxI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:48:35 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-Viw9Ci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:48:35 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-zK7jTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:48:35 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-ed7Shv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:48:35 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-AkDTYZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:48:35 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-HmeqlR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:48:35 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-YK1wyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:48:35 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-ONZ4LR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:48:35 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-nPid2v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:48:35 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-OBQiF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:48:36 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-H7buBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:48:36 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-prPSYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:48:36 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-vMQvYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:48:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:48:36 INFO - Running setup.py install for manifestparser 02:48:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:48:36 INFO - Running setup.py install for mozcrash 02:48:36 INFO - Running setup.py install for mozdebug 02:48:36 INFO - Running setup.py install for mozdevice 02:48:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:48:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:48:36 INFO - Running setup.py install for mozfile 02:48:37 INFO - Running setup.py install for mozhttpd 02:48:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:48:37 INFO - Running setup.py install for mozinfo 02:48:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:48:37 INFO - Running setup.py install for mozInstall 02:48:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:48:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:48:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:48:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:48:37 INFO - Running setup.py install for mozleak 02:48:37 INFO - Running setup.py install for mozlog 02:48:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:48:37 INFO - Running setup.py install for moznetwork 02:48:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:48:37 INFO - Running setup.py install for mozprocess 02:48:38 INFO - Running setup.py install for mozprofile 02:48:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:48:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:48:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:48:38 INFO - Running setup.py install for mozrunner 02:48:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:48:38 INFO - Running setup.py install for mozscreenshot 02:48:38 INFO - Running setup.py install for moztest 02:48:38 INFO - Running setup.py install for mozversion 02:48:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:48:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:48:38 INFO - Cleaning up... 02:48:38 INFO - Return code: 0 02:48:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:48:38 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')]} 02:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:38 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')]} 02:48:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:38 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 0x101030a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010384c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc450c84890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ed4d30>, '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 0x100cf8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ecbb20>, '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.bRzqGKF7KN/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.dOM7ZMDTJp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 02:48:38 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 02:48:38 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 02:48:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bRzqGKF7KN/Render', 02:48:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:38 INFO - 'HOME': '/Users/cltbld', 02:48:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:38 INFO - 'LOGNAME': 'cltbld', 02:48:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:38 INFO - 'MOZ_NO_REMOTE': '1', 02:48:38 INFO - 'NO_EM_RESTART': '1', 02:48:38 INFO - 'PAGER': '/bin/cat', 02:48:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:38 INFO - 'PWD': '/builds/slave/test', 02:48:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:38 INFO - 'SHELL': '/bin/bash', 02:48:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dOM7ZMDTJp/Listeners', 02:48:38 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 02:48:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:38 INFO - 'USER': 'cltbld', 02:48:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:38 INFO - 'XPC_FLAGS': '0x0', 02:48:38 INFO - 'XPC_SERVICE_NAME': '0', 02:48:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:48:39 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-_XqkLv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:48:39 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)) 02:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:48:39 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-vnTYtb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:48:39 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)) 02:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:48:39 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-C8OULZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:48:39 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)) 02:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:48:39 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-qgroU6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:48:39 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)) 02:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:48:39 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-VeiDgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:48:39 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)) 02:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:48:39 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-5LqRjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:48:39 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)) 02:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:48:39 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-bRBPAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:48:39 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)) 02:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:48:39 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-1UShGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:48:40 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)) 02:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:48:40 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-QlXfIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:48:40 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)) 02:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:48:40 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-ryXpRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:48:40 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)) 02:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:48:40 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-My_odj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:48:40 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)) 02:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:48:40 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-XXfvqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:48:40 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)) 02:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:48:40 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-ozkecz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:48:40 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)) 02:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:48:40 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-_P2EnS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:48:40 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)) 02:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:48:40 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-H1Lce5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:48:40 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)) 02:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:48:40 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-FSPwxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:48:40 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)) 02:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:48:40 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-MYUeqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:48:40 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)) 02:48:40 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)) 02:48:40 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)) 02:48:40 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)) 02:48:40 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)) 02:48:40 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)) 02:48:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:48:40 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 02:48:40 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 02:48:40 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 02:48:40 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 02:48:40 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 02:48:40 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 02:48:43 INFO - Downloading blessings-1.6.tar.gz 02:48:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:48:43 INFO - Installing collected packages: blessings 02:48:43 INFO - Running setup.py install for blessings 02:48:43 INFO - Successfully installed blessings 02:48:43 INFO - Cleaning up... 02:48:43 INFO - Return code: 0 02:48:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:48:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:48:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:48:43 INFO - Reading from file tmpfile_stdout 02:48:43 INFO - Current package versions: 02:48:43 INFO - blessings == 1.6 02:48:43 INFO - blobuploader == 1.2.4 02:48:43 INFO - docopt == 0.6.1 02:48:43 INFO - manifestparser == 1.1 02:48:43 INFO - mozInstall == 1.12 02:48:43 INFO - mozcrash == 0.16 02:48:43 INFO - mozdebug == 0.1 02:48:43 INFO - mozdevice == 0.48 02:48:43 INFO - mozfile == 1.2 02:48:43 INFO - mozhttpd == 0.7 02:48:43 INFO - mozinfo == 0.9 02:48:43 INFO - mozleak == 0.1 02:48:43 INFO - mozlog == 3.1 02:48:43 INFO - moznetwork == 0.27 02:48:43 INFO - mozprocess == 0.22 02:48:43 INFO - mozprofile == 0.28 02:48:43 INFO - mozrunner == 6.11 02:48:43 INFO - mozscreenshot == 0.1 02:48:43 INFO - mozsystemmonitor == 0.0 02:48:43 INFO - moztest == 0.7 02:48:43 INFO - mozversion == 1.4 02:48:43 INFO - psutil == 3.1.1 02:48:43 INFO - requests == 1.2.3 02:48:43 INFO - wsgiref == 0.1.2 02:48:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:48:43 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')]} 02:48:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:43 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')]} 02:48:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:43 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 0x101030a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010384c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc450c84890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ed4d30>, '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 0x100cf8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ecbb20>, '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.bRzqGKF7KN/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.dOM7ZMDTJp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 02:48:43 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 02:48:43 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 02:48:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bRzqGKF7KN/Render', 02:48:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:43 INFO - 'HOME': '/Users/cltbld', 02:48:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:43 INFO - 'LOGNAME': 'cltbld', 02:48:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:43 INFO - 'MOZ_NO_REMOTE': '1', 02:48:43 INFO - 'NO_EM_RESTART': '1', 02:48:43 INFO - 'PAGER': '/bin/cat', 02:48:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:43 INFO - 'PWD': '/builds/slave/test', 02:48:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:43 INFO - 'SHELL': '/bin/bash', 02:48:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dOM7ZMDTJp/Listeners', 02:48:43 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 02:48:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:43 INFO - 'USER': 'cltbld', 02:48:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:43 INFO - 'XPC_FLAGS': '0x0', 02:48:43 INFO - 'XPC_SERVICE_NAME': '0', 02:48:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:44 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)) 02:48:44 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)) 02:48:44 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)) 02:48:44 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)) 02:48:44 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)) 02:48:44 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)) 02:48:44 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)) 02:48:44 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)) 02:48:44 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)) 02:48:44 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)) 02:48:44 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)) 02:48:44 INFO - Cleaning up... 02:48:44 INFO - Return code: 0 02:48:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:48:44 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')]} 02:48:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:44 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')]} 02:48:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:44 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 0x101030a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010384c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc450c84890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ed4d30>, '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 0x100cf8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ecbb20>, '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.bRzqGKF7KN/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.dOM7ZMDTJp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 02:48:44 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 02:48:44 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 02:48:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bRzqGKF7KN/Render', 02:48:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:44 INFO - 'HOME': '/Users/cltbld', 02:48:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:44 INFO - 'LOGNAME': 'cltbld', 02:48:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:44 INFO - 'MOZ_NO_REMOTE': '1', 02:48:44 INFO - 'NO_EM_RESTART': '1', 02:48:44 INFO - 'PAGER': '/bin/cat', 02:48:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:44 INFO - 'PWD': '/builds/slave/test', 02:48:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:44 INFO - 'SHELL': '/bin/bash', 02:48:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dOM7ZMDTJp/Listeners', 02:48:44 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 02:48:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:44 INFO - 'USER': 'cltbld', 02:48:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:44 INFO - 'XPC_FLAGS': '0x0', 02:48:44 INFO - 'XPC_SERVICE_NAME': '0', 02:48:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:44 INFO - Downloading/unpacking jsonschema 02:48: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 02:48: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 02:48: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 02:48: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 02:48: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 02:48: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 02:48:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:48:46 INFO - Downloading/unpacking functools32 (from jsonschema) 02:48:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:46 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 02:48:46 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 02:48:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:47 INFO - Downloading functools32-3.2.3-2.tar.gz 02:48:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:48:47 INFO - warning: no files found matching '*.txt' 02:48:47 INFO - no previously-included directories found matching 'build' 02:48:47 INFO - no previously-included directories found matching 'dist' 02:48:47 INFO - no previously-included directories found matching '.git*' 02:48:47 INFO - Installing collected packages: jsonschema, functools32 02:48:47 INFO - Running setup.py install for functools32 02:48:47 INFO - warning: no files found matching '*.txt' 02:48:47 INFO - no previously-included directories found matching 'build' 02:48:47 INFO - no previously-included directories found matching 'dist' 02:48:47 INFO - no previously-included directories found matching '.git*' 02:48:47 INFO - Successfully installed jsonschema functools32 02:48:47 INFO - Cleaning up... 02:48:47 INFO - Return code: 0 02:48:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:48:47 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')]} 02:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:47 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')]} 02:48:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:47 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 0x101030a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010384c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc450c84890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ed4d30>, '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 0x100cf8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ecbb20>, '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.bRzqGKF7KN/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.dOM7ZMDTJp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 02:48:47 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 02:48:47 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 02:48:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bRzqGKF7KN/Render', 02:48:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:47 INFO - 'HOME': '/Users/cltbld', 02:48:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:47 INFO - 'LOGNAME': 'cltbld', 02:48:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:47 INFO - 'MOZ_NO_REMOTE': '1', 02:48:47 INFO - 'NO_EM_RESTART': '1', 02:48:47 INFO - 'PAGER': '/bin/cat', 02:48:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:47 INFO - 'PWD': '/builds/slave/test', 02:48:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:47 INFO - 'SHELL': '/bin/bash', 02:48:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dOM7ZMDTJp/Listeners', 02:48:47 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 02:48:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:47 INFO - 'USER': 'cltbld', 02:48:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:47 INFO - 'XPC_FLAGS': '0x0', 02:48:47 INFO - 'XPC_SERVICE_NAME': '0', 02:48:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:47 INFO - Downloading/unpacking flake8 02:48:47 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 02:48:47 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 02:48:47 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 02:48:47 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 02:48:47 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 02:48:47 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 02:48:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:48:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:48:50 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 02:48:50 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 02:48:50 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 02:48:50 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 02:48:50 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 02:48:50 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 02:48:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:48:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:48:50 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 02:48:50 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 02:48:50 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 02:48:50 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 02:48:50 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 02:48:50 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 02:48:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:48:50 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 02:48:50 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 02:48:50 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 02:48:50 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 02:48:50 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 02:48:50 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 02:48:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:48:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:48:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:48:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:48:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:48:51 INFO - no previously-included directories found matching 'docs/_build' 02:48:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:48:51 INFO - Running setup.py install for pep8 02:48:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:48:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:48:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:48:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:48:51 INFO - no previously-included directories found matching 'docs/_build' 02:48:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:48:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:48:51 INFO - Cleaning up... 02:48:51 INFO - Return code: 0 02:48:51 INFO - Running post-action listener: _resource_record_post_action 02:48:51 INFO - Running post-action listener: _start_resource_monitoring 02:48:51 INFO - Starting resource monitoring. 02:48:51 INFO - ##### 02:48:51 INFO - ##### Running install step. 02:48:51 INFO - ##### 02:48:51 INFO - Running pre-action listener: _resource_record_pre_action 02:48:51 INFO - Running main action method: install 02:48:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:48:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:48:51 INFO - Reading from file tmpfile_stdout 02:48:51 INFO - Detecting whether we're running mozinstall >=1.0... 02:48:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:48:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:48:52 INFO - Reading from file tmpfile_stdout 02:48:52 INFO - Output received: 02:48:52 INFO - Usage: mozinstall [options] installer 02:48:52 INFO - Options: 02:48:52 INFO - -h, --help show this help message and exit 02:48:52 INFO - -d DEST, --destination=DEST 02:48:52 INFO - Directory to install application into. [default: 02:48:52 INFO - "/builds/slave/test"] 02:48:52 INFO - --app=APP Application being installed. [default: firefox] 02:48:52 INFO - mkdir: /builds/slave/test/build/application 02:48:52 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'] 02:48:52 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 02:49:25 INFO - Reading from file tmpfile_stdout 02:49:25 INFO - Output received: 02:49:25 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 02:49:25 INFO - Running post-action listener: _resource_record_post_action 02:49:25 INFO - ##### 02:49:25 INFO - ##### Running run-tests step. 02:49:25 INFO - ##### 02:49:25 INFO - Running pre-action listener: _resource_record_pre_action 02:49:25 INFO - Running main action method: run_tests 02:49:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:49:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:49:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:49:25 INFO - 2016-02-10 02:49:25.954 screenresolution[1655:7913] starting screenresolution argv=screenresolution get 02:49:25 INFO - 2016-02-10 02:49:25.957 screenresolution[1655:7913] Display 0: 1600x1200x32@60 02:49:25 INFO - 2016-02-10 02:49:25.962 screenresolution[1656:7915] starting screenresolution argv=screenresolution list 02:49:25 INFO - Available Modes on Display 0 02:49:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:49:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:49:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:49:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:49:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:49:26 INFO - Intel Iris: 02:49:26 INFO - Chipset Model: Intel Iris 02:49:26 INFO - Type: GPU 02:49:26 INFO - Bus: Built-In 02:49:26 INFO - VRAM (Dynamic, Max): 1536 MB 02:49:26 INFO - Vendor: Intel (0x8086) 02:49:26 INFO - Device ID: 0x0a2e 02:49:26 INFO - Revision ID: 0x0009 02:49:26 INFO - Displays: 02:49:26 INFO - Display: 02:49:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:49:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:49:26 INFO - Display Serial Number: 1600x1200 60 02:49:26 INFO - Main Display: Yes 02:49:26 INFO - Mirror: Off 02:49:26 INFO - Online: Yes 02:49:26 INFO - Rotation: Supported 02:49:26 INFO - Return code: 0 02:49:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:49:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:49:26 INFO - Python 2.7.3 02:49:26 INFO - Return code: 0 02:49:26 INFO - grabbing minidump binary from tooltool 02:49:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:49:26 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 0x100ed4d30>, '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 0x100cf8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ecbb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:49:26 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 02:49:26 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 02:49:26 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:49:26 INFO - Return code: 0 02:49:26 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:49:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:49:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:49:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:49:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:49:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:49:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:49:27 INFO - Return code: 0 02:49:27 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/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0032', '--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 02:49:27 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/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0032 --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 02:49:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bRzqGKF7KN/Render', 02:49:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:49:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:49:27 INFO - 'HOME': '/Users/cltbld', 02:49:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:49:27 INFO - 'LOGNAME': 'cltbld', 02:49:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:49:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:49:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:49:27 INFO - 'MOZ_NO_REMOTE': '1', 02:49:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:49:27 INFO - 'NO_EM_RESTART': '1', 02:49:27 INFO - 'PAGER': '/bin/cat', 02:49:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:49:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:49:27 INFO - 'PWD': '/builds/slave/test', 02:49:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:49:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:49:27 INFO - 'SHELL': '/bin/bash', 02:49:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dOM7ZMDTJp/Listeners', 02:49:27 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 02:49:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:49:27 INFO - 'USER': 'cltbld', 02:49:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:49:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:49:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:49:27 INFO - 'XPC_FLAGS': '0x0', 02:49:27 INFO - 'XPC_SERVICE_NAME': '0', 02:49:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:49:27 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/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0032', '--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 02:49:27 INFO - mozversion application_buildid: 20160208164823 02:49:27 INFO - mozversion application_changeset: 49945e5fe79e6cf2b083f56fd49d917ca886db0b 02:49:27 INFO - mozversion application_display_name: Nightly 02:49:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:49:27 INFO - mozversion application_name: Firefox 02:49:27 INFO - mozversion application_remotingname: firefox 02:49:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:49:27 INFO - mozversion application_vendor: Mozilla 02:49:27 INFO - mozversion application_version: 47.0a1 02:49:27 INFO - mozversion platform_buildid: 20160208164823 02:49:27 INFO - mozversion platform_changeset: 49945e5fe79e6cf2b083f56fd49d917ca886db0b 02:49:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:49:27 INFO - mozversion platform_version: 47.0a1 02:49:27 INFO - using testdate: 1455101367 02:49:27 INFO - actual date: 1455101367 02:49:28 INFO - starting webserver on 'localhost:49279' 02:49:28 INFO - SUITE-START | Running 2 tests 02:49:28 INFO - TEST-START | dromaeo_css 02:49:28 INFO - operating with platform_type : mac_ 02:49:28 INFO - Initialising browser for dromaeo_css test... 02:49:28 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmp5eZXuJ/profile http://localhost:49279/getInfo.html) 02:49:30 INFO - PROCESS | 1674 | __metrics Screen width/height:1600/1200 02:49:30 INFO - PROCESS | 1674 | colorDepth:24 02:49:30 INFO - PROCESS | 1674 | Browser inner width/height: 1024/689 02:49:30 INFO - PROCESS | 1674 | __metrics 02:49:30 INFO - PROCESS | 1674 | 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" 02:49:30 INFO - PROCESS | 1674 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:49:31 INFO - TEST-INFO | 1674: exit 0 02:49:31 INFO - Browser initialized. 02:49:31 INFO - Running cycle 1/1 for dromaeo_css test... 02:49:31 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmp5eZXuJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:49:42 INFO - PROCESS | 1677 | RSS: Main: 246030336 02:49:42 INFO - PROCESS | 1677 | 02:50:40 INFO - PROCESS | 1677 | 1455101440162 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] 02:52:45 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49279/tests/dromaeo/cssquery-ext.html) 02:52:46 INFO - PROCESS | 1677 | RSS: Main: 367042560 02:52:46 INFO - PROCESS | 1677 | 02:55:49 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-ext.html (next: http://localhost:49279/tests/dromaeo/cssquery-jquery.html) 02:55:49 INFO - PROCESS | 1677 | RSS: Main: 381386752 02:55:49 INFO - PROCESS | 1677 | 02:58:52 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49279/tests/dromaeo/cssquery-mootools.html) 02:58:52 INFO - PROCESS | 1677 | RSS: Main: 378740736 02:58:52 INFO - PROCESS | 1677 | 03:01:54 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49279/tests/dromaeo/cssquery-prototype.html) 03:01:55 INFO - PROCESS | 1677 | RSS: Main: 344219648 03:01:55 INFO - PROCESS | 1677 | 03:04:58 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49279/tests/dromaeo/cssquery-yui.html) 03:04:59 INFO - PROCESS | 1677 | RSS: Main: 344805376 03:04:59 INFO - PROCESS | 1677 | 03:08:02 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-yui.html (next: http://localhost:49279/tests/dromaeo/cssquery-dojo.html) 03:08:02 INFO - PROCESS | 1677 | RSS: Main: 420442112 03:08:02 INFO - PROCESS | 1677 | 03:08:02 INFO - PROCESS | 1677 | __start_tp_report 03:08:02 INFO - PROCESS | 1677 | _x_x_mozilla_page_load 03:08:02 INFO - PROCESS | 1677 | _x_x_mozilla_page_load_details 03:08:02 INFO - PROCESS | 1677 | |i|pagename|runs| 03:08:02 INFO - PROCESS | 1677 | |0;dojo.html;3446.879359222427;3483.372992861284;3505.2638945821377;3518.4018716818136;3539.026767638899;5654.180143879135;5666.178404131399;5702.857428564288;5730.426957304273;5732.31212254529;5715.971420142904;5796.68118253497;5798.884022319551;5799.362070172288;5819.67991760453;5132.97433512832;5168.250603662466;5180.197069454241;5202.583793296527;5237.8952420951555;5239.397469291023;5245.239440281157;5254.842354729364;5255.369355677305;5259.737013149346;4386.868393948187;5202.271681964509;5214.634975551713;5228.660137091096;5241.0042092002395;5246.396664383607;5252.949410117953;5253.921191182136;5257.579393648499;5259.447757985395;4399.428074350314;5136.203888397305;5189.6886186828915;5254.500822421864;5273.736313184364;5619;5645.576581756343;5682.602217844753;5713.800016999427;5727.284089488814;6248.125262463259;6254.0618907163835;6265.780697675559;6274.466670333027;6287.622742635456;6106.2977757558;6108.694565271763;6214.5960512566535;6220.253569571681;6253.749850005995;5866.589338746289;5874.236349274653;5896.292444906639;5899.380565040695;5911.083782013795;6094.8171554853425;6236.656983865931;6268.091126786681;6269.153664255358;6274.592151510137;6063.727132279058;6101.398774955092;6155.076738489173;6189.164462797465;6198.845028874224;5312.468753124656;6104.298005729309;6201;6252.030935205051;6286.5599408041;6216.689165541705;6279.560430769893;6283.59156654816;6287.842803929847;6301.306856245809;6100.641728746782;6115.483736156547;6218.782342617987;6242.656653883989;6265.561410701207;4905.607551395879;4907.558319751168;4912.828051018198;4915.992221594564;4946.86222168896;4414.823407063745;4418.779061046935;4434.800433980478;4449.599536041772;4458.888527786831;5558.44415558449;5653.321601407857;5660.518855897295;5728.198052272685;5784.71076446176;6205.100260462208;6210.7515699371515;6211.782587609412;6216.036514340284;6221.502279817604;5589.413111623221;5736.62711923732;5737.942620573825;5745.195672605755;5750.079987202112;5322.4411436799355;5356.517913387814;5390.865228369322;5392.73036348181;5409.350877894678;4888.926666100083;6246.281677607133;6271.78048768291;6318.778842740482;6346.397092276226;6200.596961197508;6202.2867370253;6211.440970312513;6224.62652240867;6225.501959843292;6285.874282514415;6301.180846489927;6316.242050953915;6339.936600633934;6340.524460665376;6063.151158837678;6114.084479019511;6130.306415576139;6130.917941862889;6144.539159562962;6124.289394098022;6231.439170474498;6233;6237.781677641261;6246.125542424155;5558.805441809517;5972.790952316822;6064.727087280995;6080.513558915364;6081.452669259611;5938.703064846827;6070.362611925861;6078.574499784972;6105.389461053859;6105.603135796159;5984.880302393841;6031.517478601613;6036.517078633611;6063.787767428295;6094.055421409688;6120.770032358895;6146.231721034871;6150.7539698411565;6157.415045570664;6163.599366041193;5829.970850145722;5941.643501389931;5997.430244126801;6019.1573179754;6023.879522409615 03:08:02 INFO - PROCESS | 1677 | |1;ext.html;485.28905153949455;522.6237109281318;552.5496720173057;578.1472328315732;602.8914795336839;29276.560851587215;36883;37432.625673743256;37447.625523744755;37517.62482375176;33364.833175834145;39863.40204896929;40147.19705605893;40214.39678404819;40341.79829100858;9320.533973301342;9573.760655983622;9580.712578622653;9584.856227156599;9632.80734385312;9450;9518.666846660368;9577.329586928918;9583.377080489747;9589.568469418859;9701.757456063584;9798.510074496282;9812.313138080337;9826.852597211047;9848.90151098487;9644.132028117469;9739.756506087333;9770.36492627977;9775.75560610987;9776.755581110458;9428.057194280516;9582.616695332179;9590.232781377474;9602.039796020412;9606.90393096067;38524.80737596294;38991.220175596616;39061.609383906085;39116.41325380121;39208.80395598032;3203.2952750395107;3207.83960801959;3327.5341452196712;3357.731381489475;3584.8207589620415;22750.431239218986;28170.577441338395;28217.717822821713;28248;29700;2837.1346739244523;2862.427514497109;2884.668263149744;2915.1400336900665;2919.6642386125654;384644;391281;392355.0382248099;392389;392397;59340;60739.69630151821;63134.36865631377;64415;64439.67780161163;73718.26281737114;74607;74917;75055.87416188761;75186.62406688041;16271;16454.341826326814;16484.258208380652;16509.9268547544;16557.91721041411;10013.898471168166;11563.132765042656;12446.439910204062;12595.811062834066;12770.9361453194;21887.12451501954;22537.323880283617;22564.66153007706;22586.548269034527;22622.208222712125;8928.910710892807;9706.563204655808;9723.61105555784;9747.268954828416;9761.804763904824;952.0859974424492;984.3109823123699;1009.8081364540714;1014.6600888702368;1154.3766366162347;27167.320816979733;27607.723922760917;29398.853005735262;29649.407011859643;30328.393432131234;1056.2078441169124;1080.1682704317632;1105.0275757333495;1162.610525473959;1204.837346958167;13054.34728263583;13813.723725525433;13845.861541384456;14156.150630962175;14229.28853557318;662791;670570;670622;670991;672471;47258.76370618193;54153;54536;54877;55291;1424.8290205175444;1439.0502268502737;1454.5636309107438;1454.6290695872485;1457.7959085728007;22453;27309.590356145072;27411.45177096407;27771.166864994084;28504.714952850205;43922.34116488192;49535.25697114474;50524.179235802694;50532.747336263084;50625.49374506355;333197;334538;337211;337990;338532.30733846175;30574.694253058075;30709.23226919345;30820.075397738103;30845.537316939815;30868.765249389773;38849.2230155401;39277.41083883801;39758.20483590254;40676.79661601673;41450.79274603607;33502;34688.479672804424;35076.82461587676;35342.64657353496;36022.639773602976;29960.550591741576;34623;34648;34729.65270347264;35583.754568589975;34995.12512187216;35664.643353566134;36151.27697445984;36173;36186.45720314145;31317.686823131477;32183.51724724178;32338.83830580832;32970.835145824116;33009.50485742668;23270.72011039409;23435.53128937446;23480.17819376382;23824.642630360904;24017 03:08:02 INFO - PROCESS | 1677 | |2;jquery.html;358.2798574864522;362.6301172803741;363.30608537692996;371.17413754396455;371.63950967561453;12298.569550065728;15006.249687515636;18709.906450467744;18802.43592692218;19453.70819437708;11690.824637630443;11710.765784684323;11925.58260460884;11943.34311612861;11972.461239244232;5084.745762711859;5267.841964741045;5278.709670968095;5285.418603953582;5294.073537131006;3930.862419815307;4098.672106231495;5837.299524057098;6044.788432404866;6049.243844519435;6010.669413182273;6044.758209671608;6169.537284703642;6232.158658581079;6566.80299591013;5654.547636189095;6303.968480157616;6305.87388252237;6311.968440157792;6333.271673757531;5609.971950140264;5614.017546929312;5621.634593751393;5623.7469313880565;5626.409227031144;13594;22651.773482265133;23523.17668881581;23605.819709014653;23636.527269454513;2100.9810242032754;2157.126363822654;2165.307101727448;2286.211257116292;2759.6274502942247;10234.02776736209;10385.79228415435;11003.61487347939;12167.574134905324;14039.806616437512;1697.2532085882171;1781.2607767776358;1784.4022252545412;1798.739182818497;1841.0886611127444;79754;95051;101067;102231.97768022299;102890.97109028963;11070.28043177191;11132.944335278435;11144.721381965353;11150.888491115147;11289.153313501356;13471.528496502771;13617.182969021891;13618.523351682643;13667.726645467035;13703.657408564666;8343.123971982854;8344.8331033379;8356.874646880302;8456.577171141418;8464.44981076228;8380;8392.454490458224;8397.28623067034;8498.532580707997;8500.277476414574;3997.220541994341;4177.874663760092;4180;4326.848560300375;4462.620677242471;1620.6758648270393;1656.436811484101;1764.7441121037377;1794.452691928948;1806.683830329687;861.9396642235109;900.2797761790672;904.6426661468814;981.9165370943407;1024.2113572549094;18889.7166542502;19396.515087122934;19649.508762281057;19879.30422435208;20770.48073798137;847.7711018025099;923.2060428031887;932.2728271947891;938.2681508423441;947.1049857884233;10326.48367581618;10603.628872989408;10838.458077096271;10844.620438284623;10874.945625271823;590099;642028;726822;763003;767243;106589;108254.91745082449;111711.44144279226;114202;116277.8372216267;1192.8986036186848;1194.7909115904856;1229.883161099694;1251.6620512461584;1281.564268148834;18257;18645.627087457902;18659.880407175613;18686.34597789071;18733.812661873206;45519.77240113778;48029.519704803904;49045.5095449041;49762.75118624384;50927;63842;64043;64200.678996604714;64289.035664464136;65548.67225663841;7515.887261690969;7801.804954876174;7841.529508229524;7845.725399610987;7858.292753652198;10729.785404291715;11464.885351146382;12154.574589889311;12198.13343864209;12325.322107284186;7223.602701851449;8406.201410865959;10073.597056117673;10482.63310784119;10592.89407105919;10027.247956403446;10137.341072830242;10155.933626969061;10397.948010259901;10402.895971040496;7338.77983660491;7814.22633114842;8488.533130677624;8814;10995.890041099487;6584.670766461753;7726.18875018115;7768.262015108556;7879.0151231096115;7908.762737117896;5763.049096898964;6432.9678351607945;9724.124828765445;10875.619353322596;11039.944800275947 03:08:02 INFO - PROCESS | 1677 | |3;mootools.html;1400.6988497473042;1521.1557585540024;1554.285028886712;1790.2480957997639;1940.175425444186;7898.328642065424;8589.91410085899;8776.2101410873;8781.868271975925;8800.471971681704;8388.496690198592;8610.87083693745;8614.095519970408;8619.094995025525;8624.525651089187;2183.170395249811;2244.2930476899805;2247.752747197807;2445.0586524188184;2473.727889932106;2062.6493496105622;2254.571631390039;2258.627326491127;2483.1681386735463;2490.2902672738273;2416.1060407649193;2440.670509481224;2445.8410203336816;2453.325335532725;2479.0579579759665;2413.3363325085566;2451.9754802451926;2453.8036957043396;2456.385903524128;2457.164564048232;2447.7919376852988;2452.350127216271;2454.521368333176;2454.8036157107567;2461.54461424637;8813.603387847563;8907.643694252221;8911.376203665746;8916.019237883827;8936.8659470108;5322.840314790563;5352.197170424468;5482.876010417895;5483.287172667528;5484.341878974548;3133.2166958260436;3578.177019285579;3714.9814250928844;3773.811309434545;3776.4524143998965;1010.6563768318733;1025.3232866308201;1056.1497994114734;1087.722630729159;1111.1166622535104;12016.759664806656;12028.977536909373;12033.819492707617;12068.275903445909;12096.81854772179;4792.880177995578;4860.441049279308;4861.951380486221;4892.681975671641;4913.1893237615395;9887.901120988841;9899.307048506535;10059.994000600027;10106.140978016803;10132;5403.189521571796;5453.372862120827;5457.590680698963;5457.83626491198;5464.9453505464435;4959.975200123977;4966.850994470172;4971.403431588233;4979.502049794992;4980.7509624518625;3588.7667301625834;3696.353138200804;3861;3913.9021524461546;3961.900952476211;1217.3548019549653;1237.461704158676;1267.714764178071;1296.598054603076;1296.7536168128026;993.5777294649745;1080.1304949515716;1107.7618312062946;1231.870653581379;1350.1696456679267;7829.099653539802;7957.3634109271115;7960.960195198987;8007.719729809429;8014.278714915569;1163.5404015414033;1178.6464060781732;1179.988200118005;1189.3161432176532;1199.2145144930084;6109.358517355614;6182.629042257479;6189.6286222826775;6195.349488303754;6206.348333425016;10111.595536178618;10703.090237329758;10738.677839664666;10839.783204336027;10879.401632910265;10332.793344133226;10556.208284378703;10567.894321056845;10702.090322322534;10736.785264294671;8332.791680208044;8336.83326333482;8427.578621068922;8427.83144337122;8438.57807109642;7837.294643482114;7857.371410287277;7861.764147075597;7901.367890568626;7930.088039875257;9511.524423778921;9540.95229523848;9698.078682525149;9765.462899540593;9810.65662701802;9041.864372034293;9898.851517227104;9908.653197138066;9920.950395247977;10065.396076235449;7323.084614423197;7338.192798792022;7358.11702595692;7424.257574242532;7425.9628701856145;7025.332593403618;8117.959410202911;8186.386021048326;8203.753887383387;8218.465799723239;6563.967180164069;7620.771376858703;7751.8837217442915;7884.21157884207;7905.367570594223;7438.888416673646;7439.888401674088;7460.701571937062;7577.242275772379;7589.316961473494;7542.170361260367;7612.467127301257;7621.1997740236475;7634.923650763421;7639.427042971911;6799.966000169968;6840.48696347766;6889.621070841152;6892.827679308058;6907.171139463096;6972.755953541602;7107.928920710727;7108;7109.324614161646;7134.500584959211 03:08:02 INFO - PROCESS | 1677 | |4;prototype.html;283.9872205750741;322.55326372973434;333.13551334287513;333.2285758469143;339.30781206339054;5279.92080118798;6587.8023659290175;6596.406323430891;6599.142111525501;6605.702743376548;6551.508636852232;6573.408393244607;6574.572652777566;6575.046618240364;6608.7686930957425;4847.321375007502;4861.173600487917;4874.195757699975;4884.780184891689;4887.047025829965;4547.567981041796;4685.36747539083;4843.104025755229;4844.951550484503;4903.362562866822;4762.857114286577;4773.355596994414;4777.04459108178;4799.400074990626;4804.90390192196;4624.3988281523525;4720.59874910633;4812.326274321597;4818.18090924542;4830.516948305177;4036.858709945138;4071.653909417703;4140.047789008545;4151.169766046803;4152;6296.527760417987;6300.495960323163;6314.273858506284;6319.58922670025;6330.81007569769;5400.108982017962;5568.303962004749;5720.8283751487525;5723.771049158028;5746.367899531048;6861.622610756406;7006.75476358325;7023.403010744093;7032.542884712478;7057.647117644097;4627.0745850829635;4658.301254811771;4670.859874203779;4681.157391669498;4693.48371679115;7104.21853596104;7384.372328352097;7389.556626602421;7396;7410.221926697727;4788;4809.0862736080035;4809.567138957511;4811.133995880775;4817.325574419584;4860.343853579792;4878.95121048792;4880.585150262196;4880.633952453581;4887.266909963534;5725.3988331225455;5747.568932330092;5760.855978600569;5764.394738552392;5765.106408506688;6494.6103233806125;6796.52424330302;7072.080629518233;7084.866421372556;7106.751263705745;1377.1324065838457;1450.840407555168;1493.828209755892;1630.8776841736917;1635.8364163583785;907.3059109781022;1043.4991204222015;1045.5713157605346;1046.9948849104792;1065.9200559958035;6552.868942621121;6562.704678289489;6562.704678289489;6571.342865713486;6589.571677840925;7252.057232559733;7267.420065876538;7268.563886166847;7271.745488907863;7288.562686238843;6360.14138091361;6551.541392102507;6558.606483610999;6560.147180866456;6577.21073471177;3194.2174167329154;3774.6225377462033;3809.657130858236;3840.9039774005873;3842.481265029185;7602.543847369176;7619.695212191561;7620.771376858703;7627.466077374531;7647.273509016634;7253.347198752032;7471.4396420268695;7472.663730132157;7500.587467689329;7521.398288136936;7592.81017974555;7603.201663825329;7603.657835397531;7603.847923041508;7606.733764318223;7239.420846332386;7257.52826066304;7264.854702906018;7265.346118849117;7278.163011253773;5757.395473475225;7154;7317.341439270278;7324.487285889936;7342.412606991535;7776.416768742254;7776.844463110593;7804.570748608881;7816.843663126592;7830.843383132192;3891;4612.469565999819;4675.111728771522;4679.649026322972;4686.648501362343;7184.784456466315;7288.161861386008;7327.194008659149;7364.263573642593;7364.3003914628025;7122.821929451805;7124.750633727795;7126.251743566851;7142.285771422816;7149.0706208192605;6912.965435172792;7083.5041547091205;7115.53749006313;7116.8932466014085;7118.0034795127685;6924.896126558207;6927.7228910843005;6932.48006399512;6933.445324373937;6971.5468494547695;6479.352064793483;7072.3634872861685;7089.6100714459135;7093.751718689821;7099.609521476162;6681.799546013627;6910.8617827644175;6941.757038503628;6970.302969702989;6995.545289556163 03:08:02 INFO - PROCESS | 1677 | |5;yui.html;661.4840424468913;676.9559978601394;683.1597135523306;731.1263040666403;736.4329466310944;14825;14985.025973311755;14999.999999999973;15010.624734381647;15105.622359441006;13440.3951822168;13509.392077356542;13511.432827762717;13521.391537380818;13521.594352169426;675.4292622733807;688.2016860441888;734.5482528245144;818.5007145641155;843.1905370843997;833.3749687734199;843.464400105931;845.8266055458647;846.5597889097666;847.6990668312752;713.2546488919093;901.535709109809;901.995490022549;902.5577467041168;903.4850135422812;651.6122906870404;679.4564348521163;717.114363760755;717.2003216413714;863.3826813828081;662.9436497897684;667.6294656465708;667.7629441548229;668.0547025958264;668.0647094068295;14518.782218266735;14594.70810583793;14613.707725845423;14620.049696769676;14628.268586570735;12170.57402990891;12506.249625022438;12678.619641410773;12785.201231899682;12798.680032999157;11276.790802547155;11354.602588909349;11621.883781162165;11747.412629368582;12246.265224086494;3593.9936817690827;3597.622249663774;3620.9275814483826;3626.492291079251;3692.48305237267;77978.61010694967;79293;79740.20259797444;79837.20162798355;79880;9588.760280992892;9589.041095890356;9623.422594644344;9707.9029209707;9719.076687714656;20683.58632827335;20686.482837929172;20697.896510517654;20735.170593176405;20786.37640870776;6326;7396.778096657109;7474.215207403253;7509.399248060142;7566.9621651892485;4086.7139300248696;4138.461999939988;4138.79306034703;4147.709660323809;4155.729877557949;3536.7524273301137;3572.285542891432;3573.94639080414;3580.7314451415727;3586.605473397924;662.1193812229723;663.1909070933453;665.012456502094;667.8297034256234;686.4645576450376;517.7721802406929;557.5985290590768;572.4247131632683;577.6851615869361;606.0152252589542;8330.708425205088;8485.363597730195;8609.397342186112;8717.825643487095;8729.694460693845;538.2383926743693;551.7461967494997;552.6601140298687;575.81955006652;642.4795915308615;3972.106276087915;4227.42929704486;4276.893077673083;4345.022369966796;4375.365571992107;87695;91822.54088729648;92406;92435;92743;57972;78401;79301.60349198217;80082;80425;69624.6006789077;69706;70086.9486957696;70333;70412.64793675998;8857.516651992195;8897.866532002156;8921.598528066383;8923.464592124494;8980.550972451481;41794.37308440315;45268.77365613283;49704.011839526014;49921;50635;67095;67599.66200168968;67753;67753.66123169352;67793;10980.835287470534;11024.779504409706;11107;11277.661670149908;11524.884751152382;12039.699007524881;12116.333601651993;12357.505699772268;12439.004879609429;12647.430865610886;9396.718098457057;11349.432528373383;11497.02628732078;11592.768144636892;12210.660543238255;11001.19545726221;11527.193096483166;11881.524739010343;12243;12261.957733592744;9053.773655658399;11356.772864542829;11791;11795.115366347387;11960.787254357972;9312.906870931203;9479.19426848698;9530.142287194185;9615.711528654152;9851.802963940538;9521.571529281338;10018.899811002088;10032.29773915848;10035;10041.196704263788 03:08:02 INFO - PROCESS | 1677 | __end_tp_report 03:08:02 INFO - PROCESS | 1677 | __start_cc_report 03:08:02 INFO - PROCESS | 1677 | _x_x_mozilla_cycle_collect,1043 03:08:02 INFO - PROCESS | 1677 | __end_cc_report 03:08:02 INFO - PROCESS | 1677 | __startTimestamp1455102482364__endTimestamp 03:08:02 INFO - PROCESS | 1677 | 03:08:02 INFO - PROCESS | 1677 | ------- Summary: start ------- 03:08:02 INFO - PROCESS | 1677 | Number of tests: 6 03:08:02 INFO - PROCESS | 1677 | 03:08:02 INFO - PROCESS | 1677 | [#0] dojo.html Cycles:165 Average:5727.97 Median:5984.88 stddev:633.73 (10.6%) stddev-sans-first:609.88 03:08:02 INFO - PROCESS | 1677 | Values: 3446.9 3483.4 3505.3 3518.4 3539.0 5654.2 5666.2 5702.9 5730.4 5732.3 5716.0 5796.7 5798.9 5799.4 5819.7 5133.0 5168.3 5180.2 5202.6 5237.9 5239.4 5245.2 5254.8 5255.4 5259.7 4386.9 5202.3 5214.6 5228.7 5241.0 5246.4 5252.9 5253.9 5257.6 5259.4 4399.4 5136.2 5189.7 5254.5 5273.7 5619.0 5645.6 5682.6 5713.8 5727.3 6248.1 6254.1 6265.8 6274.5 6287.6 6106.3 6108.7 6214.6 6220.3 6253.7 5866.6 5874.2 5896.3 5899.4 5911.1 6094.8 6236.7 6268.1 6269.2 6274.6 6063.7 6101.4 6155.1 6189.2 6198.8 5312.5 6104.3 6201.0 6252.0 6286.6 6216.7 6279.6 6283.6 6287.8 6301.3 6100.6 6115.5 6218.8 6242.7 6265.6 4905.6 4907.6 4912.8 4916.0 4946.9 4414.8 4418.8 4434.8 4449.6 4458.9 5558.4 5653.3 5660.5 5728.2 5784.7 6205.1 6210.8 6211.8 6216.0 6221.5 5589.4 5736.6 5737.9 5745.2 5750.1 5322.4 5356.5 5390.9 5392.7 5409.4 4888.9 6246.3 6271.8 6318.8 6346.4 6200.6 6202.3 6211.4 6224.6 6225.5 6285.9 6301.2 6316.2 6339.9 6340.5 6063.2 6114.1 6130.3 6130.9 6144.5 6124.3 6231.4 6233.0 6237.8 6246.1 5558.8 5972.8 6064.7 6080.5 6081.5 5938.7 6070.4 6078.6 6105.4 6105.6 5984.9 6031.5 6036.5 6063.8 6094.1 6120.8 6146.2 6150.8 6157.4 6163.6 5830.0 5941.6 5997.4 6019.2 6023.9 03:08:02 INFO - PROCESS | 1677 | 03:08:02 INFO - PROCESS | 1677 | [#1] ext.html Cycles:180 Average:61008.01 Median:19803.73 stddev:130617.01 (659.6%) stddev-sans-first:130904.38 03:08:02 INFO - PROCESS | 1677 | Values: 485.3 522.6 552.5 578.1 602.9 29276.6 36883.0 37432.6 37447.6 37517.6 33364.8 39863.4 40147.2 40214.4 40341.8 9320.5 9573.8 9580.7 9584.9 9632.8 9450.0 9518.7 9577.3 9583.4 9589.6 9701.8 9798.5 9812.3 9826.9 9848.9 9644.1 9739.8 9770.4 9775.8 9776.8 9428.1 9582.6 9590.2 9602.0 9606.9 38524.8 38991.2 39061.6 39116.4 39208.8 3203.3 3207.8 3327.5 3357.7 3584.8 22750.4 28170.6 28217.7 28248.0 29700.0 2837.1 2862.4 2884.7 2915.1 2919.7 384644.0 391281.0 392355.0 392389.0 392397.0 59340.0 60739.7 63134.4 64415.0 64439.7 73718.3 74607.0 74917.0 75055.9 75186.6 16271.0 16454.3 16484.3 16509.9 16557.9 10013.9 11563.1 12446.4 12595.8 12770.9 21887.1 22537.3 22564.7 22586.5 22622.2 8928.9 9706.6 9723.6 9747.3 9761.8 952.1 984.3 1009.8 1014.7 1154.4 27167.3 27607.7 29398.9 29649.4 30328.4 1056.2 1080.2 1105.0 1162.6 1204.8 13054.3 13813.7 13845.9 14156.2 14229.3 662791.0 670570.0 670622.0 670991.0 672471.0 47258.8 54153.0 54536.0 54877.0 55291.0 1424.8 1439.1 1454.6 1454.6 1457.8 22453.0 27309.6 27411.5 27771.2 28504.7 43922.3 49535.3 50524.2 50532.7 50625.5 333197.0 334538.0 337211.0 337990.0 338532.3 30574.7 30709.2 30820.1 30845.5 30868.8 38849.2 39277.4 39758.2 40676.8 41450.8 33502.0 34688.5 35076.8 35342.6 36022.6 29960.6 34623.0 34648.0 34729.7 35583.8 34995.1 35664.6 36151.3 36173.0 36186.5 31317.7 32183.5 32338.8 32970.8 33009.5 23270.7 23435.5 23480.2 23824.6 24017.0 03:08:02 INFO - PROCESS | 1677 | 03:08:02 INFO - PROCESS | 1677 | [#2] jquery.html Cycles:180 Average:35467.98 Median:360.45 stddev:115555.08 (32058.1%) stddev-sans-first:115849.17 03:08:02 INFO - PROCESS | 1677 | Values: 358.3 362.6 363.3 371.2 371.6 12298.6 15006.2 18709.9 18802.4 19453.7 11690.8 11710.8 11925.6 11943.3 11972.5 5084.7 5267.8 5278.7 5285.4 5294.1 3930.9 4098.7 5837.3 6044.8 6049.2 6010.7 6044.8 6169.5 6232.2 6566.8 5654.5 6304.0 6305.9 6312.0 6333.3 5610.0 5614.0 5621.6 5623.7 5626.4 13594.0 22651.8 23523.2 23605.8 23636.5 2101.0 2157.1 2165.3 2286.2 2759.6 10234.0 10385.8 11003.6 12167.6 14039.8 1697.3 1781.3 1784.4 1798.7 1841.1 79754.0 95051.0 101067.0 102232.0 102891.0 11070.3 11132.9 11144.7 11150.9 11289.2 13471.5 13617.2 13618.5 13667.7 13703.7 8343.1 8344.8 8356.9 8456.6 8464.4 8380.0 8392.5 8397.3 8498.5 8500.3 3997.2 4177.9 4180.0 4326.8 4462.6 1620.7 1656.4 1764.7 1794.5 1806.7 861.9 900.3 904.6 981.9 1024.2 18889.7 19396.5 19649.5 19879.3 20770.5 847.8 923.2 932.3 938.3 947.1 10326.5 10603.6 10838.5 10844.6 10874.9 590099.0 642028.0 726822.0 763003.0 767243.0 106589.0 108254.9 111711.4 114202.0 116277.8 1192.9 1194.8 1229.9 1251.7 1281.6 18257.0 18645.6 18659.9 18686.3 18733.8 45519.8 48029.5 49045.5 49762.8 50927.0 63842.0 64043.0 64200.7 64289.0 65548.7 7515.9 7801.8 7841.5 7845.7 7858.3 10729.8 11464.9 12154.6 12198.1 12325.3 7223.6 8406.2 10073.6 10482.6 10592.9 10027.2 10137.3 10155.9 10397.9 10402.9 7338.8 7814.2 8488.5 8814.0 10995.9 6584.7 7726.2 7768.3 7879.0 7908.8 5763.0 6433.0 9724.1 10875.6 11039.9 03:08:02 INFO - PROCESS | 1677 | 03:08:02 INFO - PROCESS | 1677 | [#3] mootools.html Cycles:180 Average:6041.28 Median:5428.28 stddev:3191.68 (58.8%) stddev-sans-first:3181.57 03:08:02 INFO - PROCESS | 1677 | Values: 1400.7 1521.2 1554.3 1790.2 1940.2 7898.3 8589.9 8776.2 8781.9 8800.5 8388.5 8610.9 8614.1 8619.1 8624.5 2183.2 2244.3 2247.8 2445.1 2473.7 2062.6 2254.6 2258.6 2483.2 2490.3 2416.1 2440.7 2445.8 2453.3 2479.1 2413.3 2452.0 2453.8 2456.4 2457.2 2447.8 2452.4 2454.5 2454.8 2461.5 8813.6 8907.6 8911.4 8916.0 8936.9 5322.8 5352.2 5482.9 5483.3 5484.3 3133.2 3578.2 3715.0 3773.8 3776.5 1010.7 1025.3 1056.1 1087.7 1111.1 12016.8 12029.0 12033.8 12068.3 12096.8 4792.9 4860.4 4862.0 4892.7 4913.2 9887.9 9899.3 10060.0 10106.1 10132.0 5403.2 5453.4 5457.6 5457.8 5464.9 4960.0 4966.9 4971.4 4979.5 4980.8 3588.8 3696.4 3861.0 3913.9 3961.9 1217.4 1237.5 1267.7 1296.6 1296.8 993.6 1080.1 1107.8 1231.9 1350.2 7829.1 7957.4 7961.0 8007.7 8014.3 1163.5 1178.6 1180.0 1189.3 1199.2 6109.4 6182.6 6189.6 6195.3 6206.3 10111.6 10703.1 10738.7 10839.8 10879.4 10332.8 10556.2 10567.9 10702.1 10736.8 8332.8 8336.8 8427.6 8427.8 8438.6 7837.3 7857.4 7861.8 7901.4 7930.1 9511.5 9541.0 9698.1 9765.5 9810.7 9041.9 9898.9 9908.7 9921.0 10065.4 7323.1 7338.2 7358.1 7424.3 7426.0 7025.3 8118.0 8186.4 8203.8 8218.5 6564.0 7620.8 7751.9 7884.2 7905.4 7438.9 7439.9 7460.7 7577.2 7589.3 7542.2 7612.5 7621.2 7634.9 7639.4 6800.0 6840.5 6889.6 6892.8 6907.2 6972.8 7107.9 7108.0 7109.3 7134.5 03:08:02 INFO - PROCESS | 1677 | 03:08:02 INFO - PROCESS | 1677 | [#4] prototype.html Cycles:180 Average:5776.10 Median:6567.02 stddev:1862.14 (28.4%) stddev-sans-first:1821.17 03:08:02 INFO - PROCESS | 1677 | Values: 284.0 322.6 333.1 333.2 339.3 5279.9 6587.8 6596.4 6599.1 6605.7 6551.5 6573.4 6574.6 6575.0 6608.8 4847.3 4861.2 4874.2 4884.8 4887.0 4547.6 4685.4 4843.1 4845.0 4903.4 4762.9 4773.4 4777.0 4799.4 4804.9 4624.4 4720.6 4812.3 4818.2 4830.5 4036.9 4071.7 4140.0 4151.2 4152.0 6296.5 6300.5 6314.3 6319.6 6330.8 5400.1 5568.3 5720.8 5723.8 5746.4 6861.6 7006.8 7023.4 7032.5 7057.6 4627.1 4658.3 4670.9 4681.2 4693.5 7104.2 7384.4 7389.6 7396.0 7410.2 4788.0 4809.1 4809.6 4811.1 4817.3 4860.3 4879.0 4880.6 4880.6 4887.3 5725.4 5747.6 5760.9 5764.4 5765.1 6494.6 6796.5 7072.1 7084.9 7106.8 1377.1 1450.8 1493.8 1630.9 1635.8 907.3 1043.5 1045.6 1047.0 1065.9 6552.9 6562.7 6562.7 6571.3 6589.6 7252.1 7267.4 7268.6 7271.7 7288.6 6360.1 6551.5 6558.6 6560.1 6577.2 3194.2 3774.6 3809.7 3840.9 3842.5 7602.5 7619.7 7620.8 7627.5 7647.3 7253.3 7471.4 7472.7 7500.6 7521.4 7592.8 7603.2 7603.7 7603.8 7606.7 7239.4 7257.5 7264.9 7265.3 7278.2 5757.4 7154.0 7317.3 7324.5 7342.4 7776.4 7776.8 7804.6 7816.8 7830.8 3891.0 4612.5 4675.1 4679.6 4686.6 7184.8 7288.2 7327.2 7364.3 7364.3 7122.8 7124.8 7126.3 7142.3 7149.1 6913.0 7083.5 7115.5 7116.9 7118.0 6924.9 6927.7 6932.5 6933.4 6971.5 6479.4 7072.4 7089.6 7093.8 7099.6 6681.8 6910.9 6941.8 6970.3 6995.5 03:08:02 INFO - PROCESS | 1677 | 03:08:02 INFO - PROCESS | 1677 | [#5] yui.html Cycles:180 Average:18128.54 Median:29289.01 stddev:25273.71 (86.3%) stddev-sans-first:25310.57 03:08:02 INFO - PROCESS | 1677 | Values: 661.5 677.0 683.2 731.1 736.4 14825.0 14985.0 15000.0 15010.6 15105.6 13440.4 13509.4 13511.4 13521.4 13521.6 675.4 688.2 734.5 818.5 843.2 833.4 843.5 845.8 846.6 847.7 713.3 901.5 902.0 902.6 903.5 651.6 679.5 717.1 717.2 863.4 662.9 667.6 667.8 668.1 668.1 14518.8 14594.7 14613.7 14620.0 14628.3 12170.6 12506.2 12678.6 12785.2 12798.7 11276.8 11354.6 11621.9 11747.4 12246.3 3594.0 3597.6 3620.9 3626.5 3692.5 77978.6 79293.0 79740.2 79837.2 79880.0 9588.8 9589.0 9623.4 9707.9 9719.1 20683.6 20686.5 20697.9 20735.2 20786.4 6326.0 7396.8 7474.2 7509.4 7567.0 4086.7 4138.5 4138.8 4147.7 4155.7 3536.8 3572.3 3573.9 3580.7 3586.6 662.1 663.2 665.0 667.8 686.5 517.8 557.6 572.4 577.7 606.0 8330.7 8485.4 8609.4 8717.8 8729.7 538.2 551.7 552.7 575.8 642.5 3972.1 4227.4 4276.9 4345.0 4375.4 87695.0 91822.5 92406.0 92435.0 92743.0 57972.0 78401.0 79301.6 80082.0 80425.0 69624.6 69706.0 70086.9 70333.0 70412.6 8857.5 8897.9 8921.6 8923.5 8980.6 41794.4 45268.8 49704.0 49921.0 50635.0 67095.0 67599.7 67753.0 67753.7 67793.0 10980.8 11024.8 11107.0 11277.7 11524.9 12039.7 12116.3 12357.5 12439.0 12647.4 9396.7 11349.4 11497.0 11592.8 12210.7 11001.2 11527.2 11881.5 12243.0 12262.0 9053.8 11356.8 11791.0 11795.1 11960.8 9312.9 9479.2 9530.1 9615.7 9851.8 9521.6 10018.9 10032.3 10035.0 10041.2 03:08:02 INFO - PROCESS | 1677 | -------- Summary: end -------- 03:08:02 INFO - PROCESS | 1677 | 03:08:02 INFO - TEST-INFO | 1677: exit 0 03:08:02 INFO - TEST-OK | dromaeo_css | took 1114773ms 03:08:02 INFO - TEST-START | kraken 03:08:02 INFO - operating with platform_type : mac_ 03:08:02 INFO - Initialising browser for kraken test... 03:08:02 INFO - TEST-INFO | started process 1684 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmpn6_gBg/profile http://localhost:49279/getInfo.html) 03:08:05 INFO - PROCESS | 1684 | __metrics Screen width/height:1600/1200 03:08:05 INFO - PROCESS | 1684 | colorDepth:24 03:08:05 INFO - PROCESS | 1684 | Browser inner width/height: 1024/689 03:08:05 INFO - PROCESS | 1684 | __metrics 03:08:05 INFO - PROCESS | 1684 | 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" 03:08:05 INFO - PROCESS | 1684 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:08:05 INFO - TEST-INFO | 1684: exit 0 03:08:05 INFO - Browser initialized. 03:08:05 INFO - Running cycle 1/1 for kraken test... 03:08:05 INFO - TEST-INFO | started process 1686 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmpn6_gBg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:08:17 INFO - PROCESS | 1686 | RSS: Main: 246321152 03:08:17 INFO - PROCESS | 1686 | 03:08:20 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection) 03:08:20 INFO - PROCESS | 1686 | RSS: Main: 292962304 03:08:20 INFO - PROCESS | 1686 | 03:08:23 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-dft) 03:08:24 INFO - PROCESS | 1686 | RSS: Main: 302137344 03:08:24 INFO - PROCESS | 1686 | 03:08:27 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-fft) 03:08:27 INFO - PROCESS | 1686 | RSS: Main: 289234944 03:08:27 INFO - PROCESS | 1686 | 03:08:29 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator) 03:08:30 INFO - PROCESS | 1686 | RSS: Main: 290504704 03:08:30 INFO - PROCESS | 1686 | 03:08:32 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:08:33 INFO - PROCESS | 1686 | RSS: Main: 291524608 03:08:33 INFO - PROCESS | 1686 | 03:08:35 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom) 03:08:36 INFO - PROCESS | 1686 | RSS: Main: 293629952 03:08:36 INFO - PROCESS | 1686 | 03:08:39 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate) 03:08:40 INFO - PROCESS | 1686 | RSS: Main: 293720064 03:08:40 INFO - PROCESS | 1686 | 03:08:42 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial) 03:08:43 INFO - PROCESS | 1686 | RSS: Main: 293421056 03:08:43 INFO - PROCESS | 1686 | 03:08:44 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:08:45 INFO - PROCESS | 1686 | RSS: Main: 325701632 03:08:45 INFO - PROCESS | 1686 | 03:08:47 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:08:47 INFO - PROCESS | 1686 | RSS: Main: 326701056 03:08:47 INFO - PROCESS | 1686 | 03:08:50 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:08:50 INFO - PROCESS | 1686 | RSS: Main: 334675968 03:08:50 INFO - PROCESS | 1686 | 03:08:53 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:08:53 INFO - PROCESS | 1686 | RSS: Main: 335769600 03:08:53 INFO - PROCESS | 1686 | 03:08:56 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:08:56 INFO - PROCESS | 1686 | RSS: Main: 335392768 03:08:56 INFO - PROCESS | 1686 | 03:08:58 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49279/tests/kraken/driver.html?testName=ai-astar) 03:08:58 INFO - PROCESS | 1686 | RSS: Main: 396214272 03:08:58 INFO - PROCESS | 1686 | 03:08:58 INFO - PROCESS | 1686 | __start_tp_report 03:08:58 INFO - PROCESS | 1686 | _x_x_mozilla_page_load 03:08:58 INFO - PROCESS | 1686 | _x_x_mozilla_page_load_details 03:08:58 INFO - PROCESS | 1686 | |i|pagename|runs| 03:08:58 INFO - PROCESS | 1686 | |0;ai-astar;110;106;111;109;110;113;116;112;110;112 03:08:58 INFO - PROCESS | 1686 | |1;audio-beat-detection;158;119;142;156;120;139;145;142;160;139 03:08:58 INFO - PROCESS | 1686 | |2;audio-dft;183;185;187;185;188;186;185;184;178;183 03:08:58 INFO - PROCESS | 1686 | |3;audio-fft;82;71;86;78;57;59;57;77;74;58 03:08:58 INFO - PROCESS | 1686 | |4;audio-oscillator;96;92;126;79;80;82;108;76;78;108 03:08:58 INFO - PROCESS | 1686 | |5;imaging-gaussian-blur;85;90;84;90;83;89;88;138;86;90 03:08:58 INFO - PROCESS | 1686 | |6;imaging-darkroom;106;127;141;94;133;147;93;93;93;93 03:08:58 INFO - PROCESS | 1686 | |7;imaging-desaturate;91;92;89;92;92;90;93;91;90;90 03:08:58 INFO - PROCESS | 1686 | |8;json-parse-financial;54;54;55;53;54;52;54;65;51;52 03:08:58 INFO - PROCESS | 1686 | |9;json-stringify-tinderbox;63;68;67;73;71;66;66;66;66;68 03:08:58 INFO - PROCESS | 1686 | |10;stanford-crypto-aes;83;84;83;82;83;80;96;107;118;83 03:08:58 INFO - PROCESS | 1686 | |11;stanford-crypto-ccm;126;121;125;124;128;129;107;127;111;121 03:08:58 INFO - PROCESS | 1686 | |12;stanford-crypto-pbkdf2;135;124;135;135;134;108;143;168;118;170 03:08:58 INFO - PROCESS | 1686 | |13;stanford-crypto-sha256-iterative;66;66;68;68;67;67;68;67;66;67 03:08:58 INFO - PROCESS | 1686 | __end_tp_report 03:08:58 INFO - PROCESS | 1686 | __start_cc_report 03:08:58 INFO - PROCESS | 1686 | _x_x_mozilla_cycle_collect,1213 03:08:58 INFO - PROCESS | 1686 | __end_cc_report 03:08:58 INFO - PROCESS | 1686 | __startTimestamp1455102538875__endTimestamp 03:08:58 INFO - PROCESS | 1686 | 03:08:58 INFO - PROCESS | 1686 | ------- Summary: start ------- 03:08:58 INFO - PROCESS | 1686 | Number of tests: 14 03:08:58 INFO - PROCESS | 1686 | 03:08:58 INFO - PROCESS | 1686 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.50 stddev:2.64 (2.4%) stddev-sans-first:2.78 03:08:58 INFO - PROCESS | 1686 | Values: 110.0 106.0 111.0 109.0 110.0 113.0 116.0 112.0 110.0 112.0 03:08:58 INFO - PROCESS | 1686 | 03:08:58 INFO - PROCESS | 1686 | [#1] audio-beat-detection Cycles:10 Average:142.00 Median:143.50 stddev:14.20 (9.9%) stddev-sans-first:13.84 03:08:58 INFO - PROCESS | 1686 | Values: 158.0 119.0 142.0 156.0 120.0 139.0 145.0 142.0 160.0 139.0 03:08:58 INFO - PROCESS | 1686 | 03:08:58 INFO - PROCESS | 1686 | [#2] audio-dft Cycles:10 Average:184.40 Median:185.00 stddev:2.76 (1.5%) stddev-sans-first:2.88 03:08:58 INFO - PROCESS | 1686 | Values: 183.0 185.0 187.0 185.0 188.0 186.0 185.0 184.0 178.0 183.0 03:08:58 INFO - PROCESS | 1686 | 03:08:58 INFO - PROCESS | 1686 | [#3] audio-fft Cycles:10 Average:69.90 Median:75.50 stddev:11.22 (14.9%) stddev-sans-first:11.01 03:08:58 INFO - PROCESS | 1686 | Values: 82.0 71.0 86.0 78.0 57.0 59.0 57.0 77.0 74.0 58.0 03:08:58 INFO - PROCESS | 1686 | 03:08:58 INFO - PROCESS | 1686 | [#4] audio-oscillator Cycles:10 Average:92.50 Median:79.50 stddev:16.82 (21.2%) stddev-sans-first:17.79 03:08:58 INFO - PROCESS | 1686 | Values: 96.0 92.0 126.0 79.0 80.0 82.0 108.0 76.0 78.0 108.0 03:08:58 INFO - PROCESS | 1686 | 03:08:58 INFO - PROCESS | 1686 | [#5] imaging-gaussian-blur Cycles:10 Average:92.30 Median:88.50 stddev:16.27 (18.4%) stddev-sans-first:17.04 03:08:58 INFO - PROCESS | 1686 | Values: 85.0 90.0 84.0 90.0 83.0 89.0 88.0 138.0 86.0 90.0 03:08:58 INFO - PROCESS | 1686 | 03:08:58 INFO - PROCESS | 1686 | [#6] imaging-darkroom Cycles:10 Average:112.00 Median:93.00 stddev:22.45 (24.1%) stddev-sans-first:23.71 03:08:58 INFO - PROCESS | 1686 | Values: 106.0 127.0 141.0 94.0 133.0 147.0 93.0 93.0 93.0 93.0 03:08:58 INFO - PROCESS | 1686 | 03:08:58 INFO - PROCESS | 1686 | [#7] imaging-desaturate Cycles:10 Average:91.00 Median:91.50 stddev:1.25 (1.4%) stddev-sans-first:1.32 03:08:58 INFO - PROCESS | 1686 | Values: 91.0 92.0 89.0 92.0 92.0 90.0 93.0 91.0 90.0 90.0 03:08:58 INFO - PROCESS | 1686 | 03:08:58 INFO - PROCESS | 1686 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:54.00 stddev:3.92 (7.3%) stddev-sans-first:4.16 03:08:58 INFO - PROCESS | 1686 | Values: 54.0 54.0 55.0 53.0 54.0 52.0 54.0 65.0 51.0 52.0 03:08:58 INFO - PROCESS | 1686 | 03:08:58 INFO - PROCESS | 1686 | [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:67.50 stddev:2.84 (4.2%) stddev-sans-first:2.52 03:08:58 INFO - PROCESS | 1686 | Values: 63.0 68.0 67.0 73.0 71.0 66.0 66.0 66.0 66.0 68.0 03:08:58 INFO - PROCESS | 1686 | 03:08:58 INFO - PROCESS | 1686 | [#10] stanford-crypto-aes Cycles:10 Average:89.90 Median:83.00 stddev:12.93 (15.6%) stddev-sans-first:13.47 03:08:58 INFO - PROCESS | 1686 | Values: 83.0 84.0 83.0 82.0 83.0 80.0 96.0 107.0 118.0 83.0 03:08:58 INFO - PROCESS | 1686 | 03:08:58 INFO - PROCESS | 1686 | [#11] stanford-crypto-ccm Cycles:10 Average:121.90 Median:125.50 stddev:7.36 (5.9%) stddev-sans-first:7.65 03:08:58 INFO - PROCESS | 1686 | Values: 126.0 121.0 125.0 124.0 128.0 129.0 107.0 127.0 111.0 121.0 03:08:58 INFO - PROCESS | 1686 | 03:08:58 INFO - PROCESS | 1686 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.00 Median:135.00 stddev:19.66 (14.6%) stddev-sans-first:20.84 03:08:58 INFO - PROCESS | 1686 | Values: 135.0 124.0 135.0 135.0 134.0 108.0 143.0 168.0 118.0 170.0 03:08:58 INFO - PROCESS | 1686 | 03:08:58 INFO - PROCESS | 1686 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:0.82 (1.2%) stddev-sans-first:0.78 03:08:58 INFO - PROCESS | 1686 | Values: 66.0 66.0 68.0 68.0 67.0 67.0 68.0 67.0 66.0 67.0 03:08:58 INFO - PROCESS | 1686 | -------- Summary: end -------- 03:08:58 INFO - PROCESS | 1686 | 03:08:59 INFO - TEST-INFO | 1686: exit 0 03:08:59 INFO - TEST-OK | kraken | took 56741ms 03:08:59 INFO - SUITE-END | took 1171s 03:09:00 INFO - Completed test suite (00:19:31) 03:09:00 INFO - Working with test: dromaeo_css 03:09:00 INFO - Generating results file: dromaeo_css 03:09:00 INFO - Working with test: kraken 03:09:00 INFO - Generating results file: kraken 03:09:00 INFO - javascript benchmark 03:09:00 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:09:00 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 03:09:00 INFO - process_Request line: dromaeo_css 7437.08 graph.html#tests=[[72,64,59]] 03:09:00 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:09:00 INFO - process_Request line: kraken 1432.60 graph.html#tests=[[232,64,59]] 03:09:00 INFO - RETURN: dromaeo_css: 7437.08 03:09:00 INFO - RETURN: kraken: 1432.60 03:09:00 INFO - javascript benchmark 03:09:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3446.879359222427, 3483.372992861284, 3505.2638945821377, 3518.4018716818136, 3539.026767638899, 5654.180143879135, 5666.178404131399, 5702.857428564288, 5730.426957304273, 5732.31212254529, 5715.971420142904, 5796.68118253497, 5798.884022319551, 5799.362070172288, 5819.67991760453, 5132.97433512832, 5168.250603662466, 5180.197069454241, 5202.583793296527, 5237.8952420951555, 5239.397469291023, 5245.239440281157, 5254.842354729364, 5255.369355677305, 5259.737013149346, 4386.868393948187, 5202.271681964509, 5214.634975551713, 5228.660137091096, 5241.0042092002395, 5246.396664383607, 5252.949410117953, 5253.921191182136, 5257.579393648499, 5259.447757985395, 4399.428074350314, 5136.203888397305, 5189.6886186828915, 5254.500822421864, 5273.736313184364, 5619.0, 5645.576581756343, 5682.602217844753, 5713.800016999427, 5727.284089488814, 6248.125262463259, 6254.0618907163835, 6265.780697675559, 6274.466670333027, 6287.622742635456, 6106.2977757558, 6108.694565271763, 6214.5960512566535, 6220.253569571681, 6253.749850005995, 5866.589338746289, 5874.236349274653, 5896.292444906639, 5899.380565040695, 5911.083782013795, 6094.8171554853425, 6236.656983865931, 6268.091126786681, 6269.153664255358, 6274.592151510137, 6063.727132279058, 6101.398774955092, 6155.076738489173, 6189.164462797465, 6198.845028874224, 5312.468753124656, 6104.298005729309, 6201.0, 6252.030935205051, 6286.5599408041, 6216.689165541705, 6279.560430769893, 6283.59156654816, 6287.842803929847, 6301.306856245809, 6100.641728746782, 6115.483736156547, 6218.782342617987, 6242.656653883989, 6265.561410701207, 4905.607551395879, 4907.558319751168, 4912.828051018198, 4915.992221594564, 4946.86222168896, 4414.823407063745, 4418.779061046935, 4434.800433980478, 4449.599536041772, 4458.888527786831, 5558.44415558449, 5653.321601407857, 5660.518855897295, 5728.198052272685, 5784.71076446176, 6205.100260462208, 6210.7515699371515, 6211.782587609412, 6216.036514340284, 6221.502279817604, 5589.413111623221, 5736.62711923732, 5737.942620573825, 5745.195672605755, 5750.079987202112, 5322.4411436799355, 5356.517913387814, 5390.865228369322, 5392.73036348181, 5409.350877894678, 4888.926666100083, 6246.281677607133, 6271.78048768291, 6318.778842740482, 6346.397092276226, 6200.596961197508, 6202.2867370253, 6211.440970312513, 6224.62652240867, 6225.501959843292, 6285.874282514415, 6301.180846489927, 6316.242050953915, 6339.936600633934, 6340.524460665376, 6063.151158837678, 6114.084479019511, 6130.306415576139, 6130.917941862889, 6144.539159562962, 6124.289394098022, 6231.439170474498, 6233.0, 6237.781677641261, 6246.125542424155, 5558.805441809517, 5972.790952316822, 6064.727087280995, 6080.513558915364, 6081.452669259611, 5938.703064846827, 6070.362611925861, 6078.574499784972, 6105.389461053859, 6105.603135796159, 5984.880302393841, 6031.517478601613, 6036.517078633611, 6063.787767428295, 6094.055421409688, 6120.770032358895, 6146.231721034871, 6150.7539698411565, 6157.415045570664, 6163.599366041193, 5829.970850145722, 5941.643501389931, 5997.430244126801, 6019.1573179754, 6023.879522409615], "unit": "score", "name": "dojo.html", "value": 5689.5130109351185}, {"lowerIsBetter": false, "replicates": [485.28905153949455, 522.6237109281318, 552.5496720173057, 578.1472328315732, 602.8914795336839, 29276.560851587215, 36883.0, 37432.625673743256, 37447.625523744755, 37517.62482375176, 33364.833175834145, 39863.40204896929, 40147.19705605893, 40214.39678404819, 40341.79829100858, 9320.533973301342, 9573.760655983622, 9580.712578622653, 9584.856227156599, 9632.80734385312, 9450.0, 9518.666846660368, 9577.329586928918, 9583.377080489747, 9589.568469418859, 9701.757456063584, 9798.510074496282, 9812.313138080337, 9826.852597211047, 9848.90151098487, 9644.132028117469, 9739.756506087333, 9770.36492627977, 9775.75560610987, 9776.755581110458, 9428.057194280516, 9582.616695332179, 9590.232781377474, 9602.039796020412, 9606.90393096067, 38524.80737596294, 38991.220175596616, 39061.609383906085, 39116.41325380121, 39208.80395598032, 3203.2952750395107, 3207.83960801959, 3327.5341452196712, 3357.731381489475, 3584.8207589620415, 22750.431239218986, 28170.577441338395, 28217.717822821713, 28248.0, 29700.0, 2837.1346739244523, 2862.427514497109, 2884.668263149744, 2915.1400336900665, 2919.6642386125654, 384644.0, 391281.0, 392355.0382248099, 392389.0, 392397.0, 59340.0, 60739.69630151821, 63134.36865631377, 64415.0, 64439.67780161163, 73718.26281737114, 74607.0, 74917.0, 75055.87416188761, 75186.62406688041, 16271.0, 16454.341826326814, 16484.258208380652, 16509.9268547544, 16557.91721041411, 10013.898471168166, 11563.132765042656, 12446.439910204062, 12595.811062834066, 12770.9361453194, 21887.12451501954, 22537.323880283617, 22564.66153007706, 22586.548269034527, 22622.208222712125, 8928.910710892807, 9706.563204655808, 9723.61105555784, 9747.268954828416, 9761.804763904824, 952.0859974424492, 984.3109823123699, 1009.8081364540714, 1014.6600888702368, 1154.3766366162347, 27167.320816979733, 27607.723922760917, 29398.853005735262, 29649.407011859643, 30328.393432131234, 1056.2078441169124, 1080.1682704317632, 1105.0275757333495, 1162.610525473959, 1204.837346958167, 13054.34728263583, 13813.723725525433, 13845.861541384456, 14156.150630962175, 14229.28853557318, 662791.0, 670570.0, 670622.0, 670991.0, 672471.0, 47258.76370618193, 54153.0, 54536.0, 54877.0, 55291.0, 1424.8290205175444, 1439.0502268502737, 1454.5636309107438, 1454.6290695872485, 1457.7959085728007, 22453.0, 27309.590356145072, 27411.45177096407, 27771.166864994084, 28504.714952850205, 43922.34116488192, 49535.25697114474, 50524.179235802694, 50532.747336263084, 50625.49374506355, 333197.0, 334538.0, 337211.0, 337990.0, 338532.30733846175, 30574.694253058075, 30709.23226919345, 30820.075397738103, 30845.537316939815, 30868.765249389773, 38849.2230155401, 39277.41083883801, 39758.20483590254, 40676.79661601673, 41450.79274603607, 33502.0, 34688.479672804424, 35076.82461587676, 35342.64657353496, 36022.639773602976, 29960.550591741576, 34623.0, 34648.0, 34729.65270347264, 35583.754568589975, 34995.12512187216, 35664.643353566134, 36151.27697445984, 36173.0, 36186.45720314145, 31317.686823131477, 32183.51724724178, 32338.83830580832, 32970.835145824116, 33009.50485742668, 23270.72011039409, 23435.53128937446, 23480.17819376382, 23824.642630360904, 24017.0], "unit": "score", "name": "ext.html", "value": 19342.235129550412}, {"lowerIsBetter": false, "replicates": [358.2798574864522, 362.6301172803741, 363.30608537692996, 371.17413754396455, 371.63950967561453, 12298.569550065728, 15006.249687515636, 18709.906450467744, 18802.43592692218, 19453.70819437708, 11690.824637630443, 11710.765784684323, 11925.58260460884, 11943.34311612861, 11972.461239244232, 5084.745762711859, 5267.841964741045, 5278.709670968095, 5285.418603953582, 5294.073537131006, 3930.862419815307, 4098.672106231495, 5837.299524057098, 6044.788432404866, 6049.243844519435, 6010.669413182273, 6044.758209671608, 6169.537284703642, 6232.158658581079, 6566.80299591013, 5654.547636189095, 6303.968480157616, 6305.87388252237, 6311.968440157792, 6333.271673757531, 5609.971950140264, 5614.017546929312, 5621.634593751393, 5623.7469313880565, 5626.409227031144, 13594.0, 22651.773482265133, 23523.17668881581, 23605.819709014653, 23636.527269454513, 2100.9810242032754, 2157.126363822654, 2165.307101727448, 2286.211257116292, 2759.6274502942247, 10234.02776736209, 10385.79228415435, 11003.61487347939, 12167.574134905324, 14039.806616437512, 1697.2532085882171, 1781.2607767776358, 1784.4022252545412, 1798.739182818497, 1841.0886611127444, 79754.0, 95051.0, 101067.0, 102231.97768022299, 102890.97109028963, 11070.28043177191, 11132.944335278435, 11144.721381965353, 11150.888491115147, 11289.153313501356, 13471.528496502771, 13617.182969021891, 13618.523351682643, 13667.726645467035, 13703.657408564666, 8343.123971982854, 8344.8331033379, 8356.874646880302, 8456.577171141418, 8464.44981076228, 8380.0, 8392.454490458224, 8397.28623067034, 8498.532580707997, 8500.277476414574, 3997.220541994341, 4177.874663760092, 4180.0, 4326.848560300375, 4462.620677242471, 1620.6758648270393, 1656.436811484101, 1764.7441121037377, 1794.452691928948, 1806.683830329687, 861.9396642235109, 900.2797761790672, 904.6426661468814, 981.9165370943407, 1024.2113572549094, 18889.7166542502, 19396.515087122934, 19649.508762281057, 19879.30422435208, 20770.48073798137, 847.7711018025099, 923.2060428031887, 932.2728271947891, 938.2681508423441, 947.1049857884233, 10326.48367581618, 10603.628872989408, 10838.458077096271, 10844.620438284623, 10874.945625271823, 590099.0, 642028.0, 726822.0, 763003.0, 767243.0, 106589.0, 108254.91745082449, 111711.44144279226, 114202.0, 116277.8372216267, 1192.8986036186848, 1194.7909115904856, 1229.883161099694, 1251.6620512461584, 1281.564268148834, 18257.0, 18645.627087457902, 18659.880407175613, 18686.34597789071, 18733.812661873206, 45519.77240113778, 48029.519704803904, 49045.5095449041, 49762.75118624384, 50927.0, 63842.0, 64043.0, 64200.678996604714, 64289.035664464136, 65548.67225663841, 7515.887261690969, 7801.804954876174, 7841.529508229524, 7845.725399610987, 7858.292753652198, 10729.785404291715, 11464.885351146382, 12154.574589889311, 12198.13343864209, 12325.322107284186, 7223.602701851449, 8406.201410865959, 10073.597056117673, 10482.63310784119, 10592.89407105919, 10027.247956403446, 10137.341072830242, 10155.933626969061, 10397.948010259901, 10402.895971040496, 7338.77983660491, 7814.22633114842, 8488.533130677624, 8814.0, 10995.890041099487, 6584.670766461753, 7726.18875018115, 7768.262015108556, 7879.0151231096115, 7908.762737117896, 5763.049096898964, 6432.9678351607945, 9724.124828765445, 10875.619353322596, 11039.944800275947], "unit": "score", "name": "jquery.html", "value": 8926.459445562954}, {"lowerIsBetter": false, "replicates": [1400.6988497473042, 1521.1557585540024, 1554.285028886712, 1790.2480957997639, 1940.175425444186, 7898.328642065424, 8589.91410085899, 8776.2101410873, 8781.868271975925, 8800.471971681704, 8388.496690198592, 8610.87083693745, 8614.095519970408, 8619.094995025525, 8624.525651089187, 2183.170395249811, 2244.2930476899805, 2247.752747197807, 2445.0586524188184, 2473.727889932106, 2062.6493496105622, 2254.571631390039, 2258.627326491127, 2483.1681386735463, 2490.2902672738273, 2416.1060407649193, 2440.670509481224, 2445.8410203336816, 2453.325335532725, 2479.0579579759665, 2413.3363325085566, 2451.9754802451926, 2453.8036957043396, 2456.385903524128, 2457.164564048232, 2447.7919376852988, 2452.350127216271, 2454.521368333176, 2454.8036157107567, 2461.54461424637, 8813.603387847563, 8907.643694252221, 8911.376203665746, 8916.019237883827, 8936.8659470108, 5322.840314790563, 5352.197170424468, 5482.876010417895, 5483.287172667528, 5484.341878974548, 3133.2166958260436, 3578.177019285579, 3714.9814250928844, 3773.811309434545, 3776.4524143998965, 1010.6563768318733, 1025.3232866308201, 1056.1497994114734, 1087.722630729159, 1111.1166622535104, 12016.759664806656, 12028.977536909373, 12033.819492707617, 12068.275903445909, 12096.81854772179, 4792.880177995578, 4860.441049279308, 4861.951380486221, 4892.681975671641, 4913.1893237615395, 9887.901120988841, 9899.307048506535, 10059.994000600027, 10106.140978016803, 10132.0, 5403.189521571796, 5453.372862120827, 5457.590680698963, 5457.83626491198, 5464.9453505464435, 4959.975200123977, 4966.850994470172, 4971.403431588233, 4979.502049794992, 4980.7509624518625, 3588.7667301625834, 3696.353138200804, 3861.0, 3913.9021524461546, 3961.900952476211, 1217.3548019549653, 1237.461704158676, 1267.714764178071, 1296.598054603076, 1296.7536168128026, 993.5777294649745, 1080.1304949515716, 1107.7618312062946, 1231.870653581379, 1350.1696456679267, 7829.099653539802, 7957.3634109271115, 7960.960195198987, 8007.719729809429, 8014.278714915569, 1163.5404015414033, 1178.6464060781732, 1179.988200118005, 1189.3161432176532, 1199.2145144930084, 6109.358517355614, 6182.629042257479, 6189.6286222826775, 6195.349488303754, 6206.348333425016, 10111.595536178618, 10703.090237329758, 10738.677839664666, 10839.783204336027, 10879.401632910265, 10332.793344133226, 10556.208284378703, 10567.894321056845, 10702.090322322534, 10736.785264294671, 8332.791680208044, 8336.83326333482, 8427.578621068922, 8427.83144337122, 8438.57807109642, 7837.294643482114, 7857.371410287277, 7861.764147075597, 7901.367890568626, 7930.088039875257, 9511.524423778921, 9540.95229523848, 9698.078682525149, 9765.462899540593, 9810.65662701802, 9041.864372034293, 9898.851517227104, 9908.653197138066, 9920.950395247977, 10065.396076235449, 7323.084614423197, 7338.192798792022, 7358.11702595692, 7424.257574242532, 7425.9628701856145, 7025.332593403618, 8117.959410202911, 8186.386021048326, 8203.753887383387, 8218.465799723239, 6563.967180164069, 7620.771376858703, 7751.8837217442915, 7884.21157884207, 7905.367570594223, 7438.888416673646, 7439.888401674088, 7460.701571937062, 7577.242275772379, 7589.316961473494, 7542.170361260367, 7612.467127301257, 7621.1997740236475, 7634.923650763421, 7639.427042971911, 6799.966000169968, 6840.48696347766, 6889.621070841152, 6892.827679308058, 6907.171139463096, 6972.755953541602, 7107.928920710727, 7108.0, 7109.324614161646, 7134.500584959211], "unit": "score", "name": "mootools.html", "value": 4912.766948868736}, {"lowerIsBetter": false, "replicates": [283.9872205750741, 322.55326372973434, 333.13551334287513, 333.2285758469143, 339.30781206339054, 5279.92080118798, 6587.8023659290175, 6596.406323430891, 6599.142111525501, 6605.702743376548, 6551.508636852232, 6573.408393244607, 6574.572652777566, 6575.046618240364, 6608.7686930957425, 4847.321375007502, 4861.173600487917, 4874.195757699975, 4884.780184891689, 4887.047025829965, 4547.567981041796, 4685.36747539083, 4843.104025755229, 4844.951550484503, 4903.362562866822, 4762.857114286577, 4773.355596994414, 4777.04459108178, 4799.400074990626, 4804.90390192196, 4624.3988281523525, 4720.59874910633, 4812.326274321597, 4818.18090924542, 4830.516948305177, 4036.858709945138, 4071.653909417703, 4140.047789008545, 4151.169766046803, 4152.0, 6296.527760417987, 6300.495960323163, 6314.273858506284, 6319.58922670025, 6330.81007569769, 5400.108982017962, 5568.303962004749, 5720.8283751487525, 5723.771049158028, 5746.367899531048, 6861.622610756406, 7006.75476358325, 7023.403010744093, 7032.542884712478, 7057.647117644097, 4627.0745850829635, 4658.301254811771, 4670.859874203779, 4681.157391669498, 4693.48371679115, 7104.21853596104, 7384.372328352097, 7389.556626602421, 7396.0, 7410.221926697727, 4788.0, 4809.0862736080035, 4809.567138957511, 4811.133995880775, 4817.325574419584, 4860.343853579792, 4878.95121048792, 4880.585150262196, 4880.633952453581, 4887.266909963534, 5725.3988331225455, 5747.568932330092, 5760.855978600569, 5764.394738552392, 5765.106408506688, 6494.6103233806125, 6796.52424330302, 7072.080629518233, 7084.866421372556, 7106.751263705745, 1377.1324065838457, 1450.840407555168, 1493.828209755892, 1630.8776841736917, 1635.8364163583785, 907.3059109781022, 1043.4991204222015, 1045.5713157605346, 1046.9948849104792, 1065.9200559958035, 6552.868942621121, 6562.704678289489, 6562.704678289489, 6571.342865713486, 6589.571677840925, 7252.057232559733, 7267.420065876538, 7268.563886166847, 7271.745488907863, 7288.562686238843, 6360.14138091361, 6551.541392102507, 6558.606483610999, 6560.147180866456, 6577.21073471177, 3194.2174167329154, 3774.6225377462033, 3809.657130858236, 3840.9039774005873, 3842.481265029185, 7602.543847369176, 7619.695212191561, 7620.771376858703, 7627.466077374531, 7647.273509016634, 7253.347198752032, 7471.4396420268695, 7472.663730132157, 7500.587467689329, 7521.398288136936, 7592.81017974555, 7603.201663825329, 7603.657835397531, 7603.847923041508, 7606.733764318223, 7239.420846332386, 7257.52826066304, 7264.854702906018, 7265.346118849117, 7278.163011253773, 5757.395473475225, 7154.0, 7317.341439270278, 7324.487285889936, 7342.412606991535, 7776.416768742254, 7776.844463110593, 7804.570748608881, 7816.843663126592, 7830.843383132192, 3891.0, 4612.469565999819, 4675.111728771522, 4679.649026322972, 4686.648501362343, 7184.784456466315, 7288.161861386008, 7327.194008659149, 7364.263573642593, 7364.3003914628025, 7122.821929451805, 7124.750633727795, 7126.251743566851, 7142.285771422816, 7149.0706208192605, 6912.965435172792, 7083.5041547091205, 7115.53749006313, 7116.8932466014085, 7118.0034795127685, 6924.896126558207, 6927.7228910843005, 6932.48006399512, 6933.445324373937, 6971.5468494547695, 6479.352064793483, 7072.3634872861685, 7089.6100714459135, 7093.751718689821, 7099.609521476162, 6681.799546013627, 6910.8617827644175, 6941.757038503628, 6970.302969702989, 6995.545289556163], "unit": "score", "name": "prototype.html", "value": 5139.372632745327}, {"lowerIsBetter": false, "replicates": [661.4840424468913, 676.9559978601394, 683.1597135523306, 731.1263040666403, 736.4329466310944, 14825.0, 14985.025973311755, 14999.999999999973, 15010.624734381647, 15105.622359441006, 13440.3951822168, 13509.392077356542, 13511.432827762717, 13521.391537380818, 13521.594352169426, 675.4292622733807, 688.2016860441888, 734.5482528245144, 818.5007145641155, 843.1905370843997, 833.3749687734199, 843.464400105931, 845.8266055458647, 846.5597889097666, 847.6990668312752, 713.2546488919093, 901.535709109809, 901.995490022549, 902.5577467041168, 903.4850135422812, 651.6122906870404, 679.4564348521163, 717.114363760755, 717.2003216413714, 863.3826813828081, 662.9436497897684, 667.6294656465708, 667.7629441548229, 668.0547025958264, 668.0647094068295, 14518.782218266735, 14594.70810583793, 14613.707725845423, 14620.049696769676, 14628.268586570735, 12170.57402990891, 12506.249625022438, 12678.619641410773, 12785.201231899682, 12798.680032999157, 11276.790802547155, 11354.602588909349, 11621.883781162165, 11747.412629368582, 12246.265224086494, 3593.9936817690827, 3597.622249663774, 3620.9275814483826, 3626.492291079251, 3692.48305237267, 77978.61010694967, 79293.0, 79740.20259797444, 79837.20162798355, 79880.0, 9588.760280992892, 9589.041095890356, 9623.422594644344, 9707.9029209707, 9719.076687714656, 20683.58632827335, 20686.482837929172, 20697.896510517654, 20735.170593176405, 20786.37640870776, 6326.0, 7396.778096657109, 7474.215207403253, 7509.399248060142, 7566.9621651892485, 4086.7139300248696, 4138.461999939988, 4138.79306034703, 4147.709660323809, 4155.729877557949, 3536.7524273301137, 3572.285542891432, 3573.94639080414, 3580.7314451415727, 3586.605473397924, 662.1193812229723, 663.1909070933453, 665.012456502094, 667.8297034256234, 686.4645576450376, 517.7721802406929, 557.5985290590768, 572.4247131632683, 577.6851615869361, 606.0152252589542, 8330.708425205088, 8485.363597730195, 8609.397342186112, 8717.825643487095, 8729.694460693845, 538.2383926743693, 551.7461967494997, 552.6601140298687, 575.81955006652, 642.4795915308615, 3972.106276087915, 4227.42929704486, 4276.893077673083, 4345.022369966796, 4375.365571992107, 87695.0, 91822.54088729648, 92406.0, 92435.0, 92743.0, 57972.0, 78401.0, 79301.60349198217, 80082.0, 80425.0, 69624.6006789077, 69706.0, 70086.9486957696, 70333.0, 70412.64793675998, 8857.516651992195, 8897.866532002156, 8921.598528066383, 8923.464592124494, 8980.550972451481, 41794.37308440315, 45268.77365613283, 49704.011839526014, 49921.0, 50635.0, 67095.0, 67599.66200168968, 67753.0, 67753.66123169352, 67793.0, 10980.835287470534, 11024.779504409706, 11107.0, 11277.661670149908, 11524.884751152382, 12039.699007524881, 12116.333601651993, 12357.505699772268, 12439.004879609429, 12647.430865610886, 9396.718098457057, 11349.432528373383, 11497.02628732078, 11592.768144636892, 12210.660543238255, 11001.19545726221, 11527.193096483166, 11881.524739010343, 12243.0, 12261.957733592744, 9053.773655658399, 11356.772864542829, 11791.0, 11795.115366347387, 11960.787254357972, 9312.906870931203, 9479.19426848698, 9530.142287194185, 9615.711528654152, 9851.802963940538, 9521.571529281338, 10018.899811002088, 10032.29773915848, 10035.0, 10041.196704263788], "unit": "score", "name": "yui.html", "value": 6821.560776712094}], "name": "dromaeo_css", "value": 7437.079765498813}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 106.0, 111.0, 109.0, 110.0, 113.0, 116.0, 112.0, 110.0, 112.0], "unit": "score", "name": "ai-astar", "value": 110.9}, {"lowerIsBetter": true, "replicates": [158.0, 119.0, 142.0, 156.0, 120.0, 139.0, 145.0, 142.0, 160.0, 139.0], "unit": "score", "name": "audio-beat-detection", "value": 142.0}, {"lowerIsBetter": true, "replicates": [183.0, 185.0, 187.0, 185.0, 188.0, 186.0, 185.0, 184.0, 178.0, 183.0], "unit": "score", "name": "audio-dft", "value": 184.4}, {"lowerIsBetter": true, "replicates": [82.0, 71.0, 86.0, 78.0, 57.0, 59.0, 57.0, 77.0, 74.0, 58.0], "unit": "score", "name": "audio-fft", "value": 69.9}, {"lowerIsBetter": true, "replicates": [96.0, 92.0, 126.0, 79.0, 80.0, 82.0, 108.0, 76.0, 78.0, 108.0], "unit": "score", "name": "audio-oscillator", "value": 92.5}, {"lowerIsBetter": true, "replicates": [85.0, 90.0, 84.0, 90.0, 83.0, 89.0, 88.0, 138.0, 86.0, 90.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 92.3}, {"lowerIsBetter": true, "replicates": [106.0, 127.0, 141.0, 94.0, 133.0, 147.0, 93.0, 93.0, 93.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 112.0}, {"lowerIsBetter": true, "replicates": [91.0, 92.0, 89.0, 92.0, 92.0, 90.0, 93.0, 91.0, 90.0, 90.0], "unit": "score", "name": "imaging-desaturate", "value": 91.0}, {"lowerIsBetter": true, "replicates": [54.0, 54.0, 55.0, 53.0, 54.0, 52.0, 54.0, 65.0, 51.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 54.4}, {"lowerIsBetter": true, "replicates": [63.0, 68.0, 67.0, 73.0, 71.0, 66.0, 66.0, 66.0, 66.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.4}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 83.0, 82.0, 83.0, 80.0, 96.0, 107.0, 118.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 89.9}, {"lowerIsBetter": true, "replicates": [126.0, 121.0, 125.0, 124.0, 128.0, 129.0, 107.0, 127.0, 111.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.9}, {"lowerIsBetter": true, "replicates": [135.0, 124.0, 135.0, 135.0, 134.0, 108.0, 143.0, 168.0, 118.0, 170.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.0}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 68.0, 68.0, 67.0, 67.0, 68.0, 67.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.0}], "name": "kraken", "value": 1432.6000000000001}]} 03:09:00 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1432.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7437.08"}}} 03:09:00 INFO - Return code: 0 03:09:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:09:00 INFO - # TBPL SUCCESS # 03:09:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:09:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:09:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:09:00 INFO - 2016-02-10 03:09:00.289 screenresolution[1690:10214] starting screenresolution argv=screenresolution get 03:09:00 INFO - 2016-02-10 03:09:00.291 screenresolution[1690:10214] Display 0: 1600x1200x32@60 03:09:00 INFO - 2016-02-10 03:09:00.297 screenresolution[1691:10217] starting screenresolution argv=screenresolution list 03:09:00 INFO - Available Modes on Display 0 03:09:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:09:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:09:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:09:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:09:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:09:00 INFO - Intel Iris: 03:09:00 INFO - Chipset Model: Intel Iris 03:09:00 INFO - Type: GPU 03:09:00 INFO - Bus: Built-In 03:09:00 INFO - VRAM (Dynamic, Max): 1536 MB 03:09:00 INFO - Vendor: Intel (0x8086) 03:09:00 INFO - Device ID: 0x0a2e 03:09:00 INFO - Revision ID: 0x0009 03:09:00 INFO - Displays: 03:09:00 INFO - Display: 03:09:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:09:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:09:00 INFO - Display Serial Number: 1600x1200 60 03:09:00 INFO - Main Display: Yes 03:09:00 INFO - Mirror: Off 03:09:00 INFO - Online: Yes 03:09:00 INFO - Rotation: Supported 03:09:00 INFO - Return code: 0 03:09:00 INFO - Running post-action listener: _resource_record_post_action 03:09:00 INFO - Running post-run listener: _resource_record_post_run 03:09:01 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 33963520; Write bytes: 708027392; Read time: 353; Write time: 2061 03:09:01 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 406229504; Write bytes: 407238144; Read time: 30267; Write time: 767 03:09:01 INFO - run-tests - Wall time: 1175s; CPU: 53.0%; Read bytes: 32169472; Write bytes: 298737152; Read time: 335; Write time: 1279 03:09:01 INFO - Running post-run listener: _upload_blobber_files 03:09:01 INFO - Blob upload gear active. 03:09:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:09:01 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:09:01 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'] 03:09:01 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 03:09:02 INFO - (blobuploader) - INFO - Open directory for files ... 03:09:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:09:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:09:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:09:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:09:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:09:02 INFO - (blobuploader) - INFO - Done attempting. 03:09:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:09:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:09:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:09:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:09:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:09:03 INFO - (blobuploader) - INFO - Done attempting. 03:09:03 INFO - (blobuploader) - INFO - Iteration through files over. 03:09:03 INFO - Return code: 0 03:09:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:09:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:09:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f6960c691cc33c22a2d44339fc1e83b7fe37d74045822c388cd7f8c5ba956cdb0a6120a00387530fd0030bbf67bb62db7a039c2be01b989ee1aa409f03a63134", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d51f26b6bf028c3caef0ccfcdb46c94b7cff66a9add03d24bd08dc413dbf01fbb89c76c0aab5bd772139256507d18dd2cabdea47038af213d121600dabd7df40"} 03:09:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:09:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:09:03 INFO - Contents: 03:09:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f6960c691cc33c22a2d44339fc1e83b7fe37d74045822c388cd7f8c5ba956cdb0a6120a00387530fd0030bbf67bb62db7a039c2be01b989ee1aa409f03a63134", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d51f26b6bf028c3caef0ccfcdb46c94b7cff66a9add03d24bd08dc413dbf01fbb89c76c0aab5bd772139256507d18dd2cabdea47038af213d121600dabd7df40"} 03:09:03 INFO - Running post-run listener: copy_logs_to_upload_dir 03:09:03 INFO - Copying logs to upload dir... 03:09:03 INFO - mkdir: /builds/slave/test/build/upload/logs 03:09:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.594448 ========= master_lag: 2.15 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-02-10 03:09:06.035346) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-10 03:09:06.039187) ========= 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.bRzqGKF7KN/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.dOM7ZMDTJp/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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/f6960c691cc33c22a2d44339fc1e83b7fe37d74045822c388cd7f8c5ba956cdb0a6120a00387530fd0030bbf67bb62db7a039c2be01b989ee1aa409f03a63134", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d51f26b6bf028c3caef0ccfcdb46c94b7cff66a9add03d24bd08dc413dbf01fbb89c76c0aab5bd772139256507d18dd2cabdea47038af213d121600dabd7df40"} build_url:https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011189 build_url: 'https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/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/f6960c691cc33c22a2d44339fc1e83b7fe37d74045822c388cd7f8c5ba956cdb0a6120a00387530fd0030bbf67bb62db7a039c2be01b989ee1aa409f03a63134", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d51f26b6bf028c3caef0ccfcdb46c94b7cff66a9add03d24bd08dc413dbf01fbb89c76c0aab5bd772139256507d18dd2cabdea47038af213d121600dabd7df40"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-10 03:09:06.073649) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 03:09:06.073975) ========= 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.bRzqGKF7KN/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.dOM7ZMDTJp/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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.005272 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 03:09:06.122278) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-10 03:09:06.122565) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-10 03:09:06.124735) ========= ========= Total master_lag: 2.65 =========