builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0192 starttime: 1455310013.14 results: success (0) buildid: 20160212031713 builduid: 2303f6e6adf04d98ba1e13b697b04d31 revision: b9d3adb8692c10d93125eabcef0ac67b3d955c56 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-12 12:46:53.139474) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-12 12:46:53.140005) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-12 12:46:53.140405) ========= 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.5bireDN4lC/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.t0AbLO0kSC/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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.005622 basedir: '/builds/slave/test' ========= master_lag: 0.08 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-12 12:46:53.229250) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-12 12:46:53.229568) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-12 12:46:53.825002) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 12:46:53.825308) ========= 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.5bireDN4lC/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.t0AbLO0kSC/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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.005300 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 12:46:53.883241) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-12 12:46:53.883553) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-12 12:46:53.883925) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 12:46:53.884275) ========= 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.5bireDN4lC/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.t0AbLO0kSC/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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-12 12:46:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 159M=0s 2016-02-12 12:46:54 (159 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.201420 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 12:46:54.110804) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 12:46:54.111131) ========= 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.5bireDN4lC/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.t0AbLO0kSC/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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.025673 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 12:46:54.169326) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-12 12:46:54.169776) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b9d3adb8692c10d93125eabcef0ac67b3d955c56 --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 b9d3adb8692c10d93125eabcef0ac67b3d955c56 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5bireDN4lC/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.t0AbLO0kSC/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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-12 12:46:54,249 truncating revision to first 12 chars 2016-02-12 12:46:54,250 Setting DEBUG logging. 2016-02-12 12:46:54,250 attempt 1/10 2016-02-12 12:46:54,250 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b9d3adb8692c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-12 12:46:55,011 unpacking tar archive at: fx-team-b9d3adb8692c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.019892 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-12 12:46:55.211507) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-12 12:46:55.211919) ========= echo b9d3adb8692c10d93125eabcef0ac67b3d955c56 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'b9d3adb8692c10d93125eabcef0ac67b3d955c56'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5bireDN4lC/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.t0AbLO0kSC/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 b9d3adb8692c10d93125eabcef0ac67b3d955c56 program finished with exit code 0 elapsedTime=0.005685 script_repo_revision: 'b9d3adb8692c10d93125eabcef0ac67b3d955c56' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-12 12:46:55.262475) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-12 12:46:55.262854) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-12 12:46:55.275617) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-02-12 12:46:55.275962) ========= /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.5bireDN4lC/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.t0AbLO0kSC/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 12:46:55 INFO - MultiFileLogger online at 20160212 12:46:55 in /builds/slave/test 12:46:55 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 12:46:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:46:55 INFO - {'append_to_log': False, 12:46:55 INFO - 'base_work_dir': '/builds/slave/test', 12:46:55 INFO - 'blob_upload_branch': 'Fx-Team', 12:46:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:46:55 INFO - 'branch': 'Fx-Team', 12:46:55 INFO - 'buildbot_json_path': 'buildprops.json', 12:46:55 INFO - 'config_files': ('talos/mac_config.py',), 12:46:55 INFO - 'default_actions': ('clobber', 12:46:55 INFO - 'read-buildbot-config', 12:46:55 INFO - 'download-and-extract', 12:46:55 INFO - 'populate-webroot', 12:46:55 INFO - 'create-virtualenv', 12:46:55 INFO - 'install', 12:46:55 INFO - 'run-tests'), 12:46:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:46:55 INFO - 'download_minidump_stackwalk': True, 12:46:55 INFO - 'download_symbols': 'ondemand', 12:46:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:46:55 INFO - 'tooltool.py': '/tools/tooltool.py', 12:46:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:46:55 INFO - '/tools/misc-python/virtualenv.py')}, 12:46:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:46:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:46:55 INFO - 'installer_path': 'installer.exe', 12:46:55 INFO - 'log_level': 'info', 12:46:55 INFO - 'log_name': 'talos', 12:46:55 INFO - 'log_to_console': True, 12:46:55 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:46:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:46:55 INFO - 'opt_config_files': (), 12:46:55 INFO - 'pip_index': False, 12:46:55 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:46:55 INFO - 'cmd': ('bash', 12:46:55 INFO - '-c', 12:46:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:46:55 INFO - 'enabled': True, 12:46:55 INFO - 'halt_on_failure': False, 12:46:55 INFO - 'name': 'check_screen_resolution'},), 12:46:55 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:46:55 INFO - 'cmd': ('bash', 12:46:55 INFO - '-c', 12:46:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:46:55 INFO - 'enabled': True, 12:46:55 INFO - 'halt_on_failure': False, 12:46:55 INFO - 'name': 'check_screen_resolution'},), 12:46:55 INFO - 'run_cmd_checks_enabled': True, 12:46:55 INFO - 'sps_profile': False, 12:46:55 INFO - 'sps_profile_interval': 0, 12:46:55 INFO - 'suite': 'dromaeojs', 12:46:55 INFO - 'system_bits': '32', 12:46:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:46:55 INFO - 'title': 't-yosemite-r7-0192', 12:46:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:46:55 INFO - 'use_talos_json': True, 12:46:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:46:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:46:55 INFO - 'work_dir': 'build'} 12:46:55 INFO - ##### 12:46:55 INFO - ##### Running clobber step. 12:46:55 INFO - ##### 12:46:55 INFO - Running pre-action listener: _resource_record_pre_action 12:46:55 INFO - Running main action method: clobber 12:46:55 INFO - rmtree: /builds/slave/test/build 12:46:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:46:56 INFO - Running post-action listener: _resource_record_post_action 12:46:56 INFO - ##### 12:46:56 INFO - ##### Running read-buildbot-config step. 12:46:56 INFO - ##### 12:46:56 INFO - Running pre-action listener: _resource_record_pre_action 12:46:56 INFO - Running main action method: read_buildbot_config 12:46:56 INFO - Using buildbot properties: 12:46:56 INFO - { 12:46:56 INFO - "project": "", 12:46:56 INFO - "product": "firefox", 12:46:56 INFO - "script_repo_revision": "production", 12:46:56 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 12:46:56 INFO - "repository": "", 12:46:56 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 12:46:56 INFO - "buildid": "20160212031713", 12:46:56 INFO - "pgo_build": "False", 12:46:56 INFO - "basedir": "/builds/slave/test", 12:46:56 INFO - "buildnumber": 369, 12:46:56 INFO - "slavename": "t-yosemite-r7-0192", 12:46:56 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 12:46:56 INFO - "platform": "yosemite_r7", 12:46:56 INFO - "scheduler": "tests-fx-team-macosx64-talos", 12:46:56 INFO - "branch": "fx-team", 12:46:56 INFO - "repo_path": "integration/fx-team", 12:46:56 INFO - "revision": "b9d3adb8692c10d93125eabcef0ac67b3d955c56", 12:46:56 INFO - "stage_platform": "macosx64", 12:46:56 INFO - "builduid": "2303f6e6adf04d98ba1e13b697b04d31", 12:46:56 INFO - "slavebuilddir": "test" 12:46:56 INFO - } 12:46:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/SAjNjdB9Qyyega-EeRl1NQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 12:46:56 INFO - Running post-action listener: _resource_record_post_action 12:46:56 INFO - ##### 12:46:56 INFO - ##### Running download-and-extract step. 12:46:56 INFO - ##### 12:46:56 INFO - Running pre-action listener: _resource_record_pre_action 12:46:56 INFO - Running main action method: download_and_extract 12:46:56 INFO - mkdir: /builds/slave/test/build/tests 12:46:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:46:56 INFO - https://queue.taskcluster.net/v1/task/SAjNjdB9Qyyega-EeRl1NQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:46:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SAjNjdB9Qyyega-EeRl1NQ/artifacts/public/build/test_packages.json 12:46:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SAjNjdB9Qyyega-EeRl1NQ/artifacts/public/build/test_packages.json 12:46:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SAjNjdB9Qyyega-EeRl1NQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 12:46:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SAjNjdB9Qyyega-EeRl1NQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 12:46:58 INFO - Downloaded 1277 bytes. 12:46:58 INFO - Reading from file /builds/slave/test/build/test_packages.json 12:46:58 INFO - Using the following test package requirements: 12:46:58 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 12:46:58 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 12:46:58 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 12:46:58 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 12:46:58 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 12:46:58 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 12:46:58 INFO - u'jsshell-mac.zip'], 12:46:58 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 12:46:58 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 12:46:58 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 12:46:58 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 12:46:58 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 12:46:58 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 12:46:58 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 12:46:58 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 12:46:58 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 12:46:58 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 12:46:58 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 12:46:58 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 12:46:58 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:46:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:46:58 INFO - https://queue.taskcluster.net/v1/task/SAjNjdB9Qyyega-EeRl1NQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:46:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SAjNjdB9Qyyega-EeRl1NQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 12:46:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SAjNjdB9Qyyega-EeRl1NQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 12:46:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SAjNjdB9Qyyega-EeRl1NQ/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 12:46:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SAjNjdB9Qyyega-EeRl1NQ/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 12:47:00 INFO - Downloaded 17754968 bytes. 12:47:00 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'] 12:47:00 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 12:47:03 INFO - Return code: 0 12:47:03 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 12:47: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')]} 12:47:03 INFO - https://queue.taskcluster.net/v1/task/SAjNjdB9Qyyega-EeRl1NQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:47:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SAjNjdB9Qyyega-EeRl1NQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 12:47:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SAjNjdB9Qyyega-EeRl1NQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 12:47:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SAjNjdB9Qyyega-EeRl1NQ/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 12:47:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SAjNjdB9Qyyega-EeRl1NQ/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 12:47:04 INFO - Downloaded 17754968 bytes. 12:47: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'] 12:47: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 12:47:07 INFO - Return code: 0 12:47: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')]} 12:47:07 INFO - https://queue.taskcluster.net/v1/task/SAjNjdB9Qyyega-EeRl1NQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 12:47:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SAjNjdB9Qyyega-EeRl1NQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 12:47:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SAjNjdB9Qyyega-EeRl1NQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 12:47:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SAjNjdB9Qyyega-EeRl1NQ/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 12:47:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SAjNjdB9Qyyega-EeRl1NQ/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 12:47:09 INFO - Downloaded 10706547 bytes. 12:47:09 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'] 12:47:09 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 12:47:09 INFO - Return code: 0 12:47:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:09 INFO - https://queue.taskcluster.net/v1/task/SAjNjdB9Qyyega-EeRl1NQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 12:47:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SAjNjdB9Qyyega-EeRl1NQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 12:47:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SAjNjdB9Qyyega-EeRl1NQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 12:47:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SAjNjdB9Qyyega-EeRl1NQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 12:47:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SAjNjdB9Qyyega-EeRl1NQ/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 12:47:13 INFO - Downloaded 111136673 bytes. 12:47:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SAjNjdB9Qyyega-EeRl1NQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 12:47:13 INFO - mkdir: /builds/slave/test/properties 12:47:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:47:13 INFO - Writing to file /builds/slave/test/properties/build_url 12:47:13 INFO - Contents: 12:47:13 INFO - build_url:https://queue.taskcluster.net/v1/task/SAjNjdB9Qyyega-EeRl1NQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 12:47:14 INFO - Running post-action listener: _resource_record_post_action 12:47:14 INFO - Running post-action listener: set_extra_try_arguments 12:47:14 INFO - ##### 12:47:14 INFO - ##### Running populate-webroot step. 12:47:14 INFO - ##### 12:47:14 INFO - Running pre-action listener: _resource_record_pre_action 12:47:14 INFO - Running main action method: populate_webroot 12:47:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:47:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:47:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:47:14 INFO - '--tppagecycles', 12:47:14 INFO - '7'], 12:47:14 INFO - 'tests': ['tsvgm']}}, 12:47:14 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:47:14 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:47:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:47:14 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 12:47:14 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:47:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:47:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:47:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:47:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:47:14 INFO - 'talos_options': ['--e10s'], 12:47:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:47:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:47:14 INFO - 'tests': ['damp', 'tps']}, 12:47:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:47:14 INFO - 'talos_options': ['--e10s'], 12:47:14 INFO - 'tests': ['damp', 'tps']}, 12:47:14 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:47:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:47:14 INFO - 'other': {'tests': ['a11yr', 12:47:14 INFO - 'ts_paint', 12:47:14 INFO - 'tpaint', 12:47:14 INFO - 'sessionrestore', 12:47:14 INFO - 'sessionrestore_no_auto_restore']}, 12:47:14 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:47:14 INFO - 'tests': ['a11yr', 12:47:14 INFO - 'ts_paint', 12:47:14 INFO - 'tpaint', 12:47:14 INFO - 'sessionrestore', 12:47:14 INFO - 'sessionrestore_no_auto_restore']}, 12:47:14 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:47:14 INFO - 'tests': ['a11yr', 12:47:14 INFO - 'ts_paint', 12:47:14 INFO - 'tpaint', 12:47:14 INFO - 'sessionrestore', 12:47:14 INFO - 'sessionrestore_no_auto_restore']}, 12:47:14 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:47:14 INFO - 'tests': ['a11yr', 12:47:14 INFO - 'ts_paint', 12:47:14 INFO - 'tpaint', 12:47:14 INFO - 'sessionrestore', 12:47:14 INFO - 'sessionrestore_no_auto_restore']}, 12:47:14 INFO - 'other_l64': {'tests': ['a11yr', 12:47:14 INFO - 'ts_paint', 12:47:14 INFO - 'tpaint', 12:47:14 INFO - 'sessionrestore', 12:47:14 INFO - 'sessionrestore_no_auto_restore']}, 12:47:14 INFO - 'other_nol64': {'tests': ['a11yr', 12:47:14 INFO - 'ts_paint', 12:47:14 INFO - 'tpaint', 12:47:14 INFO - 'sessionrestore', 12:47:14 INFO - 'sessionrestore_no_auto_restore']}, 12:47:14 INFO - 'svgr': {'tests': ['tsvgx', 12:47:14 INFO - 'tsvgr_opacity', 12:47:14 INFO - 'tart', 12:47:14 INFO - 'tscrollx', 12:47:14 INFO - 'cart']}, 12:47:14 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:47:14 INFO - 'tests': ['tsvgx', 12:47:14 INFO - 'tsvgr_opacity', 12:47:14 INFO - 'tart', 12:47:14 INFO - 'tscrollx', 12:47:14 INFO - 'cart']}, 12:47:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:47:14 INFO - 'tests': ['tp5o']}, 12:47:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:47:14 INFO - 'talos_options': ['--e10s'], 12:47:14 INFO - 'tests': ['tp5o']}, 12:47:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:47:14 INFO - 'talos_options': ['--xperf_path', 12:47:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:47:14 INFO - 'tests': ['tp5n']}, 12:47:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:47:14 INFO - 'talos_options': ['--e10s', 12:47:14 INFO - '--xperf_path', 12:47:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:47:14 INFO - 'tests': ['tp5n']}}, 12:47:14 INFO - 'talos.zip': {'path': '', 12:47:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:47:14 INFO - Running post-action listener: _resource_record_post_action 12:47:14 INFO - ##### 12:47:14 INFO - ##### Running create-virtualenv step. 12:47:14 INFO - ##### 12:47:14 INFO - Running pre-action listener: _resource_record_pre_action 12:47:14 INFO - Running main action method: create_virtualenv 12:47:14 INFO - Creating virtualenv /builds/slave/test/build/venv 12:47:14 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 12:47:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:47:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:47:14 INFO - Using real prefix '/tools/python27' 12:47:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:47:15 INFO - Installing distribute.............................................................................................................................................................................................done. 12:47:17 INFO - Installing pip.................done. 12:47:17 INFO - Return code: 0 12:47:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:47:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f959a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9614c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc868d93a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7fdd30>, '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 0x10f621db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7f4b20>, '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.5bireDN4lC/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.t0AbLO0kSC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 12:47:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:47:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:47:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5bireDN4lC/Render', 12:47:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:47:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:47:17 INFO - 'HOME': '/Users/cltbld', 12:47:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:47:17 INFO - 'LOGNAME': 'cltbld', 12:47:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:17 INFO - 'MOZ_NO_REMOTE': '1', 12:47:17 INFO - 'NO_EM_RESTART': '1', 12:47:17 INFO - 'PAGER': '/bin/cat', 12:47:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:47:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:17 INFO - 'PWD': '/builds/slave/test', 12:47:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:47:17 INFO - 'SHELL': '/bin/bash', 12:47:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t0AbLO0kSC/Listeners', 12:47:17 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 12:47:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:47:17 INFO - 'USER': 'cltbld', 12:47:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:47:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:47:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:17 INFO - 'XPC_FLAGS': '0x0', 12:47:17 INFO - 'XPC_SERVICE_NAME': '0', 12:47:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:47:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:18 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 12:47:18 INFO - Cleaning up... 12:47:18 INFO - Return code: 0 12:47:18 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:47:18 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')]} 12:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:18 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')]} 12:47:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:18 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 0x10f959a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9614c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc868d93a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7fdd30>, '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 0x10f621db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7f4b20>, '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.5bireDN4lC/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.t0AbLO0kSC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 12:47:18 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 12:47:18 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 12:47:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5bireDN4lC/Render', 12:47:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:47:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:47:18 INFO - 'HOME': '/Users/cltbld', 12:47:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:47:18 INFO - 'LOGNAME': 'cltbld', 12:47:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:18 INFO - 'MOZ_NO_REMOTE': '1', 12:47:18 INFO - 'NO_EM_RESTART': '1', 12:47:18 INFO - 'PAGER': '/bin/cat', 12:47:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:47:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:18 INFO - 'PWD': '/builds/slave/test', 12:47:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:47:18 INFO - 'SHELL': '/bin/bash', 12:47:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t0AbLO0kSC/Listeners', 12:47:18 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 12:47:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:47:18 INFO - 'USER': 'cltbld', 12:47:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:47:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:47:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:18 INFO - 'XPC_FLAGS': '0x0', 12:47:18 INFO - 'XPC_SERVICE_NAME': '0', 12:47:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:47:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:18 INFO - Downloading/unpacking psutil>=0.7.1 12:47:18 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 12:47:18 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 12:47:18 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 12:47:18 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 12:47:18 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 12:47:18 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 12:47:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:47:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:47:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:47:21 INFO - Installing collected packages: psutil 12:47:21 INFO - Running setup.py install for psutil 12:47:21 INFO - building 'psutil._psutil_osx' extension 12:47:21 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 12:47:22 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 12:47:22 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 12:47:22 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 12:47:22 INFO - building 'psutil._psutil_posix' extension 12:47:22 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 12:47:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:47:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:47:22 INFO - ^ 12:47:22 INFO - 1 warning generated. 12:47:22 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 12:47:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:47:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:47:22 INFO - Successfully installed psutil 12:47:22 INFO - Cleaning up... 12:47:22 INFO - Return code: 0 12:47:22 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:47: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')]} 12:47:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47: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')]} 12:47:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47: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', '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 0x10f959a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9614c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc868d93a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7fdd30>, '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 0x10f621db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7f4b20>, '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.5bireDN4lC/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.t0AbLO0kSC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 12:47: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 12:47: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 mozsystemmonitor==0.0.0 12:47:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5bireDN4lC/Render', 12:47:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:47:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:47:22 INFO - 'HOME': '/Users/cltbld', 12:47:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:47:22 INFO - 'LOGNAME': 'cltbld', 12:47:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:22 INFO - 'MOZ_NO_REMOTE': '1', 12:47:22 INFO - 'NO_EM_RESTART': '1', 12:47:22 INFO - 'PAGER': '/bin/cat', 12:47:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:47:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:22 INFO - 'PWD': '/builds/slave/test', 12:47:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:47:22 INFO - 'SHELL': '/bin/bash', 12:47:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t0AbLO0kSC/Listeners', 12:47:22 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 12:47:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:47:22 INFO - 'USER': 'cltbld', 12:47:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:47:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:47:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:22 INFO - 'XPC_FLAGS': '0x0', 12:47:22 INFO - 'XPC_SERVICE_NAME': '0', 12:47:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:47:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:23 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:47:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:47:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:47:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:47:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:47:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:47:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:47:25 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:47:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:47:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:47:25 INFO - Installing collected packages: mozsystemmonitor 12:47:25 INFO - Running setup.py install for mozsystemmonitor 12:47:25 INFO - Successfully installed mozsystemmonitor 12:47:25 INFO - Cleaning up... 12:47:25 INFO - Return code: 0 12:47:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:47:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x10f959a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9614c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc868d93a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7fdd30>, '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 0x10f621db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7f4b20>, '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.5bireDN4lC/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.t0AbLO0kSC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 12:47:25 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 12:47:25 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 12:47:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5bireDN4lC/Render', 12:47:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:47:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:47:25 INFO - 'HOME': '/Users/cltbld', 12:47:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:47:25 INFO - 'LOGNAME': 'cltbld', 12:47:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:25 INFO - 'MOZ_NO_REMOTE': '1', 12:47:25 INFO - 'NO_EM_RESTART': '1', 12:47:25 INFO - 'PAGER': '/bin/cat', 12:47:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:47:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:25 INFO - 'PWD': '/builds/slave/test', 12:47:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:47:25 INFO - 'SHELL': '/bin/bash', 12:47:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t0AbLO0kSC/Listeners', 12:47:25 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 12:47:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:47:25 INFO - 'USER': 'cltbld', 12:47:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:47:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:47:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:25 INFO - 'XPC_FLAGS': '0x0', 12:47:25 INFO - 'XPC_SERVICE_NAME': '0', 12:47:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:47:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:25 INFO - Downloading/unpacking blobuploader==1.2.4 12:47:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:47:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:47:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:47:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:47:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:47:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:47:28 INFO - Downloading blobuploader-1.2.4.tar.gz 12:47:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:47:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:47:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:47:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:47:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:47:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:47:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:47:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:47:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:47:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:47: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 12:47: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 12:47: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 12:47: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 12:47: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 12:47: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 12:47:29 INFO - Downloading docopt-0.6.1.tar.gz 12:47:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:47:29 INFO - Installing collected packages: blobuploader, requests, docopt 12:47:29 INFO - Running setup.py install for blobuploader 12:47:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:47:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:47:29 INFO - Running setup.py install for requests 12:47:30 INFO - Running setup.py install for docopt 12:47:30 INFO - Successfully installed blobuploader requests docopt 12:47:30 INFO - Cleaning up... 12:47:30 INFO - Return code: 0 12:47:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:47:30 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')]} 12:47:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:30 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')]} 12:47:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:30 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 0x10f959a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9614c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc868d93a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7fdd30>, '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 0x10f621db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7f4b20>, '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.5bireDN4lC/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.t0AbLO0kSC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 12:47:30 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 12:47:30 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 12:47:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5bireDN4lC/Render', 12:47:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:47:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:47:30 INFO - 'HOME': '/Users/cltbld', 12:47:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:47:30 INFO - 'LOGNAME': 'cltbld', 12:47:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:30 INFO - 'MOZ_NO_REMOTE': '1', 12:47:30 INFO - 'NO_EM_RESTART': '1', 12:47:30 INFO - 'PAGER': '/bin/cat', 12:47:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:47:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:30 INFO - 'PWD': '/builds/slave/test', 12:47:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:47:30 INFO - 'SHELL': '/bin/bash', 12:47:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t0AbLO0kSC/Listeners', 12:47:30 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 12:47:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:47:30 INFO - 'USER': 'cltbld', 12:47:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:47:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:47:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:30 INFO - 'XPC_FLAGS': '0x0', 12:47:30 INFO - 'XPC_SERVICE_NAME': '0', 12:47:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:47:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:47:30 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-6gLKtd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:47:30 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-1KqRJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:47:30 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-LTHyWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:47:30 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-Aai2Tu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:47:31 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-6gaHjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:47:31 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-Z0aHea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:47:31 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-mF1coO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:47:31 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-HTYwiO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:47:31 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-kTXydu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:47:31 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-9iTaps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:47:31 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-6Ls5lx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:47:31 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-k2Z7wT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:47:31 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-j4tp0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:47:32 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-bazztv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:47:32 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-exJv4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:47:32 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-sU4_O5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:47:32 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-psjLVe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:47:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:47:32 INFO - Running setup.py install for manifestparser 12:47:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:47:32 INFO - Running setup.py install for mozcrash 12:47:32 INFO - Running setup.py install for mozdebug 12:47:32 INFO - Running setup.py install for mozdevice 12:47:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:47:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:47:33 INFO - Running setup.py install for mozfile 12:47:33 INFO - Running setup.py install for mozhttpd 12:47:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:47:33 INFO - Running setup.py install for mozinfo 12:47:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:47:33 INFO - Running setup.py install for mozInstall 12:47:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:47:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:47:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:47:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:47:33 INFO - Running setup.py install for mozleak 12:47:33 INFO - Running setup.py install for mozlog 12:47:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:47:33 INFO - Running setup.py install for moznetwork 12:47:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:47:34 INFO - Running setup.py install for mozprocess 12:47:34 INFO - Running setup.py install for mozprofile 12:47:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:47:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:47:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:47:34 INFO - Running setup.py install for mozrunner 12:47:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:47:34 INFO - Running setup.py install for mozscreenshot 12:47:34 INFO - Running setup.py install for moztest 12:47:34 INFO - Running setup.py install for mozversion 12:47:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:47:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:47:34 INFO - Cleaning up... 12:47:34 INFO - Return code: 0 12:47:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:47: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')]} 12:47:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:35 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')]} 12:47:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:35 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 0x10f959a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9614c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc868d93a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7fdd30>, '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 0x10f621db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7f4b20>, '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.5bireDN4lC/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.t0AbLO0kSC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 12:47:35 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 12:47:35 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 12:47:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5bireDN4lC/Render', 12:47:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:47:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:47:35 INFO - 'HOME': '/Users/cltbld', 12:47:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:47:35 INFO - 'LOGNAME': 'cltbld', 12:47:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:35 INFO - 'MOZ_NO_REMOTE': '1', 12:47:35 INFO - 'NO_EM_RESTART': '1', 12:47:35 INFO - 'PAGER': '/bin/cat', 12:47:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:47:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:35 INFO - 'PWD': '/builds/slave/test', 12:47:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:47:35 INFO - 'SHELL': '/bin/bash', 12:47:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t0AbLO0kSC/Listeners', 12:47:35 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 12:47:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:47:35 INFO - 'USER': 'cltbld', 12:47:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:47:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:47:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:35 INFO - 'XPC_FLAGS': '0x0', 12:47:35 INFO - 'XPC_SERVICE_NAME': '0', 12:47:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:47:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:47:35 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-ahrEWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:47:35 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)) 12:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:47:35 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-9tx7IL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:47:35 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)) 12:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:47:35 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-avYApR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:47:35 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)) 12:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:47:35 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-wsba8q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:47:35 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)) 12:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:47:35 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-eybR3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:47:35 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)) 12:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:47:35 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-gl5al3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:47:35 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)) 12:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:47:35 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-Bz8fNg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:47:36 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)) 12:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:47:36 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-5f4Z_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:47:36 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)) 12:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:47:36 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-GCvSj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:47:36 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)) 12:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:47:36 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-avUpcp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:47:36 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)) 12:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:47:36 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-r2tIF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:47:36 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)) 12:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:47:36 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-QD3xUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:47:36 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)) 12:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:47:36 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-45Y1Gf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:47:36 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)) 12:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:47:36 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-GpyQ55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:47:36 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)) 12:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:47:36 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-Md982r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:47:36 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)) 12:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:47:36 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-vH1Vlo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:47:36 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)) 12:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:47:36 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-jkI3Zk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:47:37 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)) 12:47:37 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)) 12:47:37 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)) 12:47:37 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)) 12:47:37 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)) 12:47:37 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)) 12:47:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:47:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:47:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:47:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:47:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:47:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:47:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:47:39 INFO - Downloading blessings-1.6.tar.gz 12:47:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:47:39 INFO - Installing collected packages: blessings 12:47:39 INFO - Running setup.py install for blessings 12:47:39 INFO - Successfully installed blessings 12:47:39 INFO - Cleaning up... 12:47:39 INFO - Return code: 0 12:47:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:47:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:47:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:47:40 INFO - Reading from file tmpfile_stdout 12:47:40 INFO - Current package versions: 12:47:40 INFO - blessings == 1.6 12:47:40 INFO - blobuploader == 1.2.4 12:47:40 INFO - docopt == 0.6.1 12:47:40 INFO - manifestparser == 1.1 12:47:40 INFO - mozInstall == 1.12 12:47:40 INFO - mozcrash == 0.16 12:47:40 INFO - mozdebug == 0.1 12:47:40 INFO - mozdevice == 0.48 12:47:40 INFO - mozfile == 1.2 12:47:40 INFO - mozhttpd == 0.7 12:47:40 INFO - mozinfo == 0.9 12:47:40 INFO - mozleak == 0.1 12:47:40 INFO - mozlog == 3.1 12:47:40 INFO - moznetwork == 0.27 12:47:40 INFO - mozprocess == 0.22 12:47:40 INFO - mozprofile == 0.28 12:47:40 INFO - mozrunner == 6.11 12:47:40 INFO - mozscreenshot == 0.1 12:47:40 INFO - mozsystemmonitor == 0.0 12:47:40 INFO - moztest == 0.7 12:47:40 INFO - mozversion == 1.4 12:47:40 INFO - psutil == 3.1.1 12:47:40 INFO - requests == 1.2.3 12:47:40 INFO - wsgiref == 0.1.2 12:47:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:47:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:40 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 0x10f959a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9614c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc868d93a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7fdd30>, '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 0x10f621db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7f4b20>, '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.5bireDN4lC/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.t0AbLO0kSC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 12:47:40 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 12:47:40 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 12:47:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5bireDN4lC/Render', 12:47:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:47:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:47:40 INFO - 'HOME': '/Users/cltbld', 12:47:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:47:40 INFO - 'LOGNAME': 'cltbld', 12:47:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:40 INFO - 'MOZ_NO_REMOTE': '1', 12:47:40 INFO - 'NO_EM_RESTART': '1', 12:47:40 INFO - 'PAGER': '/bin/cat', 12:47:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:47:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:40 INFO - 'PWD': '/builds/slave/test', 12:47:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:47:40 INFO - 'SHELL': '/bin/bash', 12:47:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t0AbLO0kSC/Listeners', 12:47:40 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 12:47:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:47:40 INFO - 'USER': 'cltbld', 12:47:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:47:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:47:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:40 INFO - 'XPC_FLAGS': '0x0', 12:47:40 INFO - 'XPC_SERVICE_NAME': '0', 12:47:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:47:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:40 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)) 12:47:40 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)) 12:47:40 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)) 12:47:40 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)) 12:47:40 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)) 12:47:40 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)) 12:47:40 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)) 12:47:40 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)) 12:47:40 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)) 12:47:40 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)) 12:47:40 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)) 12:47:40 INFO - Cleaning up... 12:47:40 INFO - Return code: 0 12:47:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:47:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f959a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9614c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc868d93a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7fdd30>, '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 0x10f621db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7f4b20>, '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.5bireDN4lC/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.t0AbLO0kSC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 12:47:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:47:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:47:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5bireDN4lC/Render', 12:47:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:47:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:47:40 INFO - 'HOME': '/Users/cltbld', 12:47:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:47:40 INFO - 'LOGNAME': 'cltbld', 12:47:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:40 INFO - 'MOZ_NO_REMOTE': '1', 12:47:40 INFO - 'NO_EM_RESTART': '1', 12:47:40 INFO - 'PAGER': '/bin/cat', 12:47:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:47:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:40 INFO - 'PWD': '/builds/slave/test', 12:47:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:47:40 INFO - 'SHELL': '/bin/bash', 12:47:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t0AbLO0kSC/Listeners', 12:47:40 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 12:47:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:47:40 INFO - 'USER': 'cltbld', 12:47:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:47:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:47:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:40 INFO - 'XPC_FLAGS': '0x0', 12:47:40 INFO - 'XPC_SERVICE_NAME': '0', 12:47:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:47:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:40 INFO - Downloading/unpacking jsonschema 12:47: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 12:47: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 12:47: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 12:47: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 12:47: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 12:47: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 12:47:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:47:42 INFO - Downloading/unpacking functools32 (from jsonschema) 12:47:42 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 12:47:42 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 12:47:42 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 12:47:42 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 12:47:42 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 12:47:42 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 12:47:43 INFO - Downloading functools32-3.2.3-2.tar.gz 12:47:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:47:43 INFO - warning: no files found matching '*.txt' 12:47:43 INFO - no previously-included directories found matching 'build' 12:47:43 INFO - no previously-included directories found matching 'dist' 12:47:43 INFO - no previously-included directories found matching '.git*' 12:47:43 INFO - Installing collected packages: jsonschema, functools32 12:47:43 INFO - Running setup.py install for functools32 12:47:43 INFO - warning: no files found matching '*.txt' 12:47:43 INFO - no previously-included directories found matching 'build' 12:47:43 INFO - no previously-included directories found matching 'dist' 12:47:43 INFO - no previously-included directories found matching '.git*' 12:47:43 INFO - Successfully installed jsonschema functools32 12:47:43 INFO - Cleaning up... 12:47:43 INFO - Return code: 0 12:47:43 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:47: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')]} 12:47:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47: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')]} 12:47:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:43 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 0x10f959a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9614c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc868d93a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7fdd30>, '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 0x10f621db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7f4b20>, '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.5bireDN4lC/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.t0AbLO0kSC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 12:47:43 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 12:47:43 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 12:47:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5bireDN4lC/Render', 12:47:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:47:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:47:43 INFO - 'HOME': '/Users/cltbld', 12:47:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:47:43 INFO - 'LOGNAME': 'cltbld', 12:47:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:43 INFO - 'MOZ_NO_REMOTE': '1', 12:47:43 INFO - 'NO_EM_RESTART': '1', 12:47:43 INFO - 'PAGER': '/bin/cat', 12:47:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:47:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:43 INFO - 'PWD': '/builds/slave/test', 12:47:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:47:43 INFO - 'SHELL': '/bin/bash', 12:47:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t0AbLO0kSC/Listeners', 12:47:43 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 12:47:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:47:43 INFO - 'USER': 'cltbld', 12:47:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:47:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:47:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:43 INFO - 'XPC_FLAGS': '0x0', 12:47:43 INFO - 'XPC_SERVICE_NAME': '0', 12:47:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:47:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:44 INFO - Downloading/unpacking flake8 12:47: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 12:47: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 12:47: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 12:47: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 12:47: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 12:47: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 12:47:46 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:47:46 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:47: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 12:47: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 12:47: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 12:47: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 12:47: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 12:47: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 12:47:46 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:47:46 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:47: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 12:47: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 12:47: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 12:47: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 12:47: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 12:47: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 12:47:46 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:47: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 12:47: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 12:47: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 12:47: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 12:47: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 12:47: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 12:47:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:47:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:47:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:47:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:47:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:47:47 INFO - no previously-included directories found matching 'docs/_build' 12:47:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:47:47 INFO - Running setup.py install for pep8 12:47:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:47:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:47:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:47:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:47:47 INFO - no previously-included directories found matching 'docs/_build' 12:47:47 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:47:47 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:47:47 INFO - Cleaning up... 12:47:47 INFO - Return code: 0 12:47:47 INFO - Running post-action listener: _resource_record_post_action 12:47:47 INFO - Running post-action listener: _start_resource_monitoring 12:47:47 INFO - Starting resource monitoring. 12:47:47 INFO - ##### 12:47:47 INFO - ##### Running install step. 12:47:47 INFO - ##### 12:47:47 INFO - Running pre-action listener: _resource_record_pre_action 12:47:47 INFO - Running main action method: install 12:47:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:47:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:47:48 INFO - Reading from file tmpfile_stdout 12:47:48 INFO - Detecting whether we're running mozinstall >=1.0... 12:47:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:47:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:47:48 INFO - Reading from file tmpfile_stdout 12:47:48 INFO - Output received: 12:47:48 INFO - Usage: mozinstall [options] installer 12:47:48 INFO - Options: 12:47:48 INFO - -h, --help show this help message and exit 12:47:48 INFO - -d DEST, --destination=DEST 12:47:48 INFO - Directory to install application into. [default: 12:47:48 INFO - "/builds/slave/test"] 12:47:48 INFO - --app=APP Application being installed. [default: firefox] 12:47:48 INFO - mkdir: /builds/slave/test/build/application 12:47:48 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'] 12:47:48 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 12:48:21 INFO - Reading from file tmpfile_stdout 12:48:21 INFO - Output received: 12:48:21 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:48:21 INFO - Running post-action listener: _resource_record_post_action 12:48:21 INFO - ##### 12:48:21 INFO - ##### Running run-tests step. 12:48:21 INFO - ##### 12:48:21 INFO - Running pre-action listener: _resource_record_pre_action 12:48:21 INFO - Running main action method: run_tests 12:48:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:48:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:48:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:48:21 INFO - 2016-02-12 12:48:21.791 screenresolution[1656:8680] starting screenresolution argv=screenresolution get 12:48:21 INFO - 2016-02-12 12:48:21.793 screenresolution[1656:8680] Display 0: 1600x1200x32@60 12:48:21 INFO - 2016-02-12 12:48:21.799 screenresolution[1657:8682] starting screenresolution argv=screenresolution list 12:48:21 INFO - Available Modes on Display 0 12:48:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:48:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:48:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:48:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:48:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:48:22 INFO - Intel Iris: 12:48:22 INFO - Chipset Model: Intel Iris 12:48:22 INFO - Type: GPU 12:48:22 INFO - Bus: Built-In 12:48:22 INFO - VRAM (Dynamic, Max): 1536 MB 12:48:22 INFO - Vendor: Intel (0x8086) 12:48:22 INFO - Device ID: 0x0a2e 12:48:22 INFO - Revision ID: 0x0009 12:48:22 INFO - Displays: 12:48:22 INFO - Display: 12:48:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:48:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:48:22 INFO - Display Serial Number: 1600x1200 60 12:48:22 INFO - Main Display: Yes 12:48:22 INFO - Mirror: Off 12:48:22 INFO - Online: Yes 12:48:22 INFO - Rotation: Supported 12:48:22 INFO - Return code: 0 12:48:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:48:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:48:22 INFO - Python 2.7.3 12:48:22 INFO - Return code: 0 12:48:22 INFO - grabbing minidump binary from tooltool 12: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')]} 12:48:22 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 0x10f7fdd30>, '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 0x10f621db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7f4b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:48:22 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 12:48:22 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 12:48:22 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:48:22 INFO - Return code: 0 12:48:22 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:48:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:48:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:48:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:48:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:48:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:48:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:48:23 INFO - Return code: 0 12:48:23 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/SAjNjdB9Qyyega-EeRl1NQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0192', '--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 12:48:23 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/SAjNjdB9Qyyega-EeRl1NQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0192 --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 12:48:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5bireDN4lC/Render', 12:48:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:48:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:48:23 INFO - 'HOME': '/Users/cltbld', 12:48:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:48:23 INFO - 'LOGNAME': 'cltbld', 12:48:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:48:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:48:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:23 INFO - 'MOZ_NO_REMOTE': '1', 12:48:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:48:23 INFO - 'NO_EM_RESTART': '1', 12:48:23 INFO - 'PAGER': '/bin/cat', 12:48:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:48:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:23 INFO - 'PWD': '/builds/slave/test', 12:48:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:48:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:48:23 INFO - 'SHELL': '/bin/bash', 12:48:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t0AbLO0kSC/Listeners', 12:48:23 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 12:48:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:48:23 INFO - 'USER': 'cltbld', 12:48:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:48:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:48:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:23 INFO - 'XPC_FLAGS': '0x0', 12:48:23 INFO - 'XPC_SERVICE_NAME': '0', 12:48:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:48:23 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/SAjNjdB9Qyyega-EeRl1NQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0192', '--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 12:48:23 INFO - mozversion application_buildid: 20160212031713 12:48:23 INFO - mozversion application_changeset: b9d3adb8692c10d93125eabcef0ac67b3d955c56 12:48:23 INFO - mozversion application_display_name: Nightly 12:48:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:48:23 INFO - mozversion application_name: Firefox 12:48:23 INFO - mozversion application_remotingname: firefox 12:48:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:48:23 INFO - mozversion application_vendor: Mozilla 12:48:23 INFO - mozversion application_version: 47.0a1 12:48:23 INFO - mozversion platform_buildid: 20160212031713 12:48:23 INFO - mozversion platform_changeset: b9d3adb8692c10d93125eabcef0ac67b3d955c56 12:48:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:48:23 INFO - mozversion platform_version: 47.0a1 12:48:23 INFO - using testdate: 1455310103 12:48:23 INFO - actual date: 1455310103 12:48:23 INFO - starting webserver on 'localhost:49274' 12:48:23 INFO - SUITE-START | Running 2 tests 12:48:23 INFO - TEST-START | dromaeo_css 12:48:23 INFO - operating with platform_type : mac_ 12:48:23 INFO - Initialising browser for dromaeo_css test... 12:48:23 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/tmpCO3sTC/profile http://localhost:49274/getInfo.html) 12:48:26 INFO - PROCESS | 1675 | __metrics Screen width/height:1600/1200 12:48:26 INFO - PROCESS | 1675 | colorDepth:24 12:48:26 INFO - PROCESS | 1675 | Browser inner width/height: 1024/689 12:48:26 INFO - PROCESS | 1675 | __metrics 12:48:26 INFO - PROCESS | 1675 | 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" 12:48:26 INFO - PROCESS | 1675 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:48:26 INFO - TEST-INFO | 1675: exit 0 12:48:26 INFO - Browser initialized. 12:48:26 INFO - Running cycle 1/1 for dromaeo_css test... 12:48:26 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/tmpCO3sTC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:48:38 INFO - PROCESS | 1679 | RSS: Main: 246329344 12:48:38 INFO - PROCESS | 1679 | 12:49:30 INFO - PROCESS | 1679 | 1455310170562 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] 12:51:39 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 12:51:41 INFO - PROCESS | 1679 | RSS: Main: 358121472 12:51:41 INFO - PROCESS | 1679 | 12:54:43 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 12:54:44 INFO - PROCESS | 1679 | RSS: Main: 382607360 12:54:44 INFO - PROCESS | 1679 | 12:57:46 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 12:57:47 INFO - PROCESS | 1679 | RSS: Main: 380321792 12:57:47 INFO - PROCESS | 1679 | 13:00:49 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 13:00:49 INFO - PROCESS | 1679 | RSS: Main: 337440768 13:00:49 INFO - PROCESS | 1679 | 13:03:52 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 13:03:53 INFO - PROCESS | 1679 | RSS: Main: 339947520 13:03:53 INFO - PROCESS | 1679 | 13:06:56 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 13:06:56 INFO - PROCESS | 1679 | RSS: Main: 410591232 13:06:56 INFO - PROCESS | 1679 | 13:06:56 INFO - PROCESS | 1679 | __start_tp_report 13:06:56 INFO - PROCESS | 1679 | _x_x_mozilla_page_load 13:06:56 INFO - PROCESS | 1679 | _x_x_mozilla_page_load_details 13:06:56 INFO - PROCESS | 1679 | |i|pagename|runs| 13:06:56 INFO - PROCESS | 1679 | |0;dojo.html;2706.472237913607;3435.209901722605;3447.82760861957;3456.6716161964614;3510.3330367230224;5541.5843811714185;5634.436556344363;5636.4927156555905;5650.124230744231;5665.518430933371;5653.236813030239;5657.264555607765;5674.035413979623;5805.970970145154;5810.128480727893;5080.771365288552;5084.44071152172;5112.642115051948;5134.897302053957;5221.477852214767;4019.879403617896;5197.766100525467;5214.713190774525;5248.0815857225025;5253.4221235664045;5066.923996140061;5107.157319042353;5178.5857131429775;5180.197069454241;5202.115640341132;5174.818881339135;5182.222666600002;5184.274201611777;5191.636585439021;5198.960207958424;4325.286327755916;5109.3613298337705;5166.044281807877;5167.741612919339;5171.870703232412;5471.316085489314;5588.748506317185;5607.523360514361;5635.351934527541;5702.914456283118;6156.445919867188;6161.014237721988;6169.475594574466;6177.474914632262;6184.134221209034;5238.319018527605;6067.022556241486;6205.503559715212;6258.186435763367;6281.8743625127245;5730.226419433365;5735.885282294373;5806.88386232273;5829.358770535237;5834.8541286467325;6340.270868850049;6344.143540622049;6344.746210151635;6349.142865713162;6352.237731472253;6022.488088512438;6026.156338112668;6058;6083.482903953213;6085.300190478151;5108.157154069611;6110.236220472441;6127.739336776432;6135.661410523283;6155.538334624921;6099.298580663191;6103.572749907553;6108.144859719643;6129.785457508966;6141.048137538689;6094.078451592408;6126.517673797278;6176.3514830943;6219.129321894848;6235.719392627343;4829.66192366531;4831.178699621073;4844.32179494871;4867.294242334841;4908.337374454474;4240.957590424118;4385.758783266887;4392.758398288125;4399.890002749957;4431.180231657154;5626.943730562642;5629.605927585029;5683.602147849693;5684.914726279109;5730.541556675456;6223.408776166257;6261.812145635638;6285.465735412449;6294.307626161119;6300.842478938063;5567.777288908479;5652.66084034951;5658.688772117573;5670.603057785916;5677.148427735872;5150.639455238173;5323.3611966563485;5346.946530534723;5351.411344752074;5355.30381050461;6302.243730752339;6349.206349206349;6349.999999999907;6352.841178970562;6362.300146983828;6115.422885572139;6193.225846769154;6217.253929528486;6301.747930082929;6311.116443697794;5286.259923610621;6293.905591416224;6304.495640348853;6328.367163283635;6340.778072767431;6009.519238461;6048.818535443944;6057.818265452043;6066.969665151646;6074.939250607437;6114.205153330038;6123.770712314271;6160.722767475385;6164;6262.74949002053;5841.912371314519;6015.075101140845;6049.818505444844;6052.546059045677;6113.755449781959;5985.191999080069;6013.669248191217;6021.217241758543;6034.456898879122;6049.939500605114;5839.5912286141265;5857.297124345106;5907.172995780508;5935;5965.463108320272;5999.250093738283;6035.336113027652;6053.485453736482;6056.121862330026;6059.757609695739;5793.884122317614;5906.822795316148;5921.3782552831335;5922.318933322551;5961.940380596138 13:06:56 INFO - PROCESS | 1679 | |1;ext.html;518.7017464957651;559.4321763410138;565.3357305166434;580.3760956971257;598.5570677698503;30026.849865750668;37889.43165852514;38566.22867542647;38740.80629596852;38747.612523874755;40834.97912552187;41287.79356103215;41313.83577052868;41347.79326103373;41353.79323103388;9423.858642120374;9639;9648.80702385952;9652.131308182263;9653.22774178064;8424;9792.265580081486;9795.657151999681;9795.755106122333;9817.607295708163;9731.172850307732;9817.361871478366;9818;9819.263555233387;9828.312018158731;9726;9782.5597848097;9817.067378599057;9817.165540929029;9835.508224588742;8166.67333306667;9351.625934962662;9570.282228832866;9586.6644667437;9685.176759975411;39426.81719548418;39752.40371394432;39849.80075099635;39883;39946;3176.269458024667;3210.406074876132;3245.902622921316;3273;3391.6438773928876;27784.58323125155;28341.57487637687;28605.71394286051;28716.994905178217;29113.854430727923;2791.6929137794828;2858.0533370511253;2869.196624945019;2873.8563071846534;2986.7909246352765;477438;479915;480479.59760201327;481153;482035;56937.71531142318;57906.8418631625;57935.710321448125;64667;66161;63818.0427293591;63966;64077;64105.67947160234;64106.75626353055;13192.472301107848;15729;15946.60133496672;15951.441699540692;15957.20213989296;11451.770964580663;11785.823212651818;12087.153899227145;12170.57402990891;12179.208351457128;20287.492812679506;21059.052342644616;21188.94055297229;21595.67606485904;21601.351959441243;7529.4729368943645;8775.648974040967;8931.374803763803;8935.642574297086;8981.416207946462;956.5695437053215;969.4910172159532;977.6431602465049;982.2976571751232;1006.3006210683651;29584.704152958624;29596.573007464107;29662.55506167409;29792.851035744683;29822;1063.1069901282806;1076.9407682577378;1143.8284257361297;1210.6852218423098;1227.858796238444;14314.284285785669;14465.421383144767;14531;14548.563543093724;14609.196494192922;537393;550276;552973;552990;556781;57178;57539.13691294634;57562.7121864388;57701.71149144227;57706.7114664424;1422.9644258893404;1434.2326855132662;1454.2074569359725;1459.306829256095;1464.816897887764;23210.767892320862;26689;27246;28630;28963.275918102216;50876.473705788885;51374.486255138465;51382.43087845518;51401.48598514117;51408.485915141864;501237;506280;509528;509840;510578;27030.729692703608;27861.860690696416;28216.15351539457;30105;30601.846990764905;36910.815445923676;39696.60303396929;39819.00452488711;40174;40678.983025424604;28469.43061138724;33771;33986.490202647474;34846;34886.65113348936;34140;34256.657433425346;34298.65701342955;34384.82807585946;35924.64075359213;30790.230244244074;34754;35781;36841.447378289886;36877;26013.869930650224;28407.715922840507;30493.847530762203;30522.389552209275;30876.69123308828;23523.50810598621;24445.38886527851;24519.437830130897;24598.385040374134;24717.25848224556 13:06:56 INFO - PROCESS | 1679 | |2;jquery.html;294.3494876323325;359.12373807908705;364.3587286375977;366.0555766123402;374.2776441467969;12585.496580136807;15132.924335378308;18965.715514267296;19723.704144437826;20300;18158.546036349097;18498.445046648623;18961.051947402644;20392.694109588367;20395.898020509914;5584.86037849054;5857.853553661172;5859.0625499920025;5863.941360586382;5865.824025279248;4189.895252618694;4388.517263101056;5781.913271300934;5929.169916211734;6160.1991741073825;5124.461931497195;6307.653079080649;6388.265349484822;6397.232332120152;6414.037894315843;6212.87574248517;6352.841178970517;6384.265809431882;6387.616742995435;6401.839954001164;5293.86765330866;5435.891282174374;5456.890862182734;5465.535429488498;5490.984167928906;23861.52276954451;24410;25082.498350032896;25198.496030079477;25472.74527254722;2284.8743319117443;2296.184854376689;2346.495503466746;2440;2876.8492602958986;13217.933910330483;13257.526812249649;14432.927835360755;14482.710345793024;14784.482543111048;1758.5515693498076;1759.9296028158858;1796.4790210838842;1801.3813238265864;1861.153175305233;73476.89784653235;90922.54538727264;91821.54089229644;92091;93241.06758932392;8604.78488037804;10259.846102308471;10675.412852293042;10711.62583786105;10769.515371808131;12755;12888.484460621657;12910.9354453229;12920.160189587647;12969.740605187844;6878.759243426456;8408.915910840935;8442.577871106543;8462.323014158852;8531.189536993976;8533.232009119209;8536.061033286334;8546;8624.827503449897;8633;6095.969520152371;6175.84560385994;6197.318294987548;6211.16149319845;6300.21247344082;1645.4323258475806;1735.5921358480748;1736;1834.1012903677101;1834.5321942904475;893.7542175901549;917.2111983694018;949.928755343352;980.3333733061444;997.6907158780801;15781.921090394704;18029.27882884696;18837.05814709259;20272.290469833486;20370.388888333375;880.8326417980692;962.0571839597234;1005.7535903703639;1015.5024038221219;1019.7807471393686;10836.512356943957;10973.286736362112;11068.944655276671;11084.002439780297;11093.1125509959;545531;551326;552801;719604.4862164141;727378;78627.60686196532;83807;92613.5369323149;93021.5348923251;94612;997.4115271989416;1141.2068612314529;1150.551284998851;1153.700037990112;1154.5670373609896;14270.928645356707;14728.484503042342;18647.720284195475;18949.0525473723;19197.84812911174;46364.30453543267;46833.765831171986;46875.062498750514;46889.76555117202;47575.57273281668;52030;64956.0256596142;65910.35224119436;66268.6686566564;66549.66725166343;6393.7122829471855;7383.8154046149275;7555.395568354628;7568.129665088585;7599.126100498514;12067;12081.758364832478;12195.573154939535;12218.083643726579;12234.143609947218;10429.634962776267;10603.628872989408;10690.037896589345;10762.892371076188;10865.402402867918;10365.844512332473;10562.577496900038;10598.287195768213;10757.354558726502;10760.300580462244;10864.945675271889;10939.398333091438;10947.83578246343;10971.01260886524;11177;7484.513506622052;7551.471397002157;7556.811079723051;7593.8860917087395;7617;10535.4732263385;10597;10698.839517407401;10729.678109656723;10965.50655220533 13:06:56 INFO - PROCESS | 1679 | |3;mootools.html;1383.5434306678796;1521.6272013356727;1541.2601951063486;1765.858731301496;1920.9231630734762;7768.378529717623;8466.153384661531;8624.35317351198;8628.697995570155;8635.481871087739;8277.627506762195;8557.786055348619;8559.657613695445;8571.95714021429;8580.485170889735;2170.435686721448;2234.8770817605027;2410.590199666061;2425.8908349124285;2449.2284930247006;2456.435019945414;2492.389364605665;2496.700395952488;2499.462615537659;2502.5245203411387;2430.684011078566;2448.6327050942323;2457.7173625033083;2459.7048354197523;2464.507098580282;2403.5433267679173;2426.8058555315533;2450.791682706972;2450.963235551468;2451.5832308507597;2442.5969714997004;2443.1204766284122;2443.389152711822;2472.5549401107974;2472.7279999200073;8594.914050859536;8608.39741218115;8681.739547813513;8685.565721713889;8693.695720649746;5292.57659387252;5429.53848922842;5466.125419932791;5466.371367292772;5469.699166545838;3439.7764145330725;3495.7378196635354;3539.1329124364697;3547.840347184357;3555;886.8692417168098;971;982.415462799633;1003.0821798054772;1007.89417111203;11565.768684626344;11594.768104637944;11606.24559403636;11607.825882611767;11608.24546404481;4833.275008748716;4840.29815676732;4918.975405123023;4920;4933.210686290176;10008.14930730896;10012.098911098035;10014.79970400588;10016.699499015042;10029.398236105857;5431.782728690808;5433.402325744165;5440.265564148789;5443.237946687467;5447.972760136174;4890.657653964188;4935.777889994959;4943.184374578154;4944.60443164546;4946.356973593482;3582.158192824684;3921.9215615687526;3946.309395855714;3970.642642162219;3993.940090898639;1228.834107395508;1314.737052589486;1315.1385842273326;1327.502186679995;1331.9866801331862;1081.0702795595782;1103.591671081689;1105.4141305108305;1257.9874201257871;1356.8643135686352;7988.680452781824;8008.479448835807;8009.759707208793;8045.758627241192;8210.01479822425;1171.8183681529376;1172.4489489939715;1177.4583691502005;1182.3319824299244;1193.4152265389896;6295.276043254993;6322;6387.041943708481;6387.648679322682;6405.455536279375;10396.22028347877;10676.359418434919;10750.462476876124;10752.139828813677;10868.239223254455;9726.61093556264;10595.735106622396;10717.678469645924;10724.517396717167;10749.925007499187;7931.286184243446;8041.597920103972;8069.394795390369;8128.268455839003;8144.83710325802;7879.84240315202;7941.722039728582;7984.361251100015;8011.238932301422;8024.638891249791;9316.860247096163;9324;9415;9434.339596228197;9481.146696797045;9436.575354108943;9775.755606109904;9821.312508124363;9843.803123937625;9869.950650246703;6744.527883048139;6955.1653801544135;7143.428525717826;7373.410127189919;7388.445866559922;8069.636866340911;8073;8123;8124.67501299965;8141.104478507241;7333.816654583678;7581;7670.616469176631;7706.306432420884;7710.421718371257;7413.221611730691;7487.700491980259;7489.588072656056;7596.924030759622;7617.923820761722;7579.204183560647;7602.695892164252;7671.53970761756;7676.15562288159;7688.923110768821;6816.931830681629;6943.618101004493;6951.2353641098425;6956;6964.756233531802;7107.040549525748;7147.285271473019;7189.7483588074165;7199.640017999184;7205.378789772469 13:06:56 INFO - PROCESS | 1679 | |4;prototype.html;321.6349443381761;331.10931594012106;334.5767603980964;334.80581262867537;337.8429030500818;6410.647414392218;6521.315261897504;6549.508786840988;6553.27913929468;6667.33326667333;6322.399372059647;6529.183852018497;6570.342965703439;6571.901421478682;6582.3746744059235;4884.120858245515;4893.363862697862;4899.926501102486;4900.901981960359;4907.484714105021;4660.370849935266;4736.550027747358;4783.928241076386;4828.324034635154;4910.7299098549565;3958.604139586047;4249.3201087825955;4721.173794585951;4754.239321708527;4788.61691064714;4417.602415782579;4775.856724298276;4778.952210477885;4781.976090119562;4789.568938795525;4147.129102888397;4149.792510374469;4153.646940010072;4155.812988415499;4161.10536234708;6103.816885493442;6316.652584107872;6334.271558770754;6349.333320001379;6368.681565921732;5770.23028946104;5774.0761478163295;5774.451427114417;5776.393478684719;5779.884402311972;5641.802536911229;6954.23503414624;6954.930450695479;6969.965150174216;6977.302269773033;4352.564743525622;4538.432695913011;4542.704724192917;4689.241534424591;4695.178343789823;7371.926280737178;7440.962795186044;7447.590382528959;7454.440916931252;7456.478046536745;4362.934555981663;4629.745364005012;4630.004549021976;4634.189016922025;4656.115338085753;4474.888127796831;4548.340490628906;4554.633609917011;4563.247064234431;4741.928871066937;5529.3364796223905;5558.861028474321;5567.749451274703;5567.860803479945;5585.525230355384;5761.279840019997;6987.371136597731;7046.6828992695455;7063.25835787235;7065.399441047466;1586.92858821351;1614.3139165854466;1624.3746157729358;1633.1017940132879;1636.6235765773938;1029.840374741916;1039.4958445154093;1041.4740556019162;1055.8996895294936;1055.963041293551;6539.08452816606;6541.934580654132;6544.312847150981;6553.672316384162;6575.572587781779;7323.194448610649;7324.377427918686;7331.633418329062;7341.559506429631;7342.11894572644;6445.742170313135;6528.934710652928;6542.887709089467;6710.765123220664;6713.227978782503;3017.9547306790414;3832.4251362295877;3841.865534706272;3851.9614803851605;3853.5183102112237;7548.698052077855;7550.962245188849;7551.886721699179;7552.509086909334;7573.431992600466;7280.235575264627;7415.258474152542;7487.962560187164;7493.838455039478;7504.174540800507;6015;7562.168161502121;7562.432817538706;7562.546247225184;7567.583782891884;7246.456515761444;7250.238724934017;7254.782356529313;7256.383207427428;7262.709491620487;5806.593538452268;6883;7120.430365570845;7129.857402851811;7136.036635054201;7523.586202758682;7528.247175282428;7528.774136775905;7528.849423011399;7542.868569714367;4393.384926110283;4482.887927801831;4490.101979604157;4611.16998940194;4613.400257966443;6967.09427774386;7030.367266945999;7177.569345839266;7330.450216233698;7367.905479698432;7079.29207079288;7105.786826395217;7111.43108551325;7115.324044215791;7123.074000379917;6878.55289406187;7062.1878483975;7092.787216383516;7105.18290396611;7109.040279562193;5656.377798442086;6915.204751453647;6920.307969203241;6921.134858142732;6935.7225710971;6786.253512113565;7035.718571257297;7079;7083.079199704005;7101.644917753988;6933.618650974245;6933.89599156003;6939.861202776017;6941.201761797256;6949.478789090939 13:06:56 INFO - PROCESS | 1679 | |5;yui.html;663.7046514301138;680.6800803622298;711.2070041903278;750.3846845586618;757.6022588141225;14877.107373557594;15098.471553495616;15104.848951510481;15115.470958516455;15132;13639.590812275623;13707.314634268272;13738.793918091236;13742.862571374284;13760.174389536634;700.2542292458528;715.7852644206744;843.6203708331245;868.513632365874;868.991969315594;865.3164000439646;870.2211520688979;877.2937785083005;880.1858281089966;882.1178821178821;744.159100216757;758.6206896551724;925.4447331601053;925.9398139120935;930.7905721212741;908.4276905549527;931.9440833550009;932.9626814927428;934.9205317548017;935.4200395754608;702.3012102957539;702.4977141343912;704.5350068954466;704.6864145455274;705.7988473285089;14466.349014294383;14511.709765804624;14512.984091113627;14529.709405811931;14533.982621216519;12601.30692811895;12684.238945663197;12776.808347874789;13305.135166214164;13579.660508487366;10009.199264058858;10219;10339.793204135874;10571.365718056864;11001.889981100167;3980.9402858957137;4068.1456894052285;4069.877903662895;4074.979625101885;4076.470058892325;76191;77553;77638.22361776367;77732.8340074905;78445;9257.768555786159;9306.441613503212;9386.67146649864;9540.809183816285;9850.408975461352;17654.911725441547;19507.731997420124;20318;20358.79641203569;20385.694214586794;7399.85200295991;7617.200193979553;7622.2758837910305;7623.123340815877;7690.653920573588;4131.07050913542;4141.171765646883;4146.771927544014;4172.666186705056;4190.245755763992;3380.8309584521166;3413.880514182041;3415.077928959167;3421.418358878947;3423.0928803866996;621.9595726277778;628.0391001767304;631.6841579210395;647.3267801486495;650.9251436084816;539.9865003374869;555.9148650449961;591.7455494137477;636.9044643303449;661.2461793555351;8329.750107496784;8403.957980210182;8636.95681521601;9033.63865445388;9046.86429703555;484.6704241116075;592.1325258496323;606.6845240474928;634.3656343656344;663.2538394306405;3714.832832522543;3865.3622152344547;3904.2581909437117;4079;4279.251131052053;83298;83730.32539349301;90499.54750226207;90670.54664726766;90998;74064.62967685235;74598;75249.24750752532;76289.61855190799;77756.22243777603;49224;65143.34856651467;65253;65640;70847.6457617719;8717.564121793757;8732.519711415933;8799.780005499657;8841.778955526162;9095.727128186165;45349.54650453453;46212.844678883295;47562;47877.521224787306;49419.75290123526;63949.3605063962;64124;64792.676036619516;65703.34296656972;69253.30746692469;11069.557217711523;11071.72320691989;11085.889141108808;11117.444127793417;11464.197506174822;12079.51681932713;12083.697907552381;12449.564265250672;12611.117221794386;12897.677558061123;11598.826017609574;11740.941295293469;11843;11856.466459009538;12083.818742719042;11551.76896462083;11833.171677982458;11990.700232494257;12018.519259229533;12103.51585936588;11151.996320331209;11203.103751700008;11363.488643010918;11453.083753299883;11523.769524609294;9244.260459163384;9267.76830579241;9356.48539330316;9512.33413661037;9580.425174489554;9679.854802178113;9795.412275263507;9797.951010244904;9804.509774511389;9827.361221520578 13:06:56 INFO - PROCESS | 1679 | __end_tp_report 13:06:56 INFO - PROCESS | 1679 | __start_cc_report 13:06:56 INFO - PROCESS | 1679 | _x_x_mozilla_cycle_collect,1036 13:06:56 INFO - PROCESS | 1679 | __end_cc_report 13:06:56 INFO - PROCESS | 1679 | __startTimestamp1455311216772__endTimestamp 13:06:56 INFO - PROCESS | 1679 | 13:06:56 INFO - PROCESS | 1679 | ------- Summary: start ------- 13:06:56 INFO - PROCESS | 1679 | Number of tests: 6 13:06:56 INFO - PROCESS | 1679 | 13:06:56 INFO - PROCESS | 1679 | [#0] dojo.html Cycles:165 Average:5671.95 Median:5906.82 stddev:664.54 (11.3%) stddev-sans-first:624.54 13:06:56 INFO - PROCESS | 1679 | Values: 2706.5 3435.2 3447.8 3456.7 3510.3 5541.6 5634.4 5636.5 5650.1 5665.5 5653.2 5657.3 5674.0 5806.0 5810.1 5080.8 5084.4 5112.6 5134.9 5221.5 4019.9 5197.8 5214.7 5248.1 5253.4 5066.9 5107.2 5178.6 5180.2 5202.1 5174.8 5182.2 5184.3 5191.6 5199.0 4325.3 5109.4 5166.0 5167.7 5171.9 5471.3 5588.7 5607.5 5635.4 5702.9 6156.4 6161.0 6169.5 6177.5 6184.1 5238.3 6067.0 6205.5 6258.2 6281.9 5730.2 5735.9 5806.9 5829.4 5834.9 6340.3 6344.1 6344.7 6349.1 6352.2 6022.5 6026.2 6058.0 6083.5 6085.3 5108.2 6110.2 6127.7 6135.7 6155.5 6099.3 6103.6 6108.1 6129.8 6141.0 6094.1 6126.5 6176.4 6219.1 6235.7 4829.7 4831.2 4844.3 4867.3 4908.3 4241.0 4385.8 4392.8 4399.9 4431.2 5626.9 5629.6 5683.6 5684.9 5730.5 6223.4 6261.8 6285.5 6294.3 6300.8 5567.8 5652.7 5658.7 5670.6 5677.1 5150.6 5323.4 5346.9 5351.4 5355.3 6302.2 6349.2 6350.0 6352.8 6362.3 6115.4 6193.2 6217.3 6301.7 6311.1 5286.3 6293.9 6304.5 6328.4 6340.8 6009.5 6048.8 6057.8 6067.0 6074.9 6114.2 6123.8 6160.7 6164.0 6262.7 5841.9 6015.1 6049.8 6052.5 6113.8 5985.2 6013.7 6021.2 6034.5 6049.9 5839.6 5857.3 5907.2 5935.0 5965.5 5999.3 6035.3 6053.5 6056.1 6059.8 5793.9 5906.8 5921.4 5922.3 5961.9 13:06:56 INFO - PROCESS | 1679 | 13:06:56 INFO - PROCESS | 1679 | [#1] ext.html Cycles:180 Average:64687.83 Median:38744.21 stddev:136796.87 (353.1%) stddev-sans-first:137095.78 13:06:56 INFO - PROCESS | 1679 | Values: 518.7 559.4 565.3 580.4 598.6 30026.8 37889.4 38566.2 38740.8 38747.6 40835.0 41287.8 41313.8 41347.8 41353.8 9423.9 9639.0 9648.8 9652.1 9653.2 8424.0 9792.3 9795.7 9795.8 9817.6 9731.2 9817.4 9818.0 9819.3 9828.3 9726.0 9782.6 9817.1 9817.2 9835.5 8166.7 9351.6 9570.3 9586.7 9685.2 39426.8 39752.4 39849.8 39883.0 39946.0 3176.3 3210.4 3245.9 3273.0 3391.6 27784.6 28341.6 28605.7 28717.0 29113.9 2791.7 2858.1 2869.2 2873.9 2986.8 477438.0 479915.0 480479.6 481153.0 482035.0 56937.7 57906.8 57935.7 64667.0 66161.0 63818.0 63966.0 64077.0 64105.7 64106.8 13192.5 15729.0 15946.6 15951.4 15957.2 11451.8 11785.8 12087.2 12170.6 12179.2 20287.5 21059.1 21188.9 21595.7 21601.4 7529.5 8775.6 8931.4 8935.6 8981.4 956.6 969.5 977.6 982.3 1006.3 29584.7 29596.6 29662.6 29792.9 29822.0 1063.1 1076.9 1143.8 1210.7 1227.9 14314.3 14465.4 14531.0 14548.6 14609.2 537393.0 550276.0 552973.0 552990.0 556781.0 57178.0 57539.1 57562.7 57701.7 57706.7 1423.0 1434.2 1454.2 1459.3 1464.8 23210.8 26689.0 27246.0 28630.0 28963.3 50876.5 51374.5 51382.4 51401.5 51408.5 501237.0 506280.0 509528.0 509840.0 510578.0 27030.7 27861.9 28216.2 30105.0 30601.8 36910.8 39696.6 39819.0 40174.0 40679.0 28469.4 33771.0 33986.5 34846.0 34886.7 34140.0 34256.7 34298.7 34384.8 35924.6 30790.2 34754.0 35781.0 36841.4 36877.0 26013.9 28407.7 30493.8 30522.4 30876.7 23523.5 24445.4 24519.4 24598.4 24717.3 13:06:56 INFO - PROCESS | 1679 | 13:06:56 INFO - PROCESS | 1679 | [#2] jquery.html Cycles:180 Average:32858.51 Median:1585.60 stddev:102689.61 (6476.4%) stddev-sans-first:102948.57 13:06:56 INFO - PROCESS | 1679 | Values: 294.3 359.1 364.4 366.1 374.3 12585.5 15132.9 18965.7 19723.7 20300.0 18158.5 18498.4 18961.1 20392.7 20395.9 5584.9 5857.9 5859.1 5863.9 5865.8 4189.9 4388.5 5781.9 5929.2 6160.2 5124.5 6307.7 6388.3 6397.2 6414.0 6212.9 6352.8 6384.3 6387.6 6401.8 5293.9 5435.9 5456.9 5465.5 5491.0 23861.5 24410.0 25082.5 25198.5 25472.7 2284.9 2296.2 2346.5 2440.0 2876.8 13217.9 13257.5 14432.9 14482.7 14784.5 1758.6 1759.9 1796.5 1801.4 1861.2 73476.9 90922.5 91821.5 92091.0 93241.1 8604.8 10259.8 10675.4 10711.6 10769.5 12755.0 12888.5 12910.9 12920.2 12969.7 6878.8 8408.9 8442.6 8462.3 8531.2 8533.2 8536.1 8546.0 8624.8 8633.0 6096.0 6175.8 6197.3 6211.2 6300.2 1645.4 1735.6 1736.0 1834.1 1834.5 893.8 917.2 949.9 980.3 997.7 15781.9 18029.3 18837.1 20272.3 20370.4 880.8 962.1 1005.8 1015.5 1019.8 10836.5 10973.3 11068.9 11084.0 11093.1 545531.0 551326.0 552801.0 719604.5 727378.0 78627.6 83807.0 92613.5 93021.5 94612.0 997.4 1141.2 1150.6 1153.7 1154.6 14270.9 14728.5 18647.7 18949.1 19197.8 46364.3 46833.8 46875.1 46889.8 47575.6 52030.0 64956.0 65910.4 66268.7 66549.7 6393.7 7383.8 7555.4 7568.1 7599.1 12067.0 12081.8 12195.6 12218.1 12234.1 10429.6 10603.6 10690.0 10762.9 10865.4 10365.8 10562.6 10598.3 10757.4 10760.3 10864.9 10939.4 10947.8 10971.0 11177.0 7484.5 7551.5 7556.8 7593.9 7617.0 10535.5 10597.0 10698.8 10729.7 10965.5 13:06:56 INFO - PROCESS | 1679 | 13:06:56 INFO - PROCESS | 1679 | [#3] mootools.html Cycles:180 Average:6016.22 Median:5441.75 stddev:3141.04 (57.7%) stddev-sans-first:3130.55 13:06:56 INFO - PROCESS | 1679 | Values: 1383.5 1521.6 1541.3 1765.9 1920.9 7768.4 8466.2 8624.4 8628.7 8635.5 8277.6 8557.8 8559.7 8572.0 8580.5 2170.4 2234.9 2410.6 2425.9 2449.2 2456.4 2492.4 2496.7 2499.5 2502.5 2430.7 2448.6 2457.7 2459.7 2464.5 2403.5 2426.8 2450.8 2451.0 2451.6 2442.6 2443.1 2443.4 2472.6 2472.7 8594.9 8608.4 8681.7 8685.6 8693.7 5292.6 5429.5 5466.1 5466.4 5469.7 3439.8 3495.7 3539.1 3547.8 3555.0 886.9 971.0 982.4 1003.1 1007.9 11565.8 11594.8 11606.2 11607.8 11608.2 4833.3 4840.3 4919.0 4920.0 4933.2 10008.1 10012.1 10014.8 10016.7 10029.4 5431.8 5433.4 5440.3 5443.2 5448.0 4890.7 4935.8 4943.2 4944.6 4946.4 3582.2 3921.9 3946.3 3970.6 3993.9 1228.8 1314.7 1315.1 1327.5 1332.0 1081.1 1103.6 1105.4 1258.0 1356.9 7988.7 8008.5 8009.8 8045.8 8210.0 1171.8 1172.4 1177.5 1182.3 1193.4 6295.3 6322.0 6387.0 6387.6 6405.5 10396.2 10676.4 10750.5 10752.1 10868.2 9726.6 10595.7 10717.7 10724.5 10749.9 7931.3 8041.6 8069.4 8128.3 8144.8 7879.8 7941.7 7984.4 8011.2 8024.6 9316.9 9324.0 9415.0 9434.3 9481.1 9436.6 9775.8 9821.3 9843.8 9870.0 6744.5 6955.2 7143.4 7373.4 7388.4 8069.6 8073.0 8123.0 8124.7 8141.1 7333.8 7581.0 7670.6 7706.3 7710.4 7413.2 7487.7 7489.6 7596.9 7617.9 7579.2 7602.7 7671.5 7676.2 7688.9 6816.9 6943.6 6951.2 6956.0 6964.8 7107.0 7147.3 7189.7 7199.6 7205.4 13:06:56 INFO - PROCESS | 1679 | 13:06:56 INFO - PROCESS | 1679 | [#4] prototype.html Cycles:180 Average:5717.63 Median:6534.13 stddev:1844.02 (28.2%) stddev-sans-first:1804.17 13:06:56 INFO - PROCESS | 1679 | Values: 321.6 331.1 334.6 334.8 337.8 6410.6 6521.3 6549.5 6553.3 6667.3 6322.4 6529.2 6570.3 6571.9 6582.4 4884.1 4893.4 4899.9 4900.9 4907.5 4660.4 4736.6 4783.9 4828.3 4910.7 3958.6 4249.3 4721.2 4754.2 4788.6 4417.6 4775.9 4779.0 4782.0 4789.6 4147.1 4149.8 4153.6 4155.8 4161.1 6103.8 6316.7 6334.3 6349.3 6368.7 5770.2 5774.1 5774.5 5776.4 5779.9 5641.8 6954.2 6954.9 6970.0 6977.3 4352.6 4538.4 4542.7 4689.2 4695.2 7371.9 7441.0 7447.6 7454.4 7456.5 4362.9 4629.7 4630.0 4634.2 4656.1 4474.9 4548.3 4554.6 4563.2 4741.9 5529.3 5558.9 5567.7 5567.9 5585.5 5761.3 6987.4 7046.7 7063.3 7065.4 1586.9 1614.3 1624.4 1633.1 1636.6 1029.8 1039.5 1041.5 1055.9 1056.0 6539.1 6541.9 6544.3 6553.7 6575.6 7323.2 7324.4 7331.6 7341.6 7342.1 6445.7 6528.9 6542.9 6710.8 6713.2 3018.0 3832.4 3841.9 3852.0 3853.5 7548.7 7551.0 7551.9 7552.5 7573.4 7280.2 7415.3 7488.0 7493.8 7504.2 6015.0 7562.2 7562.4 7562.5 7567.6 7246.5 7250.2 7254.8 7256.4 7262.7 5806.6 6883.0 7120.4 7129.9 7136.0 7523.6 7528.2 7528.8 7528.8 7542.9 4393.4 4482.9 4490.1 4611.2 4613.4 6967.1 7030.4 7177.6 7330.5 7367.9 7079.3 7105.8 7111.4 7115.3 7123.1 6878.6 7062.2 7092.8 7105.2 7109.0 5656.4 6915.2 6920.3 6921.1 6935.7 6786.3 7035.7 7079.0 7083.1 7101.6 6933.6 6933.9 6939.9 6941.2 6949.5 13:06:56 INFO - PROCESS | 1679 | 13:06:56 INFO - PROCESS | 1679 | [#5] yui.html Cycles:180 Average:17724.33 Median:635.64 stddev:24371.95 (3834.3%) stddev-sans-first:24406.65 13:06:56 INFO - PROCESS | 1679 | Values: 663.7 680.7 711.2 750.4 757.6 14877.1 15098.5 15104.8 15115.5 15132.0 13639.6 13707.3 13738.8 13742.9 13760.2 700.3 715.8 843.6 868.5 869.0 865.3 870.2 877.3 880.2 882.1 744.2 758.6 925.4 925.9 930.8 908.4 931.9 933.0 934.9 935.4 702.3 702.5 704.5 704.7 705.8 14466.3 14511.7 14513.0 14529.7 14534.0 12601.3 12684.2 12776.8 13305.1 13579.7 10009.2 10219.0 10339.8 10571.4 11001.9 3980.9 4068.1 4069.9 4075.0 4076.5 76191.0 77553.0 77638.2 77732.8 78445.0 9257.8 9306.4 9386.7 9540.8 9850.4 17654.9 19507.7 20318.0 20358.8 20385.7 7399.9 7617.2 7622.3 7623.1 7690.7 4131.1 4141.2 4146.8 4172.7 4190.2 3380.8 3413.9 3415.1 3421.4 3423.1 622.0 628.0 631.7 647.3 650.9 540.0 555.9 591.7 636.9 661.2 8329.8 8404.0 8637.0 9033.6 9046.9 484.7 592.1 606.7 634.4 663.3 3714.8 3865.4 3904.3 4079.0 4279.3 83298.0 83730.3 90499.5 90670.5 90998.0 74064.6 74598.0 75249.2 76289.6 77756.2 49224.0 65143.3 65253.0 65640.0 70847.6 8717.6 8732.5 8799.8 8841.8 9095.7 45349.5 46212.8 47562.0 47877.5 49419.8 63949.4 64124.0 64792.7 65703.3 69253.3 11069.6 11071.7 11085.9 11117.4 11464.2 12079.5 12083.7 12449.6 12611.1 12897.7 11598.8 11740.9 11843.0 11856.5 12083.8 11551.8 11833.2 11990.7 12018.5 12103.5 11152.0 11203.1 11363.5 11453.1 11523.8 9244.3 9267.8 9356.5 9512.3 9580.4 9679.9 9795.4 9798.0 9804.5 9827.4 13:06:56 INFO - PROCESS | 1679 | -------- Summary: end -------- 13:06:56 INFO - PROCESS | 1679 | 13:06:57 INFO - TEST-INFO | 1679: exit 0 13:06:57 INFO - TEST-OK | dromaeo_css | took 1113343ms 13:06:57 INFO - TEST-START | kraken 13:06:57 INFO - operating with platform_type : mac_ 13:06:57 INFO - Initialising browser for kraken test... 13:06:57 INFO - TEST-INFO | started process 1685 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/tmpVcap3n/profile http://localhost:49274/getInfo.html) 13:06:59 INFO - PROCESS | 1685 | __metrics Screen width/height:1600/1200 13:06:59 INFO - PROCESS | 1685 | colorDepth:24 13:06:59 INFO - PROCESS | 1685 | Browser inner width/height: 1024/689 13:06:59 INFO - PROCESS | 1685 | __metrics 13:06:59 INFO - PROCESS | 1685 | 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" 13:06:59 INFO - PROCESS | 1685 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:07:00 INFO - TEST-INFO | 1685: exit 0 13:07:00 INFO - Browser initialized. 13:07:00 INFO - Running cycle 1/1 for kraken test... 13:07:00 INFO - TEST-INFO | started process 1687 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/tmpVcap3n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:07:12 INFO - PROCESS | 1687 | RSS: Main: 247013376 13:07:12 INFO - PROCESS | 1687 | 13:07:14 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 13:07:15 INFO - PROCESS | 1687 | RSS: Main: 292339712 13:07:15 INFO - PROCESS | 1687 | 13:07:17 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 13:07:18 INFO - PROCESS | 1687 | RSS: Main: 302751744 13:07:18 INFO - PROCESS | 1687 | 13:07:21 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 13:07:22 INFO - PROCESS | 1687 | RSS: Main: 288731136 13:07:22 INFO - PROCESS | 1687 | 13:07:24 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 13:07:24 INFO - PROCESS | 1687 | RSS: Main: 291233792 13:07:24 INFO - PROCESS | 1687 | 13:07:26 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:07:27 INFO - PROCESS | 1687 | RSS: Main: 290783232 13:07:27 INFO - PROCESS | 1687 | 13:07:30 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 13:07:30 INFO - PROCESS | 1687 | RSS: Main: 290996224 13:07:30 INFO - PROCESS | 1687 | 13:07:33 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 13:07:34 INFO - PROCESS | 1687 | RSS: Main: 289742848 13:07:34 INFO - PROCESS | 1687 | 13:07:37 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 13:07:37 INFO - PROCESS | 1687 | RSS: Main: 291414016 13:07:37 INFO - PROCESS | 1687 | 13:07:39 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:07:39 INFO - PROCESS | 1687 | RSS: Main: 322940928 13:07:39 INFO - PROCESS | 1687 | 13:07:41 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:07:42 INFO - PROCESS | 1687 | RSS: Main: 323809280 13:07:42 INFO - PROCESS | 1687 | 13:07:44 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:07:45 INFO - PROCESS | 1687 | RSS: Main: 332722176 13:07:45 INFO - PROCESS | 1687 | 13:07:47 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:07:48 INFO - PROCESS | 1687 | RSS: Main: 334536704 13:07:48 INFO - PROCESS | 1687 | 13:07:50 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:07:51 INFO - PROCESS | 1687 | RSS: Main: 335192064 13:07:51 INFO - PROCESS | 1687 | 13:07:53 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 13:07:53 INFO - PROCESS | 1687 | RSS: Main: 395706368 13:07:53 INFO - PROCESS | 1687 | 13:07:53 INFO - PROCESS | 1687 | __start_tp_report 13:07:53 INFO - PROCESS | 1687 | _x_x_mozilla_page_load 13:07:53 INFO - PROCESS | 1687 | _x_x_mozilla_page_load_details 13:07:53 INFO - PROCESS | 1687 | |i|pagename|runs| 13:07:53 INFO - PROCESS | 1687 | |0;ai-astar;112;108;112;112;110;113;116;113;113;112 13:07:53 INFO - PROCESS | 1687 | |1;audio-beat-detection;159;122;145;155;118;144;140;121;158;121 13:07:53 INFO - PROCESS | 1687 | |2;audio-dft;186;186;196;187;188;186;186;186;208;260 13:07:53 INFO - PROCESS | 1687 | |3;audio-fft;81;74;74;111;55;57;57;58;115;55 13:07:53 INFO - PROCESS | 1687 | |4;audio-oscillator;92;97;127;78;81;86;112;77;77;113 13:07:53 INFO - PROCESS | 1687 | |5;imaging-gaussian-blur;84;89;84;89;83;89;83;90;85;140 13:07:53 INFO - PROCESS | 1687 | |6;imaging-darkroom;93;93;94;93;93;93;93;93;92;93 13:07:53 INFO - PROCESS | 1687 | |7;imaging-desaturate;87;91;85;88;88;89;106;136;143;85 13:07:53 INFO - PROCESS | 1687 | |8;json-parse-financial;55;52;53;52;54;52;51;62;51;51 13:07:53 INFO - PROCESS | 1687 | |9;json-stringify-tinderbox;61;63;68;62;67;74;68;66;66;66 13:07:53 INFO - PROCESS | 1687 | |10;stanford-crypto-aes;82;83;79;98;105;106;108;83;85;83 13:07:53 INFO - PROCESS | 1687 | |11;stanford-crypto-ccm;125;125;133;125;135;129;127;116;124;122 13:07:53 INFO - PROCESS | 1687 | |12;stanford-crypto-pbkdf2;137;127;170;121;160;171;175;138;136;138 13:07:53 INFO - PROCESS | 1687 | |13;stanford-crypto-sha256-iterative;67;66;66;67;67;69;66;67;66;67 13:07:53 INFO - PROCESS | 1687 | __end_tp_report 13:07:53 INFO - PROCESS | 1687 | __start_cc_report 13:07:53 INFO - PROCESS | 1687 | _x_x_mozilla_cycle_collect,1187 13:07:53 INFO - PROCESS | 1687 | __end_cc_report 13:07:53 INFO - PROCESS | 1687 | __startTimestamp1455311273459__endTimestamp 13:07:53 INFO - PROCESS | 1687 | 13:07:53 INFO - PROCESS | 1687 | ------- Summary: start ------- 13:07:53 INFO - PROCESS | 1687 | Number of tests: 14 13:07:53 INFO - PROCESS | 1687 | 13:07:53 INFO - PROCESS | 1687 | [#0] ai-astar Cycles:10 Average:112.10 Median:112.50 stddev:2.08 (1.8%) stddev-sans-first:2.20 13:07:53 INFO - PROCESS | 1687 | Values: 112.0 108.0 112.0 112.0 110.0 113.0 116.0 113.0 113.0 112.0 13:07:53 INFO - PROCESS | 1687 | 13:07:53 INFO - PROCESS | 1687 | [#1] audio-beat-detection Cycles:10 Average:138.30 Median:144.50 stddev:16.51 (11.4%) stddev-sans-first:15.72 13:07:53 INFO - PROCESS | 1687 | Values: 159.0 122.0 145.0 155.0 118.0 144.0 140.0 121.0 158.0 121.0 13:07:53 INFO - PROCESS | 1687 | 13:07:53 INFO - PROCESS | 1687 | [#2] audio-dft Cycles:10 Average:196.90 Median:187.50 stddev:23.28 (12.4%) stddev-sans-first:24.35 13:07:53 INFO - PROCESS | 1687 | Values: 186.0 186.0 196.0 187.0 188.0 186.0 186.0 186.0 208.0 260.0 13:07:53 INFO - PROCESS | 1687 | 13:07:53 INFO - PROCESS | 1687 | [#3] audio-fft Cycles:10 Average:73.70 Median:57.50 stddev:22.74 (39.5%) stddev-sans-first:23.97 13:07:53 INFO - PROCESS | 1687 | Values: 81.0 74.0 74.0 111.0 55.0 57.0 57.0 58.0 115.0 55.0 13:07:53 INFO - PROCESS | 1687 | 13:07:53 INFO - PROCESS | 1687 | [#4] audio-oscillator Cycles:10 Average:94.00 Median:79.50 stddev:17.81 (22.4%) stddev-sans-first:18.87 13:07:53 INFO - PROCESS | 1687 | Values: 92.0 97.0 127.0 78.0 81.0 86.0 112.0 77.0 77.0 113.0 13:07:53 INFO - PROCESS | 1687 | 13:07:53 INFO - PROCESS | 1687 | [#5] imaging-gaussian-blur Cycles:10 Average:91.60 Median:87.00 stddev:17.23 (19.8%) stddev-sans-first:18.06 13:07:53 INFO - PROCESS | 1687 | Values: 84.0 89.0 84.0 89.0 83.0 89.0 83.0 90.0 85.0 140.0 13:07:53 INFO - PROCESS | 1687 | 13:07:53 INFO - PROCESS | 1687 | [#6] imaging-darkroom Cycles:10 Average:93.00 Median:93.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 13:07:53 INFO - PROCESS | 1687 | Values: 93.0 93.0 94.0 93.0 93.0 93.0 93.0 93.0 92.0 93.0 13:07:53 INFO - PROCESS | 1687 | 13:07:53 INFO - PROCESS | 1687 | [#7] imaging-desaturate Cycles:10 Average:99.80 Median:87.50 stddev:21.83 (25.0%) stddev-sans-first:22.66 13:07:53 INFO - PROCESS | 1687 | Values: 87.0 91.0 85.0 88.0 88.0 89.0 106.0 136.0 143.0 85.0 13:07:53 INFO - PROCESS | 1687 | 13:07:53 INFO - PROCESS | 1687 | [#8] json-parse-financial Cycles:10 Average:53.30 Median:52.50 stddev:3.33 (6.4%) stddev-sans-first:3.48 13:07:53 INFO - PROCESS | 1687 | Values: 55.0 52.0 53.0 52.0 54.0 52.0 51.0 62.0 51.0 51.0 13:07:53 INFO - PROCESS | 1687 | 13:07:53 INFO - PROCESS | 1687 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:66.50 stddev:3.70 (5.6%) stddev-sans-first:3.43 13:07:53 INFO - PROCESS | 1687 | Values: 61.0 63.0 68.0 62.0 67.0 74.0 68.0 66.0 66.0 66.0 13:07:53 INFO - PROCESS | 1687 | 13:07:53 INFO - PROCESS | 1687 | [#10] stanford-crypto-aes Cycles:10 Average:91.20 Median:83.00 stddev:11.60 (14.0%) stddev-sans-first:11.82 13:07:53 INFO - PROCESS | 1687 | Values: 82.0 83.0 79.0 98.0 105.0 106.0 108.0 83.0 85.0 83.0 13:07:53 INFO - PROCESS | 1687 | 13:07:53 INFO - PROCESS | 1687 | [#11] stanford-crypto-ccm Cycles:10 Average:126.10 Median:126.00 stddev:5.40 (4.3%) stddev-sans-first:5.72 13:07:53 INFO - PROCESS | 1687 | Values: 125.0 125.0 133.0 125.0 135.0 129.0 127.0 116.0 124.0 122.0 13:07:53 INFO - PROCESS | 1687 | 13:07:53 INFO - PROCESS | 1687 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.30 Median:149.00 stddev:19.77 (13.3%) stddev-sans-first:20.61 13:07:53 INFO - PROCESS | 1687 | Values: 137.0 127.0 170.0 121.0 160.0 171.0 175.0 138.0 136.0 138.0 13:07:53 INFO - PROCESS | 1687 | 13:07:53 INFO - PROCESS | 1687 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:0.92 (1.4%) stddev-sans-first:0.97 13:07:53 INFO - PROCESS | 1687 | Values: 67.0 66.0 66.0 67.0 67.0 69.0 66.0 67.0 66.0 67.0 13:07:53 INFO - PROCESS | 1687 | -------- Summary: end -------- 13:07:53 INFO - PROCESS | 1687 | 13:07:54 INFO - TEST-INFO | 1687: exit 0 13:07:54 INFO - TEST-OK | kraken | took 57002ms 13:07:54 INFO - SUITE-END | took 1170s 13:07:54 INFO - Completed test suite (00:19:30) 13:07:54 INFO - Working with test: dromaeo_css 13:07:54 INFO - Generating results file: dromaeo_css 13:07:54 INFO - Working with test: kraken 13:07:54 INFO - Generating results file: kraken 13:07:54 INFO - javascript benchmark 13:07:54 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:07:55 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 13:07:55 INFO - process_Request line: dromaeo_css 7465.97 graph.html#tests=[[72,64,59]] 13:07:55 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:07:55 INFO - process_Request line: kraken 1450.20 graph.html#tests=[[232,64,59]] 13:07:55 INFO - RETURN: dromaeo_css: 7465.97 13:07:55 INFO - RETURN: kraken: 1450.20 13:07:55 INFO - javascript benchmark 13:07:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2706.472237913607, 3435.209901722605, 3447.82760861957, 3456.6716161964614, 3510.3330367230224, 5541.5843811714185, 5634.436556344363, 5636.4927156555905, 5650.124230744231, 5665.518430933371, 5653.236813030239, 5657.264555607765, 5674.035413979623, 5805.970970145154, 5810.128480727893, 5080.771365288552, 5084.44071152172, 5112.642115051948, 5134.897302053957, 5221.477852214767, 4019.879403617896, 5197.766100525467, 5214.713190774525, 5248.0815857225025, 5253.4221235664045, 5066.923996140061, 5107.157319042353, 5178.5857131429775, 5180.197069454241, 5202.115640341132, 5174.818881339135, 5182.222666600002, 5184.274201611777, 5191.636585439021, 5198.960207958424, 4325.286327755916, 5109.3613298337705, 5166.044281807877, 5167.741612919339, 5171.870703232412, 5471.316085489314, 5588.748506317185, 5607.523360514361, 5635.351934527541, 5702.914456283118, 6156.445919867188, 6161.014237721988, 6169.475594574466, 6177.474914632262, 6184.134221209034, 5238.319018527605, 6067.022556241486, 6205.503559715212, 6258.186435763367, 6281.8743625127245, 5730.226419433365, 5735.885282294373, 5806.88386232273, 5829.358770535237, 5834.8541286467325, 6340.270868850049, 6344.143540622049, 6344.746210151635, 6349.142865713162, 6352.237731472253, 6022.488088512438, 6026.156338112668, 6058.0, 6083.482903953213, 6085.300190478151, 5108.157154069611, 6110.236220472441, 6127.739336776432, 6135.661410523283, 6155.538334624921, 6099.298580663191, 6103.572749907553, 6108.144859719643, 6129.785457508966, 6141.048137538689, 6094.078451592408, 6126.517673797278, 6176.3514830943, 6219.129321894848, 6235.719392627343, 4829.66192366531, 4831.178699621073, 4844.32179494871, 4867.294242334841, 4908.337374454474, 4240.957590424118, 4385.758783266887, 4392.758398288125, 4399.890002749957, 4431.180231657154, 5626.943730562642, 5629.605927585029, 5683.602147849693, 5684.914726279109, 5730.541556675456, 6223.408776166257, 6261.812145635638, 6285.465735412449, 6294.307626161119, 6300.842478938063, 5567.777288908479, 5652.66084034951, 5658.688772117573, 5670.603057785916, 5677.148427735872, 5150.639455238173, 5323.3611966563485, 5346.946530534723, 5351.411344752074, 5355.30381050461, 6302.243730752339, 6349.206349206349, 6349.999999999907, 6352.841178970562, 6362.300146983828, 6115.422885572139, 6193.225846769154, 6217.253929528486, 6301.747930082929, 6311.116443697794, 5286.259923610621, 6293.905591416224, 6304.495640348853, 6328.367163283635, 6340.778072767431, 6009.519238461, 6048.818535443944, 6057.818265452043, 6066.969665151646, 6074.939250607437, 6114.205153330038, 6123.770712314271, 6160.722767475385, 6164.0, 6262.74949002053, 5841.912371314519, 6015.075101140845, 6049.818505444844, 6052.546059045677, 6113.755449781959, 5985.191999080069, 6013.669248191217, 6021.217241758543, 6034.456898879122, 6049.939500605114, 5839.5912286141265, 5857.297124345106, 5907.172995780508, 5935.0, 5965.463108320272, 5999.250093738283, 6035.336113027652, 6053.485453736482, 6056.121862330026, 6059.757609695739, 5793.884122317614, 5906.822795316148, 5921.3782552831335, 5922.318933322551, 5961.940380596138], "unit": "score", "name": "dojo.html", "value": 5629.13772864121}, {"lowerIsBetter": false, "replicates": [518.7017464957651, 559.4321763410138, 565.3357305166434, 580.3760956971257, 598.5570677698503, 30026.849865750668, 37889.43165852514, 38566.22867542647, 38740.80629596852, 38747.612523874755, 40834.97912552187, 41287.79356103215, 41313.83577052868, 41347.79326103373, 41353.79323103388, 9423.858642120374, 9639.0, 9648.80702385952, 9652.131308182263, 9653.22774178064, 8424.0, 9792.265580081486, 9795.657151999681, 9795.755106122333, 9817.607295708163, 9731.172850307732, 9817.361871478366, 9818.0, 9819.263555233387, 9828.312018158731, 9726.0, 9782.5597848097, 9817.067378599057, 9817.165540929029, 9835.508224588742, 8166.67333306667, 9351.625934962662, 9570.282228832866, 9586.6644667437, 9685.176759975411, 39426.81719548418, 39752.40371394432, 39849.80075099635, 39883.0, 39946.0, 3176.269458024667, 3210.406074876132, 3245.902622921316, 3273.0, 3391.6438773928876, 27784.58323125155, 28341.57487637687, 28605.71394286051, 28716.994905178217, 29113.854430727923, 2791.6929137794828, 2858.0533370511253, 2869.196624945019, 2873.8563071846534, 2986.7909246352765, 477438.0, 479915.0, 480479.59760201327, 481153.0, 482035.0, 56937.71531142318, 57906.8418631625, 57935.710321448125, 64667.0, 66161.0, 63818.0427293591, 63966.0, 64077.0, 64105.67947160234, 64106.75626353055, 13192.472301107848, 15729.0, 15946.60133496672, 15951.441699540692, 15957.20213989296, 11451.770964580663, 11785.823212651818, 12087.153899227145, 12170.57402990891, 12179.208351457128, 20287.492812679506, 21059.052342644616, 21188.94055297229, 21595.67606485904, 21601.351959441243, 7529.4729368943645, 8775.648974040967, 8931.374803763803, 8935.642574297086, 8981.416207946462, 956.5695437053215, 969.4910172159532, 977.6431602465049, 982.2976571751232, 1006.3006210683651, 29584.704152958624, 29596.573007464107, 29662.55506167409, 29792.851035744683, 29822.0, 1063.1069901282806, 1076.9407682577378, 1143.8284257361297, 1210.6852218423098, 1227.858796238444, 14314.284285785669, 14465.421383144767, 14531.0, 14548.563543093724, 14609.196494192922, 537393.0, 550276.0, 552973.0, 552990.0, 556781.0, 57178.0, 57539.13691294634, 57562.7121864388, 57701.71149144227, 57706.7114664424, 1422.9644258893404, 1434.2326855132662, 1454.2074569359725, 1459.306829256095, 1464.816897887764, 23210.767892320862, 26689.0, 27246.0, 28630.0, 28963.275918102216, 50876.473705788885, 51374.486255138465, 51382.43087845518, 51401.48598514117, 51408.485915141864, 501237.0, 506280.0, 509528.0, 509840.0, 510578.0, 27030.729692703608, 27861.860690696416, 28216.15351539457, 30105.0, 30601.846990764905, 36910.815445923676, 39696.60303396929, 39819.00452488711, 40174.0, 40678.983025424604, 28469.43061138724, 33771.0, 33986.490202647474, 34846.0, 34886.65113348936, 34140.0, 34256.657433425346, 34298.65701342955, 34384.82807585946, 35924.64075359213, 30790.230244244074, 34754.0, 35781.0, 36841.447378289886, 36877.0, 26013.869930650224, 28407.715922840507, 30493.847530762203, 30522.389552209275, 30876.69123308828, 23523.50810598621, 24445.38886527851, 24519.437830130897, 24598.385040374134, 24717.25848224556], "unit": "score", "name": "ext.html", "value": 19410.671812275217}, {"lowerIsBetter": false, "replicates": [294.3494876323325, 359.12373807908705, 364.3587286375977, 366.0555766123402, 374.2776441467969, 12585.496580136807, 15132.924335378308, 18965.715514267296, 19723.704144437826, 20300.0, 18158.546036349097, 18498.445046648623, 18961.051947402644, 20392.694109588367, 20395.898020509914, 5584.86037849054, 5857.853553661172, 5859.0625499920025, 5863.941360586382, 5865.824025279248, 4189.895252618694, 4388.517263101056, 5781.913271300934, 5929.169916211734, 6160.1991741073825, 5124.461931497195, 6307.653079080649, 6388.265349484822, 6397.232332120152, 6414.037894315843, 6212.87574248517, 6352.841178970517, 6384.265809431882, 6387.616742995435, 6401.839954001164, 5293.86765330866, 5435.891282174374, 5456.890862182734, 5465.535429488498, 5490.984167928906, 23861.52276954451, 24410.0, 25082.498350032896, 25198.496030079477, 25472.74527254722, 2284.8743319117443, 2296.184854376689, 2346.495503466746, 2440.0, 2876.8492602958986, 13217.933910330483, 13257.526812249649, 14432.927835360755, 14482.710345793024, 14784.482543111048, 1758.5515693498076, 1759.9296028158858, 1796.4790210838842, 1801.3813238265864, 1861.153175305233, 73476.89784653235, 90922.54538727264, 91821.54089229644, 92091.0, 93241.06758932392, 8604.78488037804, 10259.846102308471, 10675.412852293042, 10711.62583786105, 10769.515371808131, 12755.0, 12888.484460621657, 12910.9354453229, 12920.160189587647, 12969.740605187844, 6878.759243426456, 8408.915910840935, 8442.577871106543, 8462.323014158852, 8531.189536993976, 8533.232009119209, 8536.061033286334, 8546.0, 8624.827503449897, 8633.0, 6095.969520152371, 6175.84560385994, 6197.318294987548, 6211.16149319845, 6300.21247344082, 1645.4323258475806, 1735.5921358480748, 1736.0, 1834.1012903677101, 1834.5321942904475, 893.7542175901549, 917.2111983694018, 949.928755343352, 980.3333733061444, 997.6907158780801, 15781.921090394704, 18029.27882884696, 18837.05814709259, 20272.290469833486, 20370.388888333375, 880.8326417980692, 962.0571839597234, 1005.7535903703639, 1015.5024038221219, 1019.7807471393686, 10836.512356943957, 10973.286736362112, 11068.944655276671, 11084.002439780297, 11093.1125509959, 545531.0, 551326.0, 552801.0, 719604.4862164141, 727378.0, 78627.60686196532, 83807.0, 92613.5369323149, 93021.5348923251, 94612.0, 997.4115271989416, 1141.2068612314529, 1150.551284998851, 1153.700037990112, 1154.5670373609896, 14270.928645356707, 14728.484503042342, 18647.720284195475, 18949.0525473723, 19197.84812911174, 46364.30453543267, 46833.765831171986, 46875.062498750514, 46889.76555117202, 47575.57273281668, 52030.0, 64956.0256596142, 65910.35224119436, 66268.6686566564, 66549.66725166343, 6393.7122829471855, 7383.8154046149275, 7555.395568354628, 7568.129665088585, 7599.126100498514, 12067.0, 12081.758364832478, 12195.573154939535, 12218.083643726579, 12234.143609947218, 10429.634962776267, 10603.628872989408, 10690.037896589345, 10762.892371076188, 10865.402402867918, 10365.844512332473, 10562.577496900038, 10598.287195768213, 10757.354558726502, 10760.300580462244, 10864.945675271889, 10939.398333091438, 10947.83578246343, 10971.01260886524, 11177.0, 7484.513506622052, 7551.471397002157, 7556.811079723051, 7593.8860917087395, 7617.0, 10535.4732263385, 10597.0, 10698.839517407401, 10729.678109656723, 10965.50655220533], "unit": "score", "name": "jquery.html", "value": 9225.679851540737}, {"lowerIsBetter": false, "replicates": [1383.5434306678796, 1521.6272013356727, 1541.2601951063486, 1765.858731301496, 1920.9231630734762, 7768.378529717623, 8466.153384661531, 8624.35317351198, 8628.697995570155, 8635.481871087739, 8277.627506762195, 8557.786055348619, 8559.657613695445, 8571.95714021429, 8580.485170889735, 2170.435686721448, 2234.8770817605027, 2410.590199666061, 2425.8908349124285, 2449.2284930247006, 2456.435019945414, 2492.389364605665, 2496.700395952488, 2499.462615537659, 2502.5245203411387, 2430.684011078566, 2448.6327050942323, 2457.7173625033083, 2459.7048354197523, 2464.507098580282, 2403.5433267679173, 2426.8058555315533, 2450.791682706972, 2450.963235551468, 2451.5832308507597, 2442.5969714997004, 2443.1204766284122, 2443.389152711822, 2472.5549401107974, 2472.7279999200073, 8594.914050859536, 8608.39741218115, 8681.739547813513, 8685.565721713889, 8693.695720649746, 5292.57659387252, 5429.53848922842, 5466.125419932791, 5466.371367292772, 5469.699166545838, 3439.7764145330725, 3495.7378196635354, 3539.1329124364697, 3547.840347184357, 3555.0, 886.8692417168098, 971.0, 982.415462799633, 1003.0821798054772, 1007.89417111203, 11565.768684626344, 11594.768104637944, 11606.24559403636, 11607.825882611767, 11608.24546404481, 4833.275008748716, 4840.29815676732, 4918.975405123023, 4920.0, 4933.210686290176, 10008.14930730896, 10012.098911098035, 10014.79970400588, 10016.699499015042, 10029.398236105857, 5431.782728690808, 5433.402325744165, 5440.265564148789, 5443.237946687467, 5447.972760136174, 4890.657653964188, 4935.777889994959, 4943.184374578154, 4944.60443164546, 4946.356973593482, 3582.158192824684, 3921.9215615687526, 3946.309395855714, 3970.642642162219, 3993.940090898639, 1228.834107395508, 1314.737052589486, 1315.1385842273326, 1327.502186679995, 1331.9866801331862, 1081.0702795595782, 1103.591671081689, 1105.4141305108305, 1257.9874201257871, 1356.8643135686352, 7988.680452781824, 8008.479448835807, 8009.759707208793, 8045.758627241192, 8210.01479822425, 1171.8183681529376, 1172.4489489939715, 1177.4583691502005, 1182.3319824299244, 1193.4152265389896, 6295.276043254993, 6322.0, 6387.041943708481, 6387.648679322682, 6405.455536279375, 10396.22028347877, 10676.359418434919, 10750.462476876124, 10752.139828813677, 10868.239223254455, 9726.61093556264, 10595.735106622396, 10717.678469645924, 10724.517396717167, 10749.925007499187, 7931.286184243446, 8041.597920103972, 8069.394795390369, 8128.268455839003, 8144.83710325802, 7879.84240315202, 7941.722039728582, 7984.361251100015, 8011.238932301422, 8024.638891249791, 9316.860247096163, 9324.0, 9415.0, 9434.339596228197, 9481.146696797045, 9436.575354108943, 9775.755606109904, 9821.312508124363, 9843.803123937625, 9869.950650246703, 6744.527883048139, 6955.1653801544135, 7143.428525717826, 7373.410127189919, 7388.445866559922, 8069.636866340911, 8073.0, 8123.0, 8124.67501299965, 8141.104478507241, 7333.816654583678, 7581.0, 7670.616469176631, 7706.306432420884, 7710.421718371257, 7413.221611730691, 7487.700491980259, 7489.588072656056, 7596.924030759622, 7617.923820761722, 7579.204183560647, 7602.695892164252, 7671.53970761756, 7676.15562288159, 7688.923110768821, 6816.931830681629, 6943.618101004493, 6951.2353641098425, 6956.0, 6964.756233531802, 7107.040549525748, 7147.285271473019, 7189.7483588074165, 7199.640017999184, 7205.378789772469], "unit": "score", "name": "mootools.html", "value": 4904.650684498187}, {"lowerIsBetter": false, "replicates": [321.6349443381761, 331.10931594012106, 334.5767603980964, 334.80581262867537, 337.8429030500818, 6410.647414392218, 6521.315261897504, 6549.508786840988, 6553.27913929468, 6667.33326667333, 6322.399372059647, 6529.183852018497, 6570.342965703439, 6571.901421478682, 6582.3746744059235, 4884.120858245515, 4893.363862697862, 4899.926501102486, 4900.901981960359, 4907.484714105021, 4660.370849935266, 4736.550027747358, 4783.928241076386, 4828.324034635154, 4910.7299098549565, 3958.604139586047, 4249.3201087825955, 4721.173794585951, 4754.239321708527, 4788.61691064714, 4417.602415782579, 4775.856724298276, 4778.952210477885, 4781.976090119562, 4789.568938795525, 4147.129102888397, 4149.792510374469, 4153.646940010072, 4155.812988415499, 4161.10536234708, 6103.816885493442, 6316.652584107872, 6334.271558770754, 6349.333320001379, 6368.681565921732, 5770.23028946104, 5774.0761478163295, 5774.451427114417, 5776.393478684719, 5779.884402311972, 5641.802536911229, 6954.23503414624, 6954.930450695479, 6969.965150174216, 6977.302269773033, 4352.564743525622, 4538.432695913011, 4542.704724192917, 4689.241534424591, 4695.178343789823, 7371.926280737178, 7440.962795186044, 7447.590382528959, 7454.440916931252, 7456.478046536745, 4362.934555981663, 4629.745364005012, 4630.004549021976, 4634.189016922025, 4656.115338085753, 4474.888127796831, 4548.340490628906, 4554.633609917011, 4563.247064234431, 4741.928871066937, 5529.3364796223905, 5558.861028474321, 5567.749451274703, 5567.860803479945, 5585.525230355384, 5761.279840019997, 6987.371136597731, 7046.6828992695455, 7063.25835787235, 7065.399441047466, 1586.92858821351, 1614.3139165854466, 1624.3746157729358, 1633.1017940132879, 1636.6235765773938, 1029.840374741916, 1039.4958445154093, 1041.4740556019162, 1055.8996895294936, 1055.963041293551, 6539.08452816606, 6541.934580654132, 6544.312847150981, 6553.672316384162, 6575.572587781779, 7323.194448610649, 7324.377427918686, 7331.633418329062, 7341.559506429631, 7342.11894572644, 6445.742170313135, 6528.934710652928, 6542.887709089467, 6710.765123220664, 6713.227978782503, 3017.9547306790414, 3832.4251362295877, 3841.865534706272, 3851.9614803851605, 3853.5183102112237, 7548.698052077855, 7550.962245188849, 7551.886721699179, 7552.509086909334, 7573.431992600466, 7280.235575264627, 7415.258474152542, 7487.962560187164, 7493.838455039478, 7504.174540800507, 6015.0, 7562.168161502121, 7562.432817538706, 7562.546247225184, 7567.583782891884, 7246.456515761444, 7250.238724934017, 7254.782356529313, 7256.383207427428, 7262.709491620487, 5806.593538452268, 6883.0, 7120.430365570845, 7129.857402851811, 7136.036635054201, 7523.586202758682, 7528.247175282428, 7528.774136775905, 7528.849423011399, 7542.868569714367, 4393.384926110283, 4482.887927801831, 4490.101979604157, 4611.16998940194, 4613.400257966443, 6967.09427774386, 7030.367266945999, 7177.569345839266, 7330.450216233698, 7367.905479698432, 7079.29207079288, 7105.786826395217, 7111.43108551325, 7115.324044215791, 7123.074000379917, 6878.55289406187, 7062.1878483975, 7092.787216383516, 7105.18290396611, 7109.040279562193, 5656.377798442086, 6915.204751453647, 6920.307969203241, 6921.134858142732, 6935.7225710971, 6786.253512113565, 7035.718571257297, 7079.0, 7083.079199704005, 7101.644917753988, 6933.618650974245, 6933.89599156003, 6939.861202776017, 6941.201761797256, 6949.478789090939], "unit": "score", "name": "prototype.html", "value": 5102.07852604806}, {"lowerIsBetter": false, "replicates": [663.7046514301138, 680.6800803622298, 711.2070041903278, 750.3846845586618, 757.6022588141225, 14877.107373557594, 15098.471553495616, 15104.848951510481, 15115.470958516455, 15132.0, 13639.590812275623, 13707.314634268272, 13738.793918091236, 13742.862571374284, 13760.174389536634, 700.2542292458528, 715.7852644206744, 843.6203708331245, 868.513632365874, 868.991969315594, 865.3164000439646, 870.2211520688979, 877.2937785083005, 880.1858281089966, 882.1178821178821, 744.159100216757, 758.6206896551724, 925.4447331601053, 925.9398139120935, 930.7905721212741, 908.4276905549527, 931.9440833550009, 932.9626814927428, 934.9205317548017, 935.4200395754608, 702.3012102957539, 702.4977141343912, 704.5350068954466, 704.6864145455274, 705.7988473285089, 14466.349014294383, 14511.709765804624, 14512.984091113627, 14529.709405811931, 14533.982621216519, 12601.30692811895, 12684.238945663197, 12776.808347874789, 13305.135166214164, 13579.660508487366, 10009.199264058858, 10219.0, 10339.793204135874, 10571.365718056864, 11001.889981100167, 3980.9402858957137, 4068.1456894052285, 4069.877903662895, 4074.979625101885, 4076.470058892325, 76191.0, 77553.0, 77638.22361776367, 77732.8340074905, 78445.0, 9257.768555786159, 9306.441613503212, 9386.67146649864, 9540.809183816285, 9850.408975461352, 17654.911725441547, 19507.731997420124, 20318.0, 20358.79641203569, 20385.694214586794, 7399.85200295991, 7617.200193979553, 7622.2758837910305, 7623.123340815877, 7690.653920573588, 4131.07050913542, 4141.171765646883, 4146.771927544014, 4172.666186705056, 4190.245755763992, 3380.8309584521166, 3413.880514182041, 3415.077928959167, 3421.418358878947, 3423.0928803866996, 621.9595726277778, 628.0391001767304, 631.6841579210395, 647.3267801486495, 650.9251436084816, 539.9865003374869, 555.9148650449961, 591.7455494137477, 636.9044643303449, 661.2461793555351, 8329.750107496784, 8403.957980210182, 8636.95681521601, 9033.63865445388, 9046.86429703555, 484.6704241116075, 592.1325258496323, 606.6845240474928, 634.3656343656344, 663.2538394306405, 3714.832832522543, 3865.3622152344547, 3904.2581909437117, 4079.0, 4279.251131052053, 83298.0, 83730.32539349301, 90499.54750226207, 90670.54664726766, 90998.0, 74064.62967685235, 74598.0, 75249.24750752532, 76289.61855190799, 77756.22243777603, 49224.0, 65143.34856651467, 65253.0, 65640.0, 70847.6457617719, 8717.564121793757, 8732.519711415933, 8799.780005499657, 8841.778955526162, 9095.727128186165, 45349.54650453453, 46212.844678883295, 47562.0, 47877.521224787306, 49419.75290123526, 63949.3605063962, 64124.0, 64792.676036619516, 65703.34296656972, 69253.30746692469, 11069.557217711523, 11071.72320691989, 11085.889141108808, 11117.444127793417, 11464.197506174822, 12079.51681932713, 12083.697907552381, 12449.564265250672, 12611.117221794386, 12897.677558061123, 11598.826017609574, 11740.941295293469, 11843.0, 11856.466459009538, 12083.818742719042, 11551.76896462083, 11833.171677982458, 11990.700232494257, 12018.519259229533, 12103.51585936588, 11151.996320331209, 11203.103751700008, 11363.488643010918, 11453.083753299883, 11523.769524609294, 9244.260459163384, 9267.76830579241, 9356.48539330316, 9512.33413661037, 9580.425174489554, 9679.854802178113, 9795.412275263507, 9797.951010244904, 9804.509774511389, 9827.361221520578], "unit": "score", "name": "yui.html", "value": 6865.065329209749}], "name": "dromaeo_css", "value": 7465.963624076183}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 108.0, 112.0, 112.0, 110.0, 113.0, 116.0, 113.0, 113.0, 112.0], "unit": "score", "name": "ai-astar", "value": 112.1}, {"lowerIsBetter": true, "replicates": [159.0, 122.0, 145.0, 155.0, 118.0, 144.0, 140.0, 121.0, 158.0, 121.0], "unit": "score", "name": "audio-beat-detection", "value": 138.3}, {"lowerIsBetter": true, "replicates": [186.0, 186.0, 196.0, 187.0, 188.0, 186.0, 186.0, 186.0, 208.0, 260.0], "unit": "score", "name": "audio-dft", "value": 196.9}, {"lowerIsBetter": true, "replicates": [81.0, 74.0, 74.0, 111.0, 55.0, 57.0, 57.0, 58.0, 115.0, 55.0], "unit": "score", "name": "audio-fft", "value": 73.7}, {"lowerIsBetter": true, "replicates": [92.0, 97.0, 127.0, 78.0, 81.0, 86.0, 112.0, 77.0, 77.0, 113.0], "unit": "score", "name": "audio-oscillator", "value": 94.0}, {"lowerIsBetter": true, "replicates": [84.0, 89.0, 84.0, 89.0, 83.0, 89.0, 83.0, 90.0, 85.0, 140.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 91.6}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 94.0, 93.0, 93.0, 93.0, 93.0, 93.0, 92.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 93.0}, {"lowerIsBetter": true, "replicates": [87.0, 91.0, 85.0, 88.0, 88.0, 89.0, 106.0, 136.0, 143.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 99.8}, {"lowerIsBetter": true, "replicates": [55.0, 52.0, 53.0, 52.0, 54.0, 52.0, 51.0, 62.0, 51.0, 51.0], "unit": "score", "name": "json-parse-financial", "value": 53.3}, {"lowerIsBetter": true, "replicates": [61.0, 63.0, 68.0, 62.0, 67.0, 74.0, 68.0, 66.0, 66.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.1}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 79.0, 98.0, 105.0, 106.0, 108.0, 83.0, 85.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 91.2}, {"lowerIsBetter": true, "replicates": [125.0, 125.0, 133.0, 125.0, 135.0, 129.0, 127.0, 116.0, 124.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.1}, {"lowerIsBetter": true, "replicates": [137.0, 127.0, 170.0, 121.0, 160.0, 171.0, 175.0, 138.0, 136.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.3}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 66.0, 67.0, 67.0, 69.0, 66.0, 67.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.8}], "name": "kraken", "value": 1450.1999999999998}]} 13:07:55 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1450.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7465.97"}}} 13:07:55 INFO - Return code: 0 13:07:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:07:55 INFO - # TBPL SUCCESS # 13:07:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:07:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:07:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:07:55 INFO - 2016-02-12 13:07:55.164 screenresolution[1691:10822] starting screenresolution argv=screenresolution get 13:07:55 INFO - 2016-02-12 13:07:55.167 screenresolution[1691:10822] Display 0: 1600x1200x32@60 13:07:55 INFO - 2016-02-12 13:07:55.173 screenresolution[1692:10825] starting screenresolution argv=screenresolution list 13:07:55 INFO - Available Modes on Display 0 13:07:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:07:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:07:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:07:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:07:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:07:55 INFO - Intel Iris: 13:07:55 INFO - Chipset Model: Intel Iris 13:07:55 INFO - Type: GPU 13:07:55 INFO - Bus: Built-In 13:07:55 INFO - VRAM (Dynamic, Max): 1536 MB 13:07:55 INFO - Vendor: Intel (0x8086) 13:07:55 INFO - Device ID: 0x0a2e 13:07:55 INFO - Revision ID: 0x0009 13:07:55 INFO - Displays: 13:07:55 INFO - Display: 13:07:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:07:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:07:55 INFO - Display Serial Number: 1600x1200 60 13:07:55 INFO - Main Display: Yes 13:07:55 INFO - Mirror: Off 13:07:55 INFO - Online: Yes 13:07:55 INFO - Rotation: Supported 13:07:55 INFO - Return code: 0 13:07:55 INFO - Running post-action listener: _resource_record_post_action 13:07:55 INFO - Running post-run listener: _resource_record_post_run 13:07:56 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 33529344; Write bytes: 707867136; Read time: 353; Write time: 2195 13:07:56 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 384526848; Write bytes: 377788416; Read time: 28735; Write time: 681 13:07:56 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 32595456; Write bytes: 301562368; Read time: 339; Write time: 1457 13:07:56 INFO - Running post-run listener: _upload_blobber_files 13:07:56 INFO - Blob upload gear active. 13:07:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:07:56 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 13:07:56 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'] 13:07:56 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 13:07:56 INFO - (blobuploader) - INFO - Open directory for files ... 13:07:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:07:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:07:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:07:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:07:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:07:58 INFO - (blobuploader) - INFO - Done attempting. 13:07:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:07:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:07:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:07:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:07:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:07:59 INFO - (blobuploader) - INFO - Done attempting. 13:07:59 INFO - (blobuploader) - INFO - Iteration through files over. 13:07:59 INFO - Return code: 0 13:07:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:07:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:07:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/04aabc589a5550d7b44ab12feb1f9f84e2c652c0b1d9a217fa64d433d825226df25532c27aeab89206b55945d561cde1711b7f00b7a9e2c8434088763e5c79f0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/afcf3a9cb1838735f96332f8c5056e8d35de60ebfacbe34e2603a88daaaaf1bd0e6172abd5fbc7e8dc1bcd8a37f744b16411ea1fae96bc53e0b000c54a49e1b1"} 13:07:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:07:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:07:59 INFO - Contents: 13:07:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/04aabc589a5550d7b44ab12feb1f9f84e2c652c0b1d9a217fa64d433d825226df25532c27aeab89206b55945d561cde1711b7f00b7a9e2c8434088763e5c79f0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/afcf3a9cb1838735f96332f8c5056e8d35de60ebfacbe34e2603a88daaaaf1bd0e6172abd5fbc7e8dc1bcd8a37f744b16411ea1fae96bc53e0b000c54a49e1b1"} 13:07:59 INFO - Running post-run listener: copy_logs_to_upload_dir 13:07:59 INFO - Copying logs to upload dir... 13:07:59 INFO - mkdir: /builds/slave/test/build/upload/logs 13:07:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.992726 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-02-12 13:07:59.306989) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-12 13:07:59.310798) ========= 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.5bireDN4lC/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.t0AbLO0kSC/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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/04aabc589a5550d7b44ab12feb1f9f84e2c652c0b1d9a217fa64d433d825226df25532c27aeab89206b55945d561cde1711b7f00b7a9e2c8434088763e5c79f0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/afcf3a9cb1838735f96332f8c5056e8d35de60ebfacbe34e2603a88daaaaf1bd0e6172abd5fbc7e8dc1bcd8a37f744b16411ea1fae96bc53e0b000c54a49e1b1"} build_url:https://queue.taskcluster.net/v1/task/SAjNjdB9Qyyega-EeRl1NQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011354 build_url: 'https://queue.taskcluster.net/v1/task/SAjNjdB9Qyyega-EeRl1NQ/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/04aabc589a5550d7b44ab12feb1f9f84e2c652c0b1d9a217fa64d433d825226df25532c27aeab89206b55945d561cde1711b7f00b7a9e2c8434088763e5c79f0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/afcf3a9cb1838735f96332f8c5056e8d35de60ebfacbe34e2603a88daaaaf1bd0e6172abd5fbc7e8dc1bcd8a37f744b16411ea1fae96bc53e0b000c54a49e1b1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-12 13:07:59.338565) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 13:07:59.338936) ========= 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.5bireDN4lC/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.t0AbLO0kSC/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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.005240 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 13:07:59.388617) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-12 13:07:59.388976) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-12 13:07:59.389507) ========= ========= Total master_lag: 0.36 =========