builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0121 starttime: 1455302361.5 results: success (0) buildid: 20160212085824 builduid: 447543fa34ac43778218cb9453b24716 revision: e64c1c00081fb56bd108e112fa7ad05bf10fddcd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-12 10:39:21.504124) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-12 10:39:21.504585) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-12 10:39:21.504894) ========= 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.7vIJXobspg/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.sQsLH9hmOo/Listeners TMPDIR=/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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.005285 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-12 10:39:21.527794) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-12 10:39:21.528239) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-12 10:39:21.545346) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 10:39:21.545801) ========= 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.7vIJXobspg/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.sQsLH9hmOo/Listeners TMPDIR=/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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.005317 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 10:39:21.595040) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-12 10:39:21.598375) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-12 10:39:21.598768) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 10:39:21.599051) ========= 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.7vIJXobspg/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.sQsLH9hmOo/Listeners TMPDIR=/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 10:39:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 44.5M=0s 2016-02-12 10:39:21 (44.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104652 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 10:39:21.721490) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 10:39:21.721809) ========= 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.7vIJXobspg/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.sQsLH9hmOo/Listeners TMPDIR=/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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.025123 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 10:39:21.770048) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-12 10:39:21.773429) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e64c1c00081fb56bd108e112fa7ad05bf10fddcd --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 e64c1c00081fb56bd108e112fa7ad05bf10fddcd --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7vIJXobspg/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.sQsLH9hmOo/Listeners TMPDIR=/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 10:39:21,850 truncating revision to first 12 chars 2016-02-12 10:39:21,850 Setting DEBUG logging. 2016-02-12 10:39:21,850 attempt 1/10 2016-02-12 10:39:21,850 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e64c1c00081f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-12 10:39:22,797 unpacking tar archive at: fx-team-e64c1c00081f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.196034 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-12 10:39:22.986126) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-12 10:39:22.986563) ========= echo e64c1c00081fb56bd108e112fa7ad05bf10fddcd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'e64c1c00081fb56bd108e112fa7ad05bf10fddcd'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7vIJXobspg/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.sQsLH9hmOo/Listeners TMPDIR=/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 e64c1c00081fb56bd108e112fa7ad05bf10fddcd program finished with exit code 0 elapsedTime=0.005862 script_repo_revision: 'e64c1c00081fb56bd108e112fa7ad05bf10fddcd' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-12 10:39:23.038040) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-12 10:39:23.038438) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-12 10:39:23.052187) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-02-12 10:39:23.052804) ========= /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.7vIJXobspg/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.sQsLH9hmOo/Listeners TMPDIR=/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 10:39:23 INFO - MultiFileLogger online at 20160212 10:39:23 in /builds/slave/test 10:39:23 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 10:39:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:39:23 INFO - {'append_to_log': False, 10:39:23 INFO - 'base_work_dir': '/builds/slave/test', 10:39:23 INFO - 'blob_upload_branch': 'Fx-Team', 10:39:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:39:23 INFO - 'branch': 'Fx-Team', 10:39:23 INFO - 'buildbot_json_path': 'buildprops.json', 10:39:23 INFO - 'config_files': ('talos/mac_config.py',), 10:39:23 INFO - 'default_actions': ('clobber', 10:39:23 INFO - 'read-buildbot-config', 10:39:23 INFO - 'download-and-extract', 10:39:23 INFO - 'populate-webroot', 10:39:23 INFO - 'create-virtualenv', 10:39:23 INFO - 'install', 10:39:23 INFO - 'run-tests'), 10:39:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:39:23 INFO - 'download_minidump_stackwalk': True, 10:39:23 INFO - 'download_symbols': 'ondemand', 10:39:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:39:23 INFO - 'tooltool.py': '/tools/tooltool.py', 10:39:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:39:23 INFO - '/tools/misc-python/virtualenv.py')}, 10:39:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:39:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:39:23 INFO - 'installer_path': 'installer.exe', 10:39:23 INFO - 'log_level': 'info', 10:39:23 INFO - 'log_name': 'talos', 10:39:23 INFO - 'log_to_console': True, 10:39:23 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:39:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:39:23 INFO - 'opt_config_files': (), 10:39:23 INFO - 'pip_index': False, 10:39:23 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:39:23 INFO - 'cmd': ('bash', 10:39:23 INFO - '-c', 10:39:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:39:23 INFO - 'enabled': True, 10:39:23 INFO - 'halt_on_failure': False, 10:39:23 INFO - 'name': 'check_screen_resolution'},), 10:39:23 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:39:23 INFO - 'cmd': ('bash', 10:39:23 INFO - '-c', 10:39:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:39:23 INFO - 'enabled': True, 10:39:23 INFO - 'halt_on_failure': False, 10:39:23 INFO - 'name': 'check_screen_resolution'},), 10:39:23 INFO - 'run_cmd_checks_enabled': True, 10:39:23 INFO - 'sps_profile': False, 10:39:23 INFO - 'sps_profile_interval': 0, 10:39:23 INFO - 'suite': 'dromaeojs', 10:39:23 INFO - 'system_bits': '32', 10:39:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:39:23 INFO - 'title': 't-yosemite-r7-0121', 10:39:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:39:23 INFO - 'use_talos_json': True, 10:39:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:39:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:39:23 INFO - 'work_dir': 'build'} 10:39:23 INFO - ##### 10:39:23 INFO - ##### Running clobber step. 10:39:23 INFO - ##### 10:39:23 INFO - Running pre-action listener: _resource_record_pre_action 10:39:23 INFO - Running main action method: clobber 10:39:23 INFO - rmtree: /builds/slave/test/build 10:39:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:39:24 INFO - Running post-action listener: _resource_record_post_action 10:39:24 INFO - ##### 10:39:24 INFO - ##### Running read-buildbot-config step. 10:39:24 INFO - ##### 10:39:24 INFO - Running pre-action listener: _resource_record_pre_action 10:39:24 INFO - Running main action method: read_buildbot_config 10:39:24 INFO - Using buildbot properties: 10:39:24 INFO - { 10:39:24 INFO - "project": "", 10:39:24 INFO - "product": "firefox", 10:39:24 INFO - "script_repo_revision": "production", 10:39:24 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 10:39:24 INFO - "repository": "", 10:39:24 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 10:39:24 INFO - "buildid": "20160212085824", 10:39:24 INFO - "pgo_build": "False", 10:39:24 INFO - "basedir": "/builds/slave/test", 10:39:24 INFO - "buildnumber": 434, 10:39:24 INFO - "slavename": "t-yosemite-r7-0121", 10:39:24 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 10:39:24 INFO - "platform": "yosemite_r7", 10:39:24 INFO - "scheduler": "tests-fx-team-macosx64-talos", 10:39:24 INFO - "branch": "fx-team", 10:39:24 INFO - "repo_path": "integration/fx-team", 10:39:24 INFO - "revision": "e64c1c00081fb56bd108e112fa7ad05bf10fddcd", 10:39:24 INFO - "stage_platform": "macosx64", 10:39:24 INFO - "builduid": "447543fa34ac43778218cb9453b24716", 10:39:24 INFO - "slavebuilddir": "test" 10:39:24 INFO - } 10:39:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/WCgrczzaQ0C7quE4c89qGQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 10:39:24 INFO - Running post-action listener: _resource_record_post_action 10:39:24 INFO - ##### 10:39:24 INFO - ##### Running download-and-extract step. 10:39:24 INFO - ##### 10:39:24 INFO - Running pre-action listener: _resource_record_pre_action 10:39:24 INFO - Running main action method: download_and_extract 10:39:24 INFO - mkdir: /builds/slave/test/build/tests 10:39:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:39:24 INFO - https://queue.taskcluster.net/v1/task/WCgrczzaQ0C7quE4c89qGQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:39:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WCgrczzaQ0C7quE4c89qGQ/artifacts/public/build/test_packages.json 10:39:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WCgrczzaQ0C7quE4c89qGQ/artifacts/public/build/test_packages.json 10:39:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WCgrczzaQ0C7quE4c89qGQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 10:39:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WCgrczzaQ0C7quE4c89qGQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 10:39:26 INFO - Downloaded 1277 bytes. 10:39:26 INFO - Reading from file /builds/slave/test/build/test_packages.json 10:39:26 INFO - Using the following test package requirements: 10:39:26 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 10:39:26 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:39:26 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 10:39:26 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:39:26 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 10:39:26 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:39:26 INFO - u'jsshell-mac.zip'], 10:39:26 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:39:26 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 10:39:26 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 10:39:26 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:39:26 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 10:39:26 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:39:26 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 10:39:26 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:39:26 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 10:39:26 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 10:39:26 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:39:26 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 10:39:26 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:39:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:39:26 INFO - https://queue.taskcluster.net/v1/task/WCgrczzaQ0C7quE4c89qGQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:39:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WCgrczzaQ0C7quE4c89qGQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:39:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WCgrczzaQ0C7quE4c89qGQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:39:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WCgrczzaQ0C7quE4c89qGQ/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 10:39:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WCgrczzaQ0C7quE4c89qGQ/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 10:39:28 INFO - Downloaded 17756542 bytes. 10:39:28 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'] 10:39:28 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 10:39:31 INFO - Return code: 0 10:39:31 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 10:39:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:39:31 INFO - https://queue.taskcluster.net/v1/task/WCgrczzaQ0C7quE4c89qGQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:39:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WCgrczzaQ0C7quE4c89qGQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:39:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WCgrczzaQ0C7quE4c89qGQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:39:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WCgrczzaQ0C7quE4c89qGQ/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 10:39:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WCgrczzaQ0C7quE4c89qGQ/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 10:39:32 INFO - Downloaded 17756542 bytes. 10:39:32 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'] 10:39:32 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 10:39:35 INFO - Return code: 0 10:39: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')]} 10:39:35 INFO - https://queue.taskcluster.net/v1/task/WCgrczzaQ0C7quE4c89qGQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 10:39:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WCgrczzaQ0C7quE4c89qGQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 10:39:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WCgrczzaQ0C7quE4c89qGQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 10:39:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WCgrczzaQ0C7quE4c89qGQ/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 10:39:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WCgrczzaQ0C7quE4c89qGQ/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 10:39:36 INFO - Downloaded 10707070 bytes. 10:39:36 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'] 10:39:36 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 10:39:37 INFO - Return code: 0 10:39:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:39:37 INFO - https://queue.taskcluster.net/v1/task/WCgrczzaQ0C7quE4c89qGQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 10:39:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WCgrczzaQ0C7quE4c89qGQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 10:39:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WCgrczzaQ0C7quE4c89qGQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 10:39:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WCgrczzaQ0C7quE4c89qGQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 10:39:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WCgrczzaQ0C7quE4c89qGQ/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 10:39:39 INFO - Downloaded 111078479 bytes. 10:39:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WCgrczzaQ0C7quE4c89qGQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 10:39:39 INFO - mkdir: /builds/slave/test/properties 10:39:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:39:39 INFO - Writing to file /builds/slave/test/properties/build_url 10:39:39 INFO - Contents: 10:39:39 INFO - build_url:https://queue.taskcluster.net/v1/task/WCgrczzaQ0C7quE4c89qGQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 10:39:41 INFO - Running post-action listener: _resource_record_post_action 10:39:41 INFO - Running post-action listener: set_extra_try_arguments 10:39:41 INFO - ##### 10:39:41 INFO - ##### Running populate-webroot step. 10:39:41 INFO - ##### 10:39:41 INFO - Running pre-action listener: _resource_record_pre_action 10:39:41 INFO - Running main action method: populate_webroot 10:39:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:39:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:39:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:39:41 INFO - '--tppagecycles', 10:39:41 INFO - '7'], 10:39:41 INFO - 'tests': ['tsvgm']}}, 10:39:41 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:39:41 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:39:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:39:41 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 10:39:41 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:39:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:39:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:39:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:39:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:39:41 INFO - 'talos_options': ['--e10s'], 10:39:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:39:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:39:41 INFO - 'tests': ['damp', 'tps']}, 10:39:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:39:41 INFO - 'talos_options': ['--e10s'], 10:39:41 INFO - 'tests': ['damp', 'tps']}, 10:39:41 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:39:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:39:41 INFO - 'other': {'tests': ['a11yr', 10:39:41 INFO - 'ts_paint', 10:39:41 INFO - 'tpaint', 10:39:41 INFO - 'sessionrestore', 10:39:41 INFO - 'sessionrestore_no_auto_restore']}, 10:39:41 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:39:41 INFO - 'tests': ['a11yr', 10:39:41 INFO - 'ts_paint', 10:39:41 INFO - 'tpaint', 10:39:41 INFO - 'sessionrestore', 10:39:41 INFO - 'sessionrestore_no_auto_restore']}, 10:39:41 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:39:41 INFO - 'tests': ['a11yr', 10:39:41 INFO - 'ts_paint', 10:39:41 INFO - 'tpaint', 10:39:41 INFO - 'sessionrestore', 10:39:41 INFO - 'sessionrestore_no_auto_restore']}, 10:39:41 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:39:41 INFO - 'tests': ['a11yr', 10:39:41 INFO - 'ts_paint', 10:39:41 INFO - 'tpaint', 10:39:41 INFO - 'sessionrestore', 10:39:41 INFO - 'sessionrestore_no_auto_restore']}, 10:39:41 INFO - 'other_l64': {'tests': ['a11yr', 10:39:41 INFO - 'ts_paint', 10:39:41 INFO - 'tpaint', 10:39:41 INFO - 'sessionrestore', 10:39:41 INFO - 'sessionrestore_no_auto_restore']}, 10:39:41 INFO - 'other_nol64': {'tests': ['a11yr', 10:39:41 INFO - 'ts_paint', 10:39:41 INFO - 'tpaint', 10:39:41 INFO - 'sessionrestore', 10:39:41 INFO - 'sessionrestore_no_auto_restore']}, 10:39:41 INFO - 'svgr': {'tests': ['tsvgx', 10:39:41 INFO - 'tsvgr_opacity', 10:39:41 INFO - 'tart', 10:39:41 INFO - 'tscrollx', 10:39:41 INFO - 'cart']}, 10:39:41 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:39:41 INFO - 'tests': ['tsvgx', 10:39:41 INFO - 'tsvgr_opacity', 10:39:41 INFO - 'tart', 10:39:41 INFO - 'tscrollx', 10:39:41 INFO - 'cart']}, 10:39:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:39:41 INFO - 'tests': ['tp5o']}, 10:39:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:39:41 INFO - 'talos_options': ['--e10s'], 10:39:41 INFO - 'tests': ['tp5o']}, 10:39:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:39:41 INFO - 'talos_options': ['--xperf_path', 10:39:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:39:41 INFO - 'tests': ['tp5n']}, 10:39:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:39:41 INFO - 'talos_options': ['--e10s', 10:39:41 INFO - '--xperf_path', 10:39:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:39:41 INFO - 'tests': ['tp5n']}}, 10:39:41 INFO - 'talos.zip': {'path': '', 10:39:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:39:41 INFO - Running post-action listener: _resource_record_post_action 10:39:41 INFO - ##### 10:39:41 INFO - ##### Running create-virtualenv step. 10:39:41 INFO - ##### 10:39:41 INFO - Running pre-action listener: _resource_record_pre_action 10:39:41 INFO - Running main action method: create_virtualenv 10:39:41 INFO - Creating virtualenv /builds/slave/test/build/venv 10:39:41 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 10:39:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:39:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:39:41 INFO - Using real prefix '/tools/python27' 10:39:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:39:42 INFO - Installing distribute.............................................................................................................................................................................................done. 10:39:45 INFO - Installing pip.................done. 10:39:45 INFO - Return code: 0 10:39:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:39:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:39:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:39:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:45 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 0x10e7d2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7da4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8a9cadf60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e676d30>, '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 0x10e49adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e66db20>, '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.7vIJXobspg/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.sQsLH9hmOo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 10:39:45 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 10:39:45 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 10:39:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7vIJXobspg/Render', 10:39:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:39:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:39:45 INFO - 'HOME': '/Users/cltbld', 10:39:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:39:45 INFO - 'LOGNAME': 'cltbld', 10:39:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:45 INFO - 'MOZ_NO_REMOTE': '1', 10:39:45 INFO - 'NO_EM_RESTART': '1', 10:39:45 INFO - 'PAGER': '/bin/cat', 10:39:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:39:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:45 INFO - 'PWD': '/builds/slave/test', 10:39:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:39:45 INFO - 'SHELL': '/bin/bash', 10:39:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sQsLH9hmOo/Listeners', 10:39:45 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 10:39:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:39:45 INFO - 'USER': 'cltbld', 10:39:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:39:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:39:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:45 INFO - 'XPC_FLAGS': '0x0', 10:39:45 INFO - 'XPC_SERVICE_NAME': '0', 10:39:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:39:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:45 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 10:39:45 INFO - Cleaning up... 10:39:45 INFO - Return code: 0 10:39:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:39:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:39:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:39:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:45 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 0x10e7d2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7da4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8a9cadf60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e676d30>, '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 0x10e49adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e66db20>, '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.7vIJXobspg/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.sQsLH9hmOo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 10:39:45 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 10:39:45 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 10:39:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7vIJXobspg/Render', 10:39:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:39:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:39:45 INFO - 'HOME': '/Users/cltbld', 10:39:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:39:45 INFO - 'LOGNAME': 'cltbld', 10:39:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:45 INFO - 'MOZ_NO_REMOTE': '1', 10:39:45 INFO - 'NO_EM_RESTART': '1', 10:39:45 INFO - 'PAGER': '/bin/cat', 10:39:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:39:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:45 INFO - 'PWD': '/builds/slave/test', 10:39:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:39:45 INFO - 'SHELL': '/bin/bash', 10:39:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sQsLH9hmOo/Listeners', 10:39:45 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 10:39:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:39:45 INFO - 'USER': 'cltbld', 10:39:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:39:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:39:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:45 INFO - 'XPC_FLAGS': '0x0', 10:39:45 INFO - 'XPC_SERVICE_NAME': '0', 10:39:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:39:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:45 INFO - Downloading/unpacking psutil>=0.7.1 10:39:45 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 10:39:45 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 10:39:45 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 10:39:45 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 10:39:45 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 10:39:45 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 10:39:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:39:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:39:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:39:48 INFO - Installing collected packages: psutil 10:39:48 INFO - Running setup.py install for psutil 10:39:48 INFO - building 'psutil._psutil_osx' extension 10:39:48 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 10:39:49 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 10:39:49 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 10:39:49 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 10:39:49 INFO - building 'psutil._psutil_posix' extension 10:39:49 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 10:39:49 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:39:49 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:39:49 INFO - ^ 10:39:49 INFO - 1 warning generated. 10:39:49 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 10:39:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:39:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:39:49 INFO - Successfully installed psutil 10:39:49 INFO - Cleaning up... 10:39:49 INFO - Return code: 0 10:39:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:39:49 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')]} 10:39:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:49 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')]} 10:39:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:49 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 0x10e7d2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7da4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8a9cadf60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e676d30>, '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 0x10e49adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e66db20>, '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.7vIJXobspg/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.sQsLH9hmOo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 10:39:49 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 10:39:49 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 10:39:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7vIJXobspg/Render', 10:39:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:39:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:39:49 INFO - 'HOME': '/Users/cltbld', 10:39:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:39:49 INFO - 'LOGNAME': 'cltbld', 10:39:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:49 INFO - 'MOZ_NO_REMOTE': '1', 10:39:49 INFO - 'NO_EM_RESTART': '1', 10:39:49 INFO - 'PAGER': '/bin/cat', 10:39:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:39:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:49 INFO - 'PWD': '/builds/slave/test', 10:39:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:39:49 INFO - 'SHELL': '/bin/bash', 10:39:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sQsLH9hmOo/Listeners', 10:39:49 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 10:39:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:39:49 INFO - 'USER': 'cltbld', 10:39:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:39:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:39:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:49 INFO - 'XPC_FLAGS': '0x0', 10:39:49 INFO - 'XPC_SERVICE_NAME': '0', 10:39:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:39:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:39:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:39:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:39:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:39:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:39:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:39:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:39:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:39:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:39:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:39:52 INFO - Installing collected packages: mozsystemmonitor 10:39:52 INFO - Running setup.py install for mozsystemmonitor 10:39:52 INFO - Successfully installed mozsystemmonitor 10:39:52 INFO - Cleaning up... 10:39:52 INFO - Return code: 0 10:39:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:39:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:39:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:52 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 0x10e7d2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7da4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8a9cadf60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e676d30>, '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 0x10e49adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e66db20>, '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.7vIJXobspg/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.sQsLH9hmOo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 10:39:52 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 10:39:52 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 10:39:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7vIJXobspg/Render', 10:39:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:39:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:39:52 INFO - 'HOME': '/Users/cltbld', 10:39:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:39:52 INFO - 'LOGNAME': 'cltbld', 10:39:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:52 INFO - 'MOZ_NO_REMOTE': '1', 10:39:52 INFO - 'NO_EM_RESTART': '1', 10:39:52 INFO - 'PAGER': '/bin/cat', 10:39:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:39:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:52 INFO - 'PWD': '/builds/slave/test', 10:39:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:39:52 INFO - 'SHELL': '/bin/bash', 10:39:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sQsLH9hmOo/Listeners', 10:39:52 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 10:39:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:39:52 INFO - 'USER': 'cltbld', 10:39:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:39:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:39:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:52 INFO - 'XPC_FLAGS': '0x0', 10:39:52 INFO - 'XPC_SERVICE_NAME': '0', 10:39:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:39:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:52 INFO - Downloading/unpacking blobuploader==1.2.4 10:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:39:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:39:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:39:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:39:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:39:55 INFO - Downloading blobuploader-1.2.4.tar.gz 10:39:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:39:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:39:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:39:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:39:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:39:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:39:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:39:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:39:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:39:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:39:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:39:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:39:56 INFO - Downloading docopt-0.6.1.tar.gz 10:39:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:39:56 INFO - Installing collected packages: blobuploader, requests, docopt 10:39:56 INFO - Running setup.py install for blobuploader 10:39:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:39:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:39:56 INFO - Running setup.py install for requests 10:39:57 INFO - Running setup.py install for docopt 10:39:57 INFO - Successfully installed blobuploader requests docopt 10:39:57 INFO - Cleaning up... 10:39:57 INFO - Return code: 0 10:39:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:39:57 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')]} 10:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:57 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')]} 10:39:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:57 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 0x10e7d2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7da4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8a9cadf60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e676d30>, '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 0x10e49adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e66db20>, '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.7vIJXobspg/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.sQsLH9hmOo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 10:39:57 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 10:39:57 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 10:39:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7vIJXobspg/Render', 10:39:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:39:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:39:57 INFO - 'HOME': '/Users/cltbld', 10:39:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:39:57 INFO - 'LOGNAME': 'cltbld', 10:39:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:57 INFO - 'MOZ_NO_REMOTE': '1', 10:39:57 INFO - 'NO_EM_RESTART': '1', 10:39:57 INFO - 'PAGER': '/bin/cat', 10:39:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:39:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:57 INFO - 'PWD': '/builds/slave/test', 10:39:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:39:57 INFO - 'SHELL': '/bin/bash', 10:39:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sQsLH9hmOo/Listeners', 10:39:57 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 10:39:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:39:57 INFO - 'USER': 'cltbld', 10:39:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:39:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:39:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:57 INFO - 'XPC_FLAGS': '0x0', 10:39:57 INFO - 'XPC_SERVICE_NAME': '0', 10:39:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:39:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:39:57 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-nV92oY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:39:57 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-f4jPJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:39:57 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-8i4jNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:39:57 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-AavDt0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:39:57 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-yz6Ico-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:39:58 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-guyeqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:39:58 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-eFHB_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:39:58 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-vmAKqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:39:58 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-dP8sSJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:39:58 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-trawu2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:39:58 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-JgQL2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:39:58 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-051Yta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:39:58 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-NWuaFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:39:58 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-GKtw1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:39:59 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-Hia0CF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:39:59 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-wxFK8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:39:59 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-FHZ1m1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:39:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:39:59 INFO - Running setup.py install for manifestparser 10:39:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:39:59 INFO - Running setup.py install for mozcrash 10:39:59 INFO - Running setup.py install for mozdebug 10:39:59 INFO - Running setup.py install for mozdevice 10:39:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:39:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:39:59 INFO - Running setup.py install for mozfile 10:40:00 INFO - Running setup.py install for mozhttpd 10:40:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:40:00 INFO - Running setup.py install for mozinfo 10:40:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:40:00 INFO - Running setup.py install for mozInstall 10:40:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:40:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:40:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:40:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:40:00 INFO - Running setup.py install for mozleak 10:40:00 INFO - Running setup.py install for mozlog 10:40:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:40:00 INFO - Running setup.py install for moznetwork 10:40:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:40:00 INFO - Running setup.py install for mozprocess 10:40:01 INFO - Running setup.py install for mozprofile 10:40:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:40:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:40:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:40:01 INFO - Running setup.py install for mozrunner 10:40:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:40:01 INFO - Running setup.py install for mozscreenshot 10:40:01 INFO - Running setup.py install for moztest 10:40:01 INFO - Running setup.py install for mozversion 10:40:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:40:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:40:01 INFO - Cleaning up... 10:40:01 INFO - Return code: 0 10:40:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:40:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:40:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:40:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:40:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:01 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 0x10e7d2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7da4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8a9cadf60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e676d30>, '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 0x10e49adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e66db20>, '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.7vIJXobspg/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.sQsLH9hmOo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 10:40:01 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 10:40:01 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 10:40:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7vIJXobspg/Render', 10:40:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:40:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:40:01 INFO - 'HOME': '/Users/cltbld', 10:40:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:40:01 INFO - 'LOGNAME': 'cltbld', 10:40:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:40:01 INFO - 'MOZ_NO_REMOTE': '1', 10:40:01 INFO - 'NO_EM_RESTART': '1', 10:40:01 INFO - 'PAGER': '/bin/cat', 10:40:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:40:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:40:01 INFO - 'PWD': '/builds/slave/test', 10:40:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:40:01 INFO - 'SHELL': '/bin/bash', 10:40:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sQsLH9hmOo/Listeners', 10:40:01 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 10:40:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:40:01 INFO - 'USER': 'cltbld', 10:40:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:40:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:40:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:40:01 INFO - 'XPC_FLAGS': '0x0', 10:40:01 INFO - 'XPC_SERVICE_NAME': '0', 10:40:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:40:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:40:02 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-BQgrZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:40:02 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)) 10:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:40:02 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-pR2nCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:40:02 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)) 10:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:40:02 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-hget6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:40:02 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)) 10:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:40:02 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-_Mkl_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:40:02 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)) 10:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:40:02 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-xwUWIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:40:02 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)) 10:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:40:02 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-Il0bGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:40:02 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)) 10:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:40:02 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-orq2jv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:40:02 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)) 10:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:40:02 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-mfiteI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:40:03 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)) 10:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:40:03 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-C2UGAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:40:03 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)) 10:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:40:03 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-pwgrTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:40:03 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)) 10:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:40:03 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-_1_K4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:40:03 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)) 10:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:40:03 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-rK0zzZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:40:03 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)) 10:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:40:03 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-S2loyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:40:03 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)) 10:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:40:03 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-2QfyC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:40:03 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)) 10:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:40:03 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-acm_lg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:40:03 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)) 10:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:40:03 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-WtqjHy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:40:03 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)) 10:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:40:03 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-CD7HZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:40:03 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)) 10:40:03 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)) 10:40:03 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)) 10:40:03 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)) 10:40:03 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)) 10:40:03 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)) 10:40:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:40:03 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 10:40:03 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 10:40:03 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 10:40:03 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 10:40:03 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 10:40:03 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 10:40:06 INFO - Downloading blessings-1.6.tar.gz 10:40:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:40:06 INFO - Installing collected packages: blessings 10:40:06 INFO - Running setup.py install for blessings 10:40:06 INFO - Successfully installed blessings 10:40:06 INFO - Cleaning up... 10:40:06 INFO - Return code: 0 10:40:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:40:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:40:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:40:06 INFO - Reading from file tmpfile_stdout 10:40:06 INFO - Current package versions: 10:40:06 INFO - blessings == 1.6 10:40:06 INFO - blobuploader == 1.2.4 10:40:06 INFO - docopt == 0.6.1 10:40:06 INFO - manifestparser == 1.1 10:40:06 INFO - mozInstall == 1.12 10:40:06 INFO - mozcrash == 0.16 10:40:06 INFO - mozdebug == 0.1 10:40:06 INFO - mozdevice == 0.48 10:40:06 INFO - mozfile == 1.2 10:40:06 INFO - mozhttpd == 0.7 10:40:06 INFO - mozinfo == 0.9 10:40:06 INFO - mozleak == 0.1 10:40:06 INFO - mozlog == 3.1 10:40:06 INFO - moznetwork == 0.27 10:40:06 INFO - mozprocess == 0.22 10:40:06 INFO - mozprofile == 0.28 10:40:06 INFO - mozrunner == 6.11 10:40:06 INFO - mozscreenshot == 0.1 10:40:06 INFO - mozsystemmonitor == 0.0 10:40:06 INFO - moztest == 0.7 10:40:06 INFO - mozversion == 1.4 10:40:06 INFO - psutil == 3.1.1 10:40:06 INFO - requests == 1.2.3 10:40:06 INFO - wsgiref == 0.1.2 10:40:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:40:06 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')]} 10:40:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:40:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:06 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')]} 10:40:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:40:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:06 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 0x10e7d2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7da4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8a9cadf60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e676d30>, '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 0x10e49adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e66db20>, '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.7vIJXobspg/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.sQsLH9hmOo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 10:40:06 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 10:40:06 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 10:40:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7vIJXobspg/Render', 10:40:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:40:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:40:06 INFO - 'HOME': '/Users/cltbld', 10:40:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:40:06 INFO - 'LOGNAME': 'cltbld', 10:40:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:40:06 INFO - 'MOZ_NO_REMOTE': '1', 10:40:06 INFO - 'NO_EM_RESTART': '1', 10:40:06 INFO - 'PAGER': '/bin/cat', 10:40:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:40:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:40:06 INFO - 'PWD': '/builds/slave/test', 10:40:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:40:06 INFO - 'SHELL': '/bin/bash', 10:40:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sQsLH9hmOo/Listeners', 10:40:06 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 10:40:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:40:06 INFO - 'USER': 'cltbld', 10:40:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:40:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:40:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:40:06 INFO - 'XPC_FLAGS': '0x0', 10:40:06 INFO - 'XPC_SERVICE_NAME': '0', 10:40:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:40:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:40:07 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)) 10:40:07 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)) 10:40:07 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)) 10:40:07 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)) 10:40:07 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)) 10:40:07 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)) 10:40:07 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)) 10:40:07 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)) 10:40:07 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)) 10:40:07 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)) 10:40:07 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)) 10:40:07 INFO - Cleaning up... 10:40:07 INFO - Return code: 0 10:40:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:40: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')]} 10:40:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:40:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40: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')]} 10:40:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:40:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:07 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 0x10e7d2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7da4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8a9cadf60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e676d30>, '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 0x10e49adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e66db20>, '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.7vIJXobspg/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.sQsLH9hmOo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 10:40:07 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 10:40:07 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 10:40:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7vIJXobspg/Render', 10:40:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:40:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:40:07 INFO - 'HOME': '/Users/cltbld', 10:40:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:40:07 INFO - 'LOGNAME': 'cltbld', 10:40:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:40:07 INFO - 'MOZ_NO_REMOTE': '1', 10:40:07 INFO - 'NO_EM_RESTART': '1', 10:40:07 INFO - 'PAGER': '/bin/cat', 10:40:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:40:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:40:07 INFO - 'PWD': '/builds/slave/test', 10:40:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:40:07 INFO - 'SHELL': '/bin/bash', 10:40:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sQsLH9hmOo/Listeners', 10:40:07 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 10:40:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:40:07 INFO - 'USER': 'cltbld', 10:40:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:40:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:40:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:40:07 INFO - 'XPC_FLAGS': '0x0', 10:40:07 INFO - 'XPC_SERVICE_NAME': '0', 10:40:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:40:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:40:07 INFO - Downloading/unpacking jsonschema 10:40:07 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 10:40:07 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 10:40:07 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 10:40:07 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 10:40:07 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 10:40:07 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 10:40:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:40:09 INFO - Downloading/unpacking functools32 (from jsonschema) 10:40:09 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 10:40:09 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 10:40:09 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 10:40:09 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 10:40:09 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 10:40:09 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 10:40:10 INFO - Downloading functools32-3.2.3-2.tar.gz 10:40:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:40:10 INFO - warning: no files found matching '*.txt' 10:40:10 INFO - no previously-included directories found matching 'build' 10:40:10 INFO - no previously-included directories found matching 'dist' 10:40:10 INFO - no previously-included directories found matching '.git*' 10:40:10 INFO - Installing collected packages: jsonschema, functools32 10:40:10 INFO - Running setup.py install for functools32 10:40:10 INFO - warning: no files found matching '*.txt' 10:40:10 INFO - no previously-included directories found matching 'build' 10:40:10 INFO - no previously-included directories found matching 'dist' 10:40:10 INFO - no previously-included directories found matching '.git*' 10:40:10 INFO - Successfully installed jsonschema functools32 10:40:10 INFO - Cleaning up... 10:40:10 INFO - Return code: 0 10:40:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:40:10 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')]} 10:40:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:40:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:10 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')]} 10:40:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:40:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:10 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 0x10e7d2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7da4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8a9cadf60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e676d30>, '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 0x10e49adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e66db20>, '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.7vIJXobspg/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.sQsLH9hmOo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 10:40:10 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 10:40:10 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 10:40:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7vIJXobspg/Render', 10:40:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:40:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:40:10 INFO - 'HOME': '/Users/cltbld', 10:40:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:40:10 INFO - 'LOGNAME': 'cltbld', 10:40:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:40:10 INFO - 'MOZ_NO_REMOTE': '1', 10:40:10 INFO - 'NO_EM_RESTART': '1', 10:40:10 INFO - 'PAGER': '/bin/cat', 10:40:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:40:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:40:10 INFO - 'PWD': '/builds/slave/test', 10:40:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:40:10 INFO - 'SHELL': '/bin/bash', 10:40:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sQsLH9hmOo/Listeners', 10:40:10 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 10:40:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:40:10 INFO - 'USER': 'cltbld', 10:40:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:40:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:40:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:40:10 INFO - 'XPC_FLAGS': '0x0', 10:40:10 INFO - 'XPC_SERVICE_NAME': '0', 10:40:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:40:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:40:11 INFO - Downloading/unpacking flake8 10:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:40:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:40:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:40:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:40:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:40:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:40:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:40:13 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 10:40:13 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 10:40:13 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 10:40:13 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 10:40:13 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 10:40:13 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 10:40:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:40:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:40:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:40:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:40:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:40:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:40:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:40:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:40:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:40:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:40:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:40:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:40:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:40:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:40:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:40:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:40:14 INFO - no previously-included directories found matching 'docs/_build' 10:40:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:40:15 INFO - Running setup.py install for pep8 10:40:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:40:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:40:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:40:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:40:15 INFO - no previously-included directories found matching 'docs/_build' 10:40:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:40:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:40:15 INFO - Cleaning up... 10:40:15 INFO - Return code: 0 10:40:15 INFO - Running post-action listener: _resource_record_post_action 10:40:15 INFO - Running post-action listener: _start_resource_monitoring 10:40:15 INFO - Starting resource monitoring. 10:40:15 INFO - ##### 10:40:15 INFO - ##### Running install step. 10:40:15 INFO - ##### 10:40:15 INFO - Running pre-action listener: _resource_record_pre_action 10:40:15 INFO - Running main action method: install 10:40:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:40:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:40:15 INFO - Reading from file tmpfile_stdout 10:40:15 INFO - Detecting whether we're running mozinstall >=1.0... 10:40:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:40:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:40:15 INFO - Reading from file tmpfile_stdout 10:40:15 INFO - Output received: 10:40:15 INFO - Usage: mozinstall [options] installer 10:40:15 INFO - Options: 10:40:15 INFO - -h, --help show this help message and exit 10:40:15 INFO - -d DEST, --destination=DEST 10:40:15 INFO - Directory to install application into. [default: 10:40:15 INFO - "/builds/slave/test"] 10:40:15 INFO - --app=APP Application being installed. [default: firefox] 10:40:15 INFO - mkdir: /builds/slave/test/build/application 10:40:15 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'] 10:40:15 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 10:40:49 INFO - Reading from file tmpfile_stdout 10:40:49 INFO - Output received: 10:40:49 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:40:49 INFO - Running post-action listener: _resource_record_post_action 10:40:49 INFO - ##### 10:40:49 INFO - ##### Running run-tests step. 10:40:49 INFO - ##### 10:40:49 INFO - Running pre-action listener: _resource_record_pre_action 10:40:49 INFO - Running main action method: run_tests 10:40:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:40:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:40:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:40:49 INFO - 2016-02-12 10:40:49.506 screenresolution[1648:7509] starting screenresolution argv=screenresolution get 10:40:49 INFO - 2016-02-12 10:40:49.508 screenresolution[1648:7509] Display 0: 1600x1200x32@60 10:40:49 INFO - 2016-02-12 10:40:49.514 screenresolution[1649:7511] starting screenresolution argv=screenresolution list 10:40:49 INFO - Available Modes on Display 0 10:40:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:40:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:40:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:40:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:40:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:40:49 INFO - Intel Iris: 10:40:49 INFO - Chipset Model: Intel Iris 10:40:49 INFO - Type: GPU 10:40:49 INFO - Bus: Built-In 10:40:49 INFO - VRAM (Dynamic, Max): 1536 MB 10:40:49 INFO - Vendor: Intel (0x8086) 10:40:49 INFO - Device ID: 0x0a2e 10:40:49 INFO - Revision ID: 0x0009 10:40:49 INFO - Displays: 10:40:49 INFO - Display: 10:40:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:40:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:40:49 INFO - Display Serial Number: 1600x1200 60 10:40:49 INFO - Main Display: Yes 10:40:49 INFO - Mirror: Off 10:40:49 INFO - Online: Yes 10:40:49 INFO - Rotation: Supported 10:40:49 INFO - Return code: 0 10:40:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:40:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:40:49 INFO - Python 2.7.3 10:40:49 INFO - Return code: 0 10:40:49 INFO - grabbing minidump binary from tooltool 10:40:49 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')]} 10:40:49 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 0x10e676d30>, '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 0x10e49adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e66db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:40:49 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 10:40:49 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 10:40:49 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:40:49 INFO - Return code: 0 10:40:49 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:40:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:40:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:40:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:40:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:40:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:40:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:40:51 INFO - Return code: 0 10:40:51 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/WCgrczzaQ0C7quE4c89qGQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0121', '--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 10:40:51 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/WCgrczzaQ0C7quE4c89qGQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0121 --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 10:40:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7vIJXobspg/Render', 10:40:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:40:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:40:51 INFO - 'HOME': '/Users/cltbld', 10:40:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:40:51 INFO - 'LOGNAME': 'cltbld', 10:40:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:40:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:40:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:40:51 INFO - 'MOZ_NO_REMOTE': '1', 10:40:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:40:51 INFO - 'NO_EM_RESTART': '1', 10:40:51 INFO - 'PAGER': '/bin/cat', 10:40:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:40:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:40:51 INFO - 'PWD': '/builds/slave/test', 10:40:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:40:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:40:51 INFO - 'SHELL': '/bin/bash', 10:40:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sQsLH9hmOo/Listeners', 10:40:51 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 10:40:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:40:51 INFO - 'USER': 'cltbld', 10:40:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:40:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:40:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:40:51 INFO - 'XPC_FLAGS': '0x0', 10:40:51 INFO - 'XPC_SERVICE_NAME': '0', 10:40:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:40:51 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/WCgrczzaQ0C7quE4c89qGQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0121', '--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 10:40:51 INFO - mozversion application_buildid: 20160212085824 10:40:51 INFO - mozversion application_changeset: e64c1c00081fb56bd108e112fa7ad05bf10fddcd 10:40:51 INFO - mozversion application_display_name: Nightly 10:40:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:40:51 INFO - mozversion application_name: Firefox 10:40:51 INFO - mozversion application_remotingname: firefox 10:40:51 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:40:51 INFO - mozversion application_vendor: Mozilla 10:40:51 INFO - mozversion application_version: 47.0a1 10:40:51 INFO - mozversion platform_buildid: 20160212085824 10:40:51 INFO - mozversion platform_changeset: e64c1c00081fb56bd108e112fa7ad05bf10fddcd 10:40:51 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:40:51 INFO - mozversion platform_version: 47.0a1 10:40:51 INFO - using testdate: 1455302451 10:40:51 INFO - actual date: 1455302451 10:40:51 INFO - starting webserver on 'localhost:49278' 10:40:51 INFO - SUITE-START | Running 2 tests 10:40:51 INFO - TEST-START | dromaeo_css 10:40:51 INFO - operating with platform_type : mac_ 10:40:51 INFO - Initialising browser for dromaeo_css test... 10:40:51 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/tmpurgP7M/profile http://localhost:49278/getInfo.html) 10:40:53 INFO - PROCESS | 1667 | __metrics Screen width/height:1600/1200 10:40:53 INFO - PROCESS | 1667 | colorDepth:24 10:40:53 INFO - PROCESS | 1667 | Browser inner width/height: 1024/689 10:40:53 INFO - PROCESS | 1667 | __metrics 10:40:53 INFO - PROCESS | 1667 | 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" 10:40:53 INFO - PROCESS | 1667 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:40:54 INFO - TEST-INFO | 1667: exit 0 10:40:54 INFO - Browser initialized. 10:40:54 INFO - Running cycle 1/1 for dromaeo_css test... 10:40:54 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/tmpurgP7M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:41:06 INFO - PROCESS | 1670 | RSS: Main: 247013376 10:41:06 INFO - PROCESS | 1670 | 10:41:57 INFO - PROCESS | 1670 | 1455302517255 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] 10:44:07 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 10:44:09 INFO - PROCESS | 1670 | RSS: Main: 380997632 10:44:09 INFO - PROCESS | 1670 | 10:47:11 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 10:47:12 INFO - PROCESS | 1670 | RSS: Main: 383758336 10:47:12 INFO - PROCESS | 1670 | 10:50:14 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 10:50:15 INFO - PROCESS | 1670 | RSS: Main: 381149184 10:50:15 INFO - PROCESS | 1670 | 10:53:17 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 10:53:17 INFO - PROCESS | 1670 | RSS: Main: 350232576 10:53:17 INFO - PROCESS | 1670 | 10:56:20 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 10:56:21 INFO - PROCESS | 1670 | RSS: Main: 350986240 10:56:21 INFO - PROCESS | 1670 | 10:59:24 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 10:59:24 INFO - PROCESS | 1670 | RSS: Main: 384716800 10:59:24 INFO - PROCESS | 1670 | 10:59:24 INFO - PROCESS | 1670 | __start_tp_report 10:59:24 INFO - PROCESS | 1670 | _x_x_mozilla_page_load 10:59:24 INFO - PROCESS | 1670 | _x_x_mozilla_page_load_details 10:59:24 INFO - PROCESS | 1670 | |i|pagename|runs| 10:59:24 INFO - PROCESS | 1670 | |0;dojo.html;3417.743669224808;3487.7384196185294;3512.718982481401;3517.665821746933;3555.71554275658;5552.472515111058;5613.80351687691;5616.803411880585;5647.209390685307;5648.983183027053;5639.520640745542;5649.49154576088;5688.402717714643;5805.448482394166;5811.941880581193;5057.620678449112;5092.032513822372;5126.128558145124;5144.8713782155555;5209.7134657593815;5168.405633352175;5175.948240517584;5225.738713064351;5245.4754524547625;5296.629235953485;5032.043911656773;5092.414372347172;5113.872153196163;5126.359205099363;5177.48225177483;5120.513551212629;5139.100657384943;5150.819721309774;5160.096983027993;5180.792768289264;5057.988402319514;5145.279660847485;5145.691258524501;5154.5103215194495;5158.484151584849;5463.590230732711;5531.2809334786625;5622.353429355636;5676.489115979582;5690.06113991191;6126.23422072241;6163.106349579286;6172.1667574877265;6181.783637572664;6186.474149697281;5384.111621582434;6204.689765511752;6231.40801623845;6250.843728906768;6255.937440625581;5592.5246354059545;5637.379888212294;5679.829605111853;5685.431456854323;5695.971520142414;4788.545088216614;4903.215485522299;6238.719257633417;6294.905576416358;6307.369263073748;5839.649621022752;5962.07587823888;5986.880262394728;6079.908801367983;6084.300305464928;6106;6169.96915015422;6200.131981522591;6206.255249370104;6243.781467648701;5983.341832398432;5998.310194327621;5999.820005399845;6000.309964354068;6004.669743164168;6015.879682406327;6023.1266466363;6027.276726792726;6033.155358249848;6033.668148251888;4797.616190704735;4800.039992001613;4810.927836082462;4819.180739274332;4821.300911367832;3797.1076796952693;4230.2174097792;4258.914821703549;4350.782460877007;4386.605205531518;5649.293838270216;5649.830505084854;5670.489655930904;5676.829695109153;5687.516561092353;6104.671374792629;6163.476104531075;6166.414190651881;6205.937940620536;6213;5732.254806875079;5754.251947246915;5771.134329850472;5788.45009724084;5814.6220495668495;5306.230596563554;5332.30680011596;5341.332333458317;5345.812896548602;5361.142217245222;6189.96905015463;6281.214848143982;6298.433141017331;6311.873762524724;6355.555111142268;5191.714455704821;6240.375962403723;6255.249370075438;6262.3737626238835;6273.843153921189;6302.590331628429;6338;6340.746370145327;6350.460210882126;6350.7142178603;5073.847784566469;6016.909746353721;6113.388661133851;6130.693465326805;6191.133241346125;6229.501639868709;6238.126662267196;6241.3134555197985;6257.1552840367785;6257.624542527463;5190.2214667800135;6024.90962635552;6098.664573448503;6107.389261073857;6121.0206366981065;5574.5261652758345;5720.141978703228;6029.216201893726;6108.053251745987;6140.109684095871;5901;5906.940930590811;5917.3490915998345;5922.881542369215;5931.703414829328;5868.647881127146;6049.727762250621;6059.666718330534;6113.23584551931;6131.110988906673;5874.324452687824;5911.556633252438;5928.822135335947;5953.345132035386;6024.548158888013 10:59:24 INFO - PROCESS | 1670 | |1;ext.html;462.027432255103;467.1241422333125;499.70517394737107;532.6431291035007;565.0168706450776;27321.907123715053;30101.096967090994;36962.63037369626;37723;37798.67704630338;40109;40519;40571.59428405715;40599;40681.169347379364;9510;9724.805503889918;9734.951325243364;9743.853842192373;9749.366291191085;9505.667301644444;9640.180584650314;9642.228621710246;9652.227821774277;9664.178544823699;9739.51302434879;9818.410895346266;9825.312228144032;9837.213022958145;9849.507524623776;9655.710328690151;9738.513074346254;9741.464219467927;9742.318037737326;9768.706938791847;9639.325247232697;9776.560054797552;9789.461579613118;9800.803983920354;9810.018998100204;39438;39720;39783.40324895129;39810.20379592392;39858.20283594312;2655.8539280339573;2757.600147978552;3289.6216935052535;3571.8571257149683;3776.376897811858;27732.30669233265;28249.321096553067;28290.717092829014;28293.575596365867;29653.851730741422;2736.493748656505;2766.833989960609;2794.6646402431634;2862.355969906775;2902.3034471726633;358959;359558;359682;359708;360369.19815400755;60680;60919.390806092255;61192;61227.775444490864;61282.693586532674;64180.35819641837;64389.678051609444;64427;64464.67767661132;64552.35447645558;16427.425040123537;16624.50126496207;16630.66738665244;16647.83352166463;16660.41688540895;12702.87297127017;12738;12753.043521735906;12763.170393924365;12766.61700148997;14798.556043318718;17686.695219095775;18778.436646900616;19207.903960480107;19244.518887027938;7255.637218139072;8419.579021048923;8669.60986755585;8700.477971321741;8750.95624521886;855.5337341148964;933.9813203735887;999.195647503752;1049.5277125293496;1075.6289080267295;24718.876405617855;24974.37564060913;28506.42987140287;28724.712752872623;29809;1026.4559783314855;1039.6725031615017;1111.0278506306981;1130.3726431830414;1158.9942050289694;13959.720805584035;14166.433342666178;14440.494582689555;15304.846951530564;15374.154421506924;434649;439307.62423315033;439424;439726;683883.5805820939;47365.76317118392;55683.72158139183;56782;56799.71600141973;56939;1337.6054064050934;1372.8009438631343;1427.4290283886528;1451.796748455217;1572.1667516216423;20997.685034724796;24688;25871.353216169748;25873.09444169445;27738.722612773614;47409.762951185025;47860.04279914452;47883.28175077446;47892.76053619709;47903.5209647913;423818;432034;432612;432858;433056;29890.70109298879;30160.84919575388;30225.848870755504;30245.09264722062;30284;40988;42814.92962675958;42918.35622465603;43213.351799723656;43394.78302608467;32497.837510812296;35283.647163529065;36311.81844090763;36334.273314533035;36390;30954;35508.289834203686;35738.64261357457;35783.642163579076;35997.82001089978;34888.302233955685;35637.82181089078;35837;35960.46059309165;35997.82001089978;30280.697193027787;31338.843305783324;31459.59565660855;31492.842535787175;31523;20936.68594971107;24111;24140.51718965576;24297.514049718553;24789.50420991606 10:59:24 INFO - PROCESS | 1670 | |2;jquery.html;361.1999421281862;362.8004597471391;364.5060942423017;367.9043448703337;369.51224383813343;14943.701125977474;15556.688866222668;18770.624587508242;19882.801171988274;20405.183792648295;19527.707084393747;19938.102785374656;20202.888841113734;20230.696539551882;20423.897880510613;5301.3373328333955;6543.280239173687;6546.378094081055;6550.901736473957;6554.442872355831;4545.159145558082;4702.741349225791;6489.091527186198;7054.18876829166;7439.4792364534505;7134.250903655119;7280;7380.852382952337;7405.740799072034;7409;4501.729896206238;5789.305283366023;7332.340089391953;7350.375218106467;7352.595607241573;5504.724763761796;5559.555235581144;5560.805371811967;5564.221009058735;5569.693666848321;13057.934710326483;14399.712005759826;16597.91701041487;18387;23724;2062.6905964105504;2154.4613846538364;2394.4253379189045;2439.499902519979;2651.8331933949003;9808.068233517804;10132.34139780912;11582.478788454455;11919;13369.197848129143;1718.2611477064856;1732.523556022104;1749.860011199101;1756.7277072053853;1773.4147731248656;92346;92385.53807230988;93775;94769;98222;10709.839352409721;10994.395308257963;11078.446077696082;11102.111831053497;11192.216544841784;13181.868181318256;13298.468061277634;13305.93347033278;13309.267990260629;13327.533536326182;6814.352636499525;8399.328053755808;8402.453840500348;8479;8502.319814414832;8671.34964877624;8678.739637810875;8679.566021698889;8772.166644168794;8780.429272097294;4089.2230476209425;4228.8308467660945;4285.057287396768;4418.116376724668;4564.908701826012;1777.2802015183872;1826.7625208723048;1835.5869929266075;1854.7959724430302;1860.8325250727228;833.9291160251325;954.8854137503544;982.7199248214224;1028.1671845804922;1031.4120951057976;16138.838611613734;20321.89839050825;20508;20668.276610318866;20776.1689532417;921.5898924978454;943.2548286853446;993.9403635781877;1007.7984403119406;1020.9841207997941;9220.077374067738;10290.485475726184;10534.73663158412;11156.832647510293;11216.439178041066;628948;713359;717037;720346;732179;109665.35501967477;110877.44561277142;111886.44056779664;112144;112292;1138.7608602193466;1165.4638866121509;1185.8754830742648;1195.3843770458047;1199.6041306368877;17467.650646986735;17813.73279400784;18017.81982180214;18443.89336639806;18484.81515184831;50693.49306506888;51596;51851.48148518467;52563.73718131538;53884.38346849601;65283.67358163179;65680.014799779;66545.66727166333;69051.05912819889;69708.30291697221;6419.518536109717;7358.190599033995;7424.665890035069;7635.580043097683;7821.530708157528;5884.823035393024;9228.40015398997;11235.15736319763;11858.208881269304;11984.64046078619;9780.951095244478;10237.744056398351;10301.845472318071;10397.740056498647;10600;7317.963410182915;10084.991500849856;10190.3505088676;10307.072363487323;10332.91504392058;9017.594208260512;10377.066064054272;10395.116415104801;10665.9466702666;10998.615048473264;7511.3615342696485;7584.355329796808;7646.617669116411;7667.386609071149;7710.961445192738;8798.988116366443;9755.365901216399;10157.187425005834;10262.897371026493;10584.735381615521 10:59:24 INFO - PROCESS | 1670 | |3;mootools.html;1399.048646920094;1517.142814309915;1549.6125968507872;1778.9021603811793;1930.3629802165287;7684.269994350535;7876.645550950207;7877.684892604296;7893.526388416699;7896.684132634688;8051.315638170762;8086.514809111442;8261.834763304745;8264.768512501636;8278.254957053863;2404.591219492682;2441.8534887906694;2445.4375493636476;2448.8897999590063;2451;2141.0365335598963;2195;2383.368407372048;2418.504206637635;2434;2339.5320935812906;2404.110479122727;2411.590029694947;2413.891374888134;2422.200673777658;2133.903974321144;2376.4415362389823;2381.44036151506;2386.3795413192606;2389.593769059264;2163.167180635451;2382.070992312982;2426.720927093389;2433.5741245282006;2435.0138194031447;8251.711190108377;8319.168083191693;8325.542095184763;8340.416170868042;8351.039630442516;5122.820701275475;5236.21456781482;5248.448912864133;5249.396319423277;5264.684118952837;3455.58532976042;3531.823408829574;3576.2311103112697;3651.379265524867;3670.1925576373155;1052.2371280821344;1069.5775168808354;1074.9946250268777;1076.6285631457135;1079.6976846482996;11488.253263537843;11489.482973266224;11501.827472587835;11508.654740357802;11514.94242528782;4676.50896655853;4765.594924431392;4841.15279826029;4844.467108618049;4847.878803029953;9792.314537982273;9812.460314682761;9821.705348839547;9831.115199632068;9839.80320393588;5338.279332290169;5374.435684253175;5381.219723140122;5405.594580406485;5433.538149257357;4845.6608037437745;4849.418069831643;4856.562909338177;4858.149823780825;4868.075065737498;3154.242981684379;3637.4907512948207;3722.664960153599;3754.342989976743;3787.242551489713;1167.7563394984315;1171.7129303320742;1174.788538063157;1177.5584155941522;1190;1304.5955753716378;1314.3625341709264;1318.4330737782846;1321.2931081871345;1353.316575129573;7748.883766743504;7774.689012439552;7815.53106813593;7872.055353357519;7947.125816160218;1185.8043422835308;1187.6733898177897;1189.976200476003;1204.151073493185;1222.2116734706065;5705.600607957404;5814.767409303665;6093.146959425684;6192.81421557354;6298.779542715983;8700.912990870136;9922.958089400654;10051.24615653829;10271.126954208976;10305.587776488857;10215.02957219063;10216.233782466345;10222.182225421948;10234.437105959094;10235.027672371112;7827.686892524349;7855.214478552099;7882.802929926683;7999.240072193133;8015.959920200362;7847.254510821463;7895.1315355309725;7911.406644501801;7918.524888506708;7919.683212671659;9026.18764311215;9159.038300978567;9437.764055898382;9458.006909274702;9471.10024547667;9447.81104377895;9801.264905132286;9802.509874506104;9812.754681133028;9829.655962041294;6752.527323087336;6817.659117044227;6840.042394064735;6852.6916288768125;6854.314568543105;7904.249096335839;7934.761957141295;7946.8807967881685;8010.038795344363;8010.719624813103;6380.649064301508;7504.099508059068;7536.660850261642;7698.92301076982;7703.422243331885;6372.87254254903;7348.448866334939;7403.962980185064;7407.8148046299275;7619.847603048019;7500.849983000418;7560.243975602396;7574.924250757422;7579.696812127453;7581.583012934121;6758.155230596176;6902.482313826383;6913.170419549485;6926.653667316513;6931.480138989495;6351.07909353132;6945.826354340979;6997.965010174917;7022.2275549688475;7023.894641580278 10:59:24 INFO - PROCESS | 1670 | |4;prototype.html;318.2695713337889;322.5307178055929;327.88360132153093;330.69080409816837;333.8581103031211;6380.872382552347;6559.60642361458;6572.3427657234315;6598.703058362374;6625.304343043983;6308;6493.1558897343275;6506.642134682591;6514.706838192281;6564.04821300911;4011.518617765872;4787.042591481701;4816.590589799863;4848.684835485682;4877.146499362615;4619.976900115512;4716.410448693913;4731.550502702238;4874.707517548958;4888.682235654689;4558.954410455886;4716.4340279166545;4830.227163653816;4847.03059388122;4854.36893203883;4817.951820481803;4821.686590371614;4828.74452642312;4831.806727730886;4888.902221955576;4157.5010998680045;4164.5210800757695;4170.457840480748;4176.937345939813;4176.979115104436;6167.4757645600175;6369.267534233576;6388;6399.168108145911;6420.101185833941;5697.743601537941;5702.287214098238;5703.5437165027115;5723.885522289573;5729.169270455761;6937.930620693779;6945.652717364112;6959.721611135548;6961.965190174067;6975.860482790366;3852.2680690668963;4634.9073018539775;4637.142128706167;4649.767511624405;4651.046535460223;7028.437724981989;7085.078939737801;7240.348368646794;7397.556146631219;7444.851102977965;4588.701734387254;4645.954660201495;4713.505081966413;4720.527947205252;4730.455997560324;4757.429108507002;4795.112904112751;4801.039792041605;4811.676788883015;4847.854564363075;5661.518770904519;5674.120511320752;5674.602777805597;5688.800891968761;5703.17303990919;6807.931920680829;6954.095967524189;6980.197277313174;7000.824979375557;7003.754868579677;1669.3656410564151;1689.3073839725653;1689.7803285572797;1690.2900781671729;1692.2976964559816;1087.7552550676035;1089.0470838016736;1105.4638500327335;1114.2979922648678;1116.6817457024708;5413.296271484682;6605;6621.536492445579;6636.634985075771;6643.036759669821;7255.963720181471;7265.2371500992695;7269.781906542812;7279.090113735783;7285.271472852778;5496.285482887199;6352.2694890087305;6577.967110164514;6591.769288074895;6625.138731964814;3835.9041023974064;3866.0914685048992;3867.7099217558793;3868.2263547290654;3874.9612503875164;6108.480779133734;7603.543787372775;7610.8097297568;7657.57883316423;7677.539347639159;6000.249968753906;7260.600666963368;7482.551046937201;7487.812804679927;7497.1753107158165;7596.696132154762;7611.961940190264;7618.733344332922;7627.466077374753;7637.274458926393;7236.2401947796825;7256.96371518139;7262.237465066092;7263.309985551364;7277.490575659653;5732.484076433141;6875.1749790025515;7135.464840136907;7139.535930164523;7143.4999550031;6133.601315914451;7428.33145016951;7475.289847464483;7481;7601.049868766404;4742.549457801503;4769.093872164278;4781.2350023996;4791;4805.783739731651;6083.330833608388;7134.286571342825;7175.748848790267;7193.064901562763;7270.091238595176;6849.1438570178725;7034.753783617549;7041.225465198721;7047.894281585678;7058.294170582901;5995.820125396245;6803.353681400259;7058.858822823618;7070.929290707233;7071.434285257064;6875.759348422981;6899.689513971783;6900.689468973807;6902.274431392152;6914;6809.353111454404;7071.080759501232;7071.434285257064;7086.893696594659;7111.9288807113335;6947.44420446353;6955.061066755923;6960.965195173992;6983.860322793617;6997 10:59:24 INFO - PROCESS | 1670 | |5;yui.html;733.6551820644298;742.7660287009592;745.5377665847176;757.9924200757993;782.6086956521739;16716;16986.49040528783;16996.49010529683;17026.91486542567;17064.402745903895;15346.616334591641;15347.769783453257;15367.846321536781;15371.23230828455;15375.846241537582;697.3723648716145;701.1726163127507;845.2646197807916;850.6682393866397;859.7377799771067;843.7637461510756;849.9490030598184;855.2687452228317;857.618359829876;857.9056303806576;885.7032893980524;893.1158153428124;896.3187977137358;897.5512243878061;898.1781669772183;726.4406407066582;727.294524311417;731.2102928836844;731.6707481633233;731.9707211711525;586.7389011889711;652.5627829354344;662.1855118204635;662.9237637671681;663.6051549328142;14743.926280368636;14816.777748333783;14828.481003164838;14847.851521484756;14871.925640371837;12055.095867809949;12207.816882746765;12307.138500304982;12462.12765106443;12700.1744886583;9682.612695492171;9960.800783984352;10044.146247568966;10114.391914052068;10190.184785217165;3435.261418794971;3470.687638112582;3473.426884564044;3478.7912725236565;3479.652034796525;70688.6465567674;71115;72097.63951180315;72287.63856180738;72371;9185.724428267162;9195.402298850553;9215.49314787693;9367.765805854908;9454.33819632633;16822.411215607393;20545.48636284105;20565.89717051405;20611.58776824455;20637;6898.586084834926;6975.197852246955;7016.929830701628;7263.818404539928;7371.557706537517;3658.8719394821587;4149.502059752849;4156.833726650961;4161.83352665896;4164.4586203793315;3467.2718729066673;3532.8056956867617;3535.611082780892;3541.8052007139854;3550.2012047289154;634.5875181132301;634.8857205702925;643.1831573901119;656.3075954867566;671.717878491035;546.8687514996373;593.9198208241831;601.485729701108;622.8100429368995;625.4714766022704;8560.957195214109;8587.914120858712;8737.563121843883;8841.425307355;8913;514.9176131818966;572.5934586443589;604.9788257410969;617.4967401567798;622.707327556048;3919.5884432134217;4007.1785284016705;4009.4587230724064;4126.938095928564;4169.958300417018;85877;86094;86749.56625216834;86860;88195.11804881998;72575;73432.89850652244;73768.26231737722;74134.25865741381;74218.62890685513;65485.67257163684;65665.01502477466;66016;66708;66783.33216667868;7264.200937896932;8152.510849349058;8372.623231954454;8499.915000849913;8756.51839148853;45355.31967020431;45767.54232457633;46198.53801461942;47431.051378972916;48206.75896620635;61283.38716612955;61963.6901815488;65064.37339066561;65503;65575;10736.83894741564;10765.89234107649;10971.615993440191;11015.614453494089;11323.036937071958;11940.10449216295;11988.64034078979;11990.760184796429;11993.580224692094;11999.1600587958;11378.943105284421;11392.031677307521;11420.257683250895;11437.714057148638;11449;9703.514824258618;11162.665120046411;11455.484503197209;11629.302241865515;11964.76070478603;9705.915906531827;10271.178305735373;11148.609798657008;11473.254238474472;12124.454399552218;8117.822915677312;8263.256306932404;8972.19250267479;9181.403208791407;9331.766705832408;8533.696229816564;9884.456354900261;9931.851022234529;9973.69086017511;10122.848157277795 10:59:24 INFO - PROCESS | 1670 | __end_tp_report 10:59:24 INFO - PROCESS | 1670 | __start_cc_report 10:59:24 INFO - PROCESS | 1670 | _x_x_mozilla_cycle_collect,1151 10:59:24 INFO - PROCESS | 1670 | __end_cc_report 10:59:24 INFO - PROCESS | 1670 | __startTimestamp1455303564726__endTimestamp 10:59:24 INFO - PROCESS | 1670 | 10:59:24 INFO - PROCESS | 1670 | ------- Summary: start ------- 10:59:24 INFO - PROCESS | 1670 | Number of tests: 6 10:59:24 INFO - PROCESS | 1670 | 10:59:24 INFO - PROCESS | 1670 | [#0] dojo.html Cycles:165 Average:5650.52 Median:5814.62 stddev:637.79 (11.0%) stddev-sans-first:615.22 10:59:24 INFO - PROCESS | 1670 | Values: 3417.7 3487.7 3512.7 3517.7 3555.7 5552.5 5613.8 5616.8 5647.2 5649.0 5639.5 5649.5 5688.4 5805.4 5811.9 5057.6 5092.0 5126.1 5144.9 5209.7 5168.4 5175.9 5225.7 5245.5 5296.6 5032.0 5092.4 5113.9 5126.4 5177.5 5120.5 5139.1 5150.8 5160.1 5180.8 5058.0 5145.3 5145.7 5154.5 5158.5 5463.6 5531.3 5622.4 5676.5 5690.1 6126.2 6163.1 6172.2 6181.8 6186.5 5384.1 6204.7 6231.4 6250.8 6255.9 5592.5 5637.4 5679.8 5685.4 5696.0 4788.5 4903.2 6238.7 6294.9 6307.4 5839.6 5962.1 5986.9 6079.9 6084.3 6106.0 6170.0 6200.1 6206.3 6243.8 5983.3 5998.3 5999.8 6000.3 6004.7 6015.9 6023.1 6027.3 6033.2 6033.7 4797.6 4800.0 4810.9 4819.2 4821.3 3797.1 4230.2 4258.9 4350.8 4386.6 5649.3 5649.8 5670.5 5676.8 5687.5 6104.7 6163.5 6166.4 6205.9 6213.0 5732.3 5754.3 5771.1 5788.5 5814.6 5306.2 5332.3 5341.3 5345.8 5361.1 6190.0 6281.2 6298.4 6311.9 6355.6 5191.7 6240.4 6255.2 6262.4 6273.8 6302.6 6338.0 6340.7 6350.5 6350.7 5073.8 6016.9 6113.4 6130.7 6191.1 6229.5 6238.1 6241.3 6257.2 6257.6 5190.2 6024.9 6098.7 6107.4 6121.0 5574.5 5720.1 6029.2 6108.1 6140.1 5901.0 5906.9 5917.3 5922.9 5931.7 5868.6 6049.7 6059.7 6113.2 6131.1 5874.3 5911.6 5928.8 5953.3 6024.5 10:59:24 INFO - PROCESS | 1670 | 10:59:24 INFO - PROCESS | 1670 | [#1] ext.html Cycles:180 Average:57316.57 Median:36323.05 stddev:114977.11 (316.5%) stddev-sans-first:115220.41 10:59:24 INFO - PROCESS | 1670 | Values: 462.0 467.1 499.7 532.6 565.0 27321.9 30101.1 36962.6 37723.0 37798.7 40109.0 40519.0 40571.6 40599.0 40681.2 9510.0 9724.8 9735.0 9743.9 9749.4 9505.7 9640.2 9642.2 9652.2 9664.2 9739.5 9818.4 9825.3 9837.2 9849.5 9655.7 9738.5 9741.5 9742.3 9768.7 9639.3 9776.6 9789.5 9800.8 9810.0 39438.0 39720.0 39783.4 39810.2 39858.2 2655.9 2757.6 3289.6 3571.9 3776.4 27732.3 28249.3 28290.7 28293.6 29653.9 2736.5 2766.8 2794.7 2862.4 2902.3 358959.0 359558.0 359682.0 359708.0 360369.2 60680.0 60919.4 61192.0 61227.8 61282.7 64180.4 64389.7 64427.0 64464.7 64552.4 16427.4 16624.5 16630.7 16647.8 16660.4 12702.9 12738.0 12753.0 12763.2 12766.6 14798.6 17686.7 18778.4 19207.9 19244.5 7255.6 8419.6 8669.6 8700.5 8751.0 855.5 934.0 999.2 1049.5 1075.6 24718.9 24974.4 28506.4 28724.7 29809.0 1026.5 1039.7 1111.0 1130.4 1159.0 13959.7 14166.4 14440.5 15304.8 15374.2 434649.0 439307.6 439424.0 439726.0 683883.6 47365.8 55683.7 56782.0 56799.7 56939.0 1337.6 1372.8 1427.4 1451.8 1572.2 20997.7 24688.0 25871.4 25873.1 27738.7 47409.8 47860.0 47883.3 47892.8 47903.5 423818.0 432034.0 432612.0 432858.0 433056.0 29890.7 30160.8 30225.8 30245.1 30284.0 40988.0 42814.9 42918.4 43213.4 43394.8 32497.8 35283.6 36311.8 36334.3 36390.0 30954.0 35508.3 35738.6 35783.6 35997.8 34888.3 35637.8 35837.0 35960.5 35997.8 30280.7 31338.8 31459.6 31492.8 31523.0 20936.7 24111.0 24140.5 24297.5 24789.5 10:59:24 INFO - PROCESS | 1670 | 10:59:24 INFO - PROCESS | 1670 | [#2] jquery.html Cycles:180 Average:35940.29 Median:362.00 stddev:115799.46 (31988.8%) stddev-sans-first:116093.49 10:59:24 INFO - PROCESS | 1670 | Values: 361.2 362.8 364.5 367.9 369.5 14943.7 15556.7 18770.6 19882.8 20405.2 19527.7 19938.1 20202.9 20230.7 20423.9 5301.3 6543.3 6546.4 6550.9 6554.4 4545.2 4702.7 6489.1 7054.2 7439.5 7134.3 7280.0 7380.9 7405.7 7409.0 4501.7 5789.3 7332.3 7350.4 7352.6 5504.7 5559.6 5560.8 5564.2 5569.7 13057.9 14399.7 16597.9 18387.0 23724.0 2062.7 2154.5 2394.4 2439.5 2651.8 9808.1 10132.3 11582.5 11919.0 13369.2 1718.3 1732.5 1749.9 1756.7 1773.4 92346.0 92385.5 93775.0 94769.0 98222.0 10709.8 10994.4 11078.4 11102.1 11192.2 13181.9 13298.5 13305.9 13309.3 13327.5 6814.4 8399.3 8402.5 8479.0 8502.3 8671.3 8678.7 8679.6 8772.2 8780.4 4089.2 4228.8 4285.1 4418.1 4564.9 1777.3 1826.8 1835.6 1854.8 1860.8 833.9 954.9 982.7 1028.2 1031.4 16138.8 20321.9 20508.0 20668.3 20776.2 921.6 943.3 993.9 1007.8 1021.0 9220.1 10290.5 10534.7 11156.8 11216.4 628948.0 713359.0 717037.0 720346.0 732179.0 109665.4 110877.4 111886.4 112144.0 112292.0 1138.8 1165.5 1185.9 1195.4 1199.6 17467.7 17813.7 18017.8 18443.9 18484.8 50693.5 51596.0 51851.5 52563.7 53884.4 65283.7 65680.0 66545.7 69051.1 69708.3 6419.5 7358.2 7424.7 7635.6 7821.5 5884.8 9228.4 11235.2 11858.2 11984.6 9781.0 10237.7 10301.8 10397.7 10600.0 7318.0 10085.0 10190.4 10307.1 10332.9 9017.6 10377.1 10395.1 10665.9 10998.6 7511.4 7584.4 7646.6 7667.4 7711.0 8799.0 9755.4 10157.2 10262.9 10584.7 10:59:24 INFO - PROCESS | 1670 | 10:59:24 INFO - PROCESS | 1670 | [#3] mootools.html Cycles:180 Average:5857.29 Median:5393.41 stddev:3043.86 (56.4%) stddev-sans-first:3033.95 10:59:24 INFO - PROCESS | 1670 | Values: 1399.0 1517.1 1549.6 1778.9 1930.4 7684.3 7876.6 7877.7 7893.5 7896.7 8051.3 8086.5 8261.8 8264.8 8278.3 2404.6 2441.9 2445.4 2448.9 2451.0 2141.0 2195.0 2383.4 2418.5 2434.0 2339.5 2404.1 2411.6 2413.9 2422.2 2133.9 2376.4 2381.4 2386.4 2389.6 2163.2 2382.1 2426.7 2433.6 2435.0 8251.7 8319.2 8325.5 8340.4 8351.0 5122.8 5236.2 5248.4 5249.4 5264.7 3455.6 3531.8 3576.2 3651.4 3670.2 1052.2 1069.6 1075.0 1076.6 1079.7 11488.3 11489.5 11501.8 11508.7 11514.9 4676.5 4765.6 4841.2 4844.5 4847.9 9792.3 9812.5 9821.7 9831.1 9839.8 5338.3 5374.4 5381.2 5405.6 5433.5 4845.7 4849.4 4856.6 4858.1 4868.1 3154.2 3637.5 3722.7 3754.3 3787.2 1167.8 1171.7 1174.8 1177.6 1190.0 1304.6 1314.4 1318.4 1321.3 1353.3 7748.9 7774.7 7815.5 7872.1 7947.1 1185.8 1187.7 1190.0 1204.2 1222.2 5705.6 5814.8 6093.1 6192.8 6298.8 8700.9 9923.0 10051.2 10271.1 10305.6 10215.0 10216.2 10222.2 10234.4 10235.0 7827.7 7855.2 7882.8 7999.2 8016.0 7847.3 7895.1 7911.4 7918.5 7919.7 9026.2 9159.0 9437.8 9458.0 9471.1 9447.8 9801.3 9802.5 9812.8 9829.7 6752.5 6817.7 6840.0 6852.7 6854.3 7904.2 7934.8 7946.9 8010.0 8010.7 6380.6 7504.1 7536.7 7698.9 7703.4 6372.9 7348.4 7404.0 7407.8 7619.8 7500.8 7560.2 7574.9 7579.7 7581.6 6758.2 6902.5 6913.2 6926.7 6931.5 6351.1 6945.8 6998.0 7022.2 7023.9 10:59:24 INFO - PROCESS | 1670 | 10:59:24 INFO - PROCESS | 1670 | [#4] prototype.html Cycles:180 Average:5718.87 Median:6456.63 stddev:1802.47 (27.9%) stddev-sans-first:1761.35 10:59:24 INFO - PROCESS | 1670 | Values: 318.3 322.5 327.9 330.7 333.9 6380.9 6559.6 6572.3 6598.7 6625.3 6308.0 6493.2 6506.6 6514.7 6564.0 4011.5 4787.0 4816.6 4848.7 4877.1 4620.0 4716.4 4731.6 4874.7 4888.7 4559.0 4716.4 4830.2 4847.0 4854.4 4818.0 4821.7 4828.7 4831.8 4888.9 4157.5 4164.5 4170.5 4176.9 4177.0 6167.5 6369.3 6388.0 6399.2 6420.1 5697.7 5702.3 5703.5 5723.9 5729.2 6937.9 6945.7 6959.7 6962.0 6975.9 3852.3 4634.9 4637.1 4649.8 4651.0 7028.4 7085.1 7240.3 7397.6 7444.9 4588.7 4646.0 4713.5 4720.5 4730.5 4757.4 4795.1 4801.0 4811.7 4847.9 5661.5 5674.1 5674.6 5688.8 5703.2 6807.9 6954.1 6980.2 7000.8 7003.8 1669.4 1689.3 1689.8 1690.3 1692.3 1087.8 1089.0 1105.5 1114.3 1116.7 5413.3 6605.0 6621.5 6636.6 6643.0 7256.0 7265.2 7269.8 7279.1 7285.3 5496.3 6352.3 6578.0 6591.8 6625.1 3835.9 3866.1 3867.7 3868.2 3875.0 6108.5 7603.5 7610.8 7657.6 7677.5 6000.2 7260.6 7482.6 7487.8 7497.2 7596.7 7612.0 7618.7 7627.5 7637.3 7236.2 7257.0 7262.2 7263.3 7277.5 5732.5 6875.2 7135.5 7139.5 7143.5 6133.6 7428.3 7475.3 7481.0 7601.0 4742.5 4769.1 4781.2 4791.0 4805.8 6083.3 7134.3 7175.7 7193.1 7270.1 6849.1 7034.8 7041.2 7047.9 7058.3 5995.8 6803.4 7058.9 7070.9 7071.4 6875.8 6899.7 6900.7 6902.3 6914.0 6809.4 7071.1 7071.4 7086.9 7111.9 6947.4 6955.1 6961.0 6983.9 6997.0 10:59:24 INFO - PROCESS | 1670 | 10:59:24 INFO - PROCESS | 1670 | [#5] yui.html Cycles:180 Average:17441.42 Median:634.74 stddev:23821.62 (3753.0%) stddev-sans-first:23855.41 10:59:24 INFO - PROCESS | 1670 | Values: 733.7 742.8 745.5 758.0 782.6 16716.0 16986.5 16996.5 17026.9 17064.4 15346.6 15347.8 15367.8 15371.2 15375.8 697.4 701.2 845.3 850.7 859.7 843.8 849.9 855.3 857.6 857.9 885.7 893.1 896.3 897.6 898.2 726.4 727.3 731.2 731.7 732.0 586.7 652.6 662.2 662.9 663.6 14743.9 14816.8 14828.5 14847.9 14871.9 12055.1 12207.8 12307.1 12462.1 12700.2 9682.6 9960.8 10044.1 10114.4 10190.2 3435.3 3470.7 3473.4 3478.8 3479.7 70688.6 71115.0 72097.6 72287.6 72371.0 9185.7 9195.4 9215.5 9367.8 9454.3 16822.4 20545.5 20565.9 20611.6 20637.0 6898.6 6975.2 7016.9 7263.8 7371.6 3658.9 4149.5 4156.8 4161.8 4164.5 3467.3 3532.8 3535.6 3541.8 3550.2 634.6 634.9 643.2 656.3 671.7 546.9 593.9 601.5 622.8 625.5 8561.0 8587.9 8737.6 8841.4 8913.0 514.9 572.6 605.0 617.5 622.7 3919.6 4007.2 4009.5 4126.9 4170.0 85877.0 86094.0 86749.6 86860.0 88195.1 72575.0 73432.9 73768.3 74134.3 74218.6 65485.7 65665.0 66016.0 66708.0 66783.3 7264.2 8152.5 8372.6 8499.9 8756.5 45355.3 45767.5 46198.5 47431.1 48206.8 61283.4 61963.7 65064.4 65503.0 65575.0 10736.8 10765.9 10971.6 11015.6 11323.0 11940.1 11988.6 11990.8 11993.6 11999.2 11378.9 11392.0 11420.3 11437.7 11449.0 9703.5 11162.7 11455.5 11629.3 11964.8 9705.9 10271.2 11148.6 11473.3 12124.5 8117.8 8263.3 8972.2 9181.4 9331.8 8533.7 9884.5 9931.9 9973.7 10122.8 10:59:24 INFO - PROCESS | 1670 | -------- Summary: end -------- 10:59:24 INFO - PROCESS | 1670 | 10:59:25 INFO - TEST-INFO | 1670: exit 0 10:59:25 INFO - TEST-OK | dromaeo_css | took 1113926ms 10:59:25 INFO - TEST-START | kraken 10:59:25 INFO - operating with platform_type : mac_ 10:59:25 INFO - Initialising browser for kraken test... 10:59:25 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/tmp_RH6g6/profile http://localhost:49278/getInfo.html) 10:59:27 INFO - PROCESS | 1679 | __metrics Screen width/height:1600/1200 10:59:27 INFO - PROCESS | 1679 | colorDepth:24 10:59:27 INFO - PROCESS | 1679 | Browser inner width/height: 1024/689 10:59:27 INFO - PROCESS | 1679 | __metrics 10:59:27 INFO - PROCESS | 1679 | 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" 10:59:27 INFO - PROCESS | 1679 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:59:28 INFO - TEST-INFO | 1679: exit 0 10:59:28 INFO - Browser initialized. 10:59:28 INFO - Running cycle 1/1 for kraken test... 10:59:28 INFO - TEST-INFO | started process 1681 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/tmp_RH6g6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:59:40 INFO - PROCESS | 1681 | RSS: Main: 247394304 10:59:40 INFO - PROCESS | 1681 | 10:59:43 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 10:59:43 INFO - PROCESS | 1681 | RSS: Main: 292696064 10:59:43 INFO - PROCESS | 1681 | 10:59:46 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 10:59:46 INFO - PROCESS | 1681 | RSS: Main: 303108096 10:59:46 INFO - PROCESS | 1681 | 10:59:50 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 10:59:50 INFO - PROCESS | 1681 | RSS: Main: 285286400 10:59:50 INFO - PROCESS | 1681 | 10:59:52 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 10:59:53 INFO - PROCESS | 1681 | RSS: Main: 289710080 10:59:53 INFO - PROCESS | 1681 | 10:59:55 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:59:56 INFO - PROCESS | 1681 | RSS: Main: 289239040 10:59:56 INFO - PROCESS | 1681 | 10:59:58 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 10:59:59 INFO - PROCESS | 1681 | RSS: Main: 288976896 10:59:59 INFO - PROCESS | 1681 | 11:00:02 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 11:00:02 INFO - PROCESS | 1681 | RSS: Main: 291123200 11:00:02 INFO - PROCESS | 1681 | 11:00:05 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 11:00:06 INFO - PROCESS | 1681 | RSS: Main: 289693696 11:00:06 INFO - PROCESS | 1681 | 11:00:07 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:00:08 INFO - PROCESS | 1681 | RSS: Main: 324030464 11:00:08 INFO - PROCESS | 1681 | 11:00:10 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:00:10 INFO - PROCESS | 1681 | RSS: Main: 325443584 11:00:10 INFO - PROCESS | 1681 | 11:00:12 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:00:13 INFO - PROCESS | 1681 | RSS: Main: 333774848 11:00:13 INFO - PROCESS | 1681 | 11:00:15 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:00:16 INFO - PROCESS | 1681 | RSS: Main: 335491072 11:00:16 INFO - PROCESS | 1681 | 11:00:18 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:00:19 INFO - PROCESS | 1681 | RSS: Main: 335441920 11:00:19 INFO - PROCESS | 1681 | 11:00:21 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 11:00:21 INFO - PROCESS | 1681 | RSS: Main: 395427840 11:00:21 INFO - PROCESS | 1681 | 11:00:21 INFO - PROCESS | 1681 | __start_tp_report 11:00:21 INFO - PROCESS | 1681 | _x_x_mozilla_page_load 11:00:21 INFO - PROCESS | 1681 | _x_x_mozilla_page_load_details 11:00:21 INFO - PROCESS | 1681 | |i|pagename|runs| 11:00:21 INFO - PROCESS | 1681 | |0;ai-astar;107;105;110;104;107;109;114;110;108;109 11:00:21 INFO - PROCESS | 1681 | |1;audio-beat-detection;157;120;143;154;122;141;142;116;179;151 11:00:21 INFO - PROCESS | 1681 | |2;audio-dft;186;185;182;186;185;186;184;181;182;182 11:00:21 INFO - PROCESS | 1681 | |3;audio-fft;80;72;86;76;57;58;58;80;83;81 11:00:21 INFO - PROCESS | 1681 | |4;audio-oscillator;96;94;129;78;81;93;112;76;78;112 11:00:21 INFO - PROCESS | 1681 | |5;imaging-gaussian-blur;85;96;131;91;86;91;84;91;87;91 11:00:21 INFO - PROCESS | 1681 | |6;imaging-darkroom;98;94;95;94;94;94;94;94;94;99 11:00:21 INFO - PROCESS | 1681 | |7;imaging-desaturate;88;85;86;88;85;91;88;86;87;85 11:00:21 INFO - PROCESS | 1681 | |8;json-parse-financial;58;56;54;55;55;53;55;62;53;52 11:00:21 INFO - PROCESS | 1681 | |9;json-stringify-tinderbox;66;70;72;79;71;69;67;66;66;68 11:00:21 INFO - PROCESS | 1681 | |10;stanford-crypto-aes;83;83;83;83;82;83;83;81;83;84 11:00:21 INFO - PROCESS | 1681 | |11;stanford-crypto-ccm;123;123;123;126;123;137;128;114;125;122 11:00:21 INFO - PROCESS | 1681 | |12;stanford-crypto-pbkdf2;141;126;138;137;137;138;137;136;139;137 11:00:21 INFO - PROCESS | 1681 | |13;stanford-crypto-sha256-iterative;66;67;65;67;68;89;93;94;94;66 11:00:21 INFO - PROCESS | 1681 | __end_tp_report 11:00:21 INFO - PROCESS | 1681 | __start_cc_report 11:00:21 INFO - PROCESS | 1681 | _x_x_mozilla_cycle_collect,1183 11:00:21 INFO - PROCESS | 1681 | __end_cc_report 11:00:21 INFO - PROCESS | 1681 | __startTimestamp1455303621536__endTimestamp 11:00:21 INFO - PROCESS | 1681 | 11:00:21 INFO - PROCESS | 1681 | ------- Summary: start ------- 11:00:21 INFO - PROCESS | 1681 | Number of tests: 14 11:00:21 INFO - PROCESS | 1681 | 11:00:21 INFO - PROCESS | 1681 | [#0] ai-astar Cycles:10 Average:108.30 Median:109.00 stddev:2.83 (2.6%) stddev-sans-first:2.96 11:00:21 INFO - PROCESS | 1681 | Values: 107.0 105.0 110.0 104.0 107.0 109.0 114.0 110.0 108.0 109.0 11:00:21 INFO - PROCESS | 1681 | 11:00:21 INFO - PROCESS | 1681 | [#1] audio-beat-detection Cycles:10 Average:142.50 Median:147.00 stddev:19.37 (13.2%) stddev-sans-first:19.83 11:00:21 INFO - PROCESS | 1681 | Values: 157.0 120.0 143.0 154.0 122.0 141.0 142.0 116.0 179.0 151.0 11:00:21 INFO - PROCESS | 1681 | 11:00:21 INFO - PROCESS | 1681 | [#2] audio-dft Cycles:10 Average:183.90 Median:185.00 stddev:1.97 (1.1%) stddev-sans-first:1.94 11:00:21 INFO - PROCESS | 1681 | Values: 186.0 185.0 182.0 186.0 185.0 186.0 184.0 181.0 182.0 182.0 11:00:21 INFO - PROCESS | 1681 | 11:00:21 INFO - PROCESS | 1681 | [#3] audio-fft Cycles:10 Average:73.10 Median:80.00 stddev:11.29 (14.1%) stddev-sans-first:11.69 11:00:21 INFO - PROCESS | 1681 | Values: 80.0 72.0 86.0 76.0 57.0 58.0 58.0 80.0 83.0 81.0 11:00:21 INFO - PROCESS | 1681 | 11:00:21 INFO - PROCESS | 1681 | [#4] audio-oscillator Cycles:10 Average:94.90 Median:79.50 stddev:17.87 (22.5%) stddev-sans-first:18.95 11:00:21 INFO - PROCESS | 1681 | Values: 96.0 94.0 129.0 78.0 81.0 93.0 112.0 76.0 78.0 112.0 11:00:21 INFO - PROCESS | 1681 | 11:00:21 INFO - PROCESS | 1681 | [#5] imaging-gaussian-blur Cycles:10 Average:93.30 Median:91.00 stddev:13.74 (15.1%) stddev-sans-first:14.24 11:00:21 INFO - PROCESS | 1681 | Values: 85.0 96.0 131.0 91.0 86.0 91.0 84.0 91.0 87.0 91.0 11:00:21 INFO - PROCESS | 1681 | 11:00:21 INFO - PROCESS | 1681 | [#6] imaging-darkroom Cycles:10 Average:95.00 Median:94.00 stddev:1.89 (2.0%) stddev-sans-first:1.66 11:00:21 INFO - PROCESS | 1681 | Values: 98.0 94.0 95.0 94.0 94.0 94.0 94.0 94.0 94.0 99.0 11:00:21 INFO - PROCESS | 1681 | 11:00:21 INFO - PROCESS | 1681 | [#7] imaging-desaturate Cycles:10 Average:86.90 Median:87.50 stddev:1.91 (2.2%) stddev-sans-first:1.99 11:00:21 INFO - PROCESS | 1681 | Values: 88.0 85.0 86.0 88.0 85.0 91.0 88.0 86.0 87.0 85.0 11:00:21 INFO - PROCESS | 1681 | 11:00:21 INFO - PROCESS | 1681 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.00 stddev:2.91 (5.3%) stddev-sans-first:2.92 11:00:21 INFO - PROCESS | 1681 | Values: 58.0 56.0 54.0 55.0 55.0 53.0 55.0 62.0 53.0 52.0 11:00:21 INFO - PROCESS | 1681 | 11:00:21 INFO - PROCESS | 1681 | [#9] json-stringify-tinderbox Cycles:10 Average:69.40 Median:69.50 stddev:4.01 (5.8%) stddev-sans-first:4.06 11:00:21 INFO - PROCESS | 1681 | Values: 66.0 70.0 72.0 79.0 71.0 69.0 67.0 66.0 66.0 68.0 11:00:21 INFO - PROCESS | 1681 | 11:00:21 INFO - PROCESS | 1681 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:83.00 stddev:0.79 (1.0%) stddev-sans-first:0.83 11:00:21 INFO - PROCESS | 1681 | Values: 83.0 83.0 83.0 83.0 82.0 83.0 83.0 81.0 83.0 84.0 11:00:21 INFO - PROCESS | 1681 | 11:00:21 INFO - PROCESS | 1681 | [#11] stanford-crypto-ccm Cycles:10 Average:124.40 Median:124.00 stddev:5.74 (4.6%) stddev-sans-first:6.06 11:00:21 INFO - PROCESS | 1681 | Values: 123.0 123.0 123.0 126.0 123.0 137.0 128.0 114.0 125.0 122.0 11:00:21 INFO - PROCESS | 1681 | 11:00:21 INFO - PROCESS | 1681 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.60 Median:137.50 stddev:3.98 (2.9%) stddev-sans-first:3.89 11:00:21 INFO - PROCESS | 1681 | Values: 141.0 126.0 138.0 137.0 137.0 138.0 137.0 136.0 139.0 137.0 11:00:21 INFO - PROCESS | 1681 | 11:00:21 INFO - PROCESS | 1681 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.90 Median:78.50 stddev:13.52 (17.2%) stddev-sans-first:13.75 11:00:21 INFO - PROCESS | 1681 | Values: 66.0 67.0 65.0 67.0 68.0 89.0 93.0 94.0 94.0 66.0 11:00:21 INFO - PROCESS | 1681 | -------- Summary: end -------- 11:00:21 INFO - PROCESS | 1681 | 11:00:22 INFO - TEST-INFO | 1681: exit 0 11:00:22 INFO - TEST-OK | kraken | took 57037ms 11:00:22 INFO - SUITE-END | took 1170s 11:00:22 INFO - Completed test suite (00:19:31) 11:00:22 INFO - Working with test: dromaeo_css 11:00:22 INFO - Generating results file: dromaeo_css 11:00:22 INFO - Working with test: kraken 11:00:22 INFO - Generating results file: kraken 11:00:22 INFO - javascript benchmark 11:00:22 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:00:23 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 11:00:23 INFO - process_Request line: dromaeo_css 7384.62 graph.html#tests=[[72,64,59]] 11:00:23 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:00:23 INFO - process_Request line: kraken 1423.30 graph.html#tests=[[232,64,59]] 11:00:23 INFO - RETURN: dromaeo_css: 7384.62 11:00:23 INFO - RETURN: kraken: 1423.30 11:00:23 INFO - javascript benchmark 11:00:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3417.743669224808, 3487.7384196185294, 3512.718982481401, 3517.665821746933, 3555.71554275658, 5552.472515111058, 5613.80351687691, 5616.803411880585, 5647.209390685307, 5648.983183027053, 5639.520640745542, 5649.49154576088, 5688.402717714643, 5805.448482394166, 5811.941880581193, 5057.620678449112, 5092.032513822372, 5126.128558145124, 5144.8713782155555, 5209.7134657593815, 5168.405633352175, 5175.948240517584, 5225.738713064351, 5245.4754524547625, 5296.629235953485, 5032.043911656773, 5092.414372347172, 5113.872153196163, 5126.359205099363, 5177.48225177483, 5120.513551212629, 5139.100657384943, 5150.819721309774, 5160.096983027993, 5180.792768289264, 5057.988402319514, 5145.279660847485, 5145.691258524501, 5154.5103215194495, 5158.484151584849, 5463.590230732711, 5531.2809334786625, 5622.353429355636, 5676.489115979582, 5690.06113991191, 6126.23422072241, 6163.106349579286, 6172.1667574877265, 6181.783637572664, 6186.474149697281, 5384.111621582434, 6204.689765511752, 6231.40801623845, 6250.843728906768, 6255.937440625581, 5592.5246354059545, 5637.379888212294, 5679.829605111853, 5685.431456854323, 5695.971520142414, 4788.545088216614, 4903.215485522299, 6238.719257633417, 6294.905576416358, 6307.369263073748, 5839.649621022752, 5962.07587823888, 5986.880262394728, 6079.908801367983, 6084.300305464928, 6106.0, 6169.96915015422, 6200.131981522591, 6206.255249370104, 6243.781467648701, 5983.341832398432, 5998.310194327621, 5999.820005399845, 6000.309964354068, 6004.669743164168, 6015.879682406327, 6023.1266466363, 6027.276726792726, 6033.155358249848, 6033.668148251888, 4797.616190704735, 4800.039992001613, 4810.927836082462, 4819.180739274332, 4821.300911367832, 3797.1076796952693, 4230.2174097792, 4258.914821703549, 4350.782460877007, 4386.605205531518, 5649.293838270216, 5649.830505084854, 5670.489655930904, 5676.829695109153, 5687.516561092353, 6104.671374792629, 6163.476104531075, 6166.414190651881, 6205.937940620536, 6213.0, 5732.254806875079, 5754.251947246915, 5771.134329850472, 5788.45009724084, 5814.6220495668495, 5306.230596563554, 5332.30680011596, 5341.332333458317, 5345.812896548602, 5361.142217245222, 6189.96905015463, 6281.214848143982, 6298.433141017331, 6311.873762524724, 6355.555111142268, 5191.714455704821, 6240.375962403723, 6255.249370075438, 6262.3737626238835, 6273.843153921189, 6302.590331628429, 6338.0, 6340.746370145327, 6350.460210882126, 6350.7142178603, 5073.847784566469, 6016.909746353721, 6113.388661133851, 6130.693465326805, 6191.133241346125, 6229.501639868709, 6238.126662267196, 6241.3134555197985, 6257.1552840367785, 6257.624542527463, 5190.2214667800135, 6024.90962635552, 6098.664573448503, 6107.389261073857, 6121.0206366981065, 5574.5261652758345, 5720.141978703228, 6029.216201893726, 6108.053251745987, 6140.109684095871, 5901.0, 5906.940930590811, 5917.3490915998345, 5922.881542369215, 5931.703414829328, 5868.647881127146, 6049.727762250621, 6059.666718330534, 6113.23584551931, 6131.110988906673, 5874.324452687824, 5911.556633252438, 5928.822135335947, 5953.345132035386, 6024.548158888013], "unit": "score", "name": "dojo.html", "value": 5612.635234560655}, {"lowerIsBetter": false, "replicates": [462.027432255103, 467.1241422333125, 499.70517394737107, 532.6431291035007, 565.0168706450776, 27321.907123715053, 30101.096967090994, 36962.63037369626, 37723.0, 37798.67704630338, 40109.0, 40519.0, 40571.59428405715, 40599.0, 40681.169347379364, 9510.0, 9724.805503889918, 9734.951325243364, 9743.853842192373, 9749.366291191085, 9505.667301644444, 9640.180584650314, 9642.228621710246, 9652.227821774277, 9664.178544823699, 9739.51302434879, 9818.410895346266, 9825.312228144032, 9837.213022958145, 9849.507524623776, 9655.710328690151, 9738.513074346254, 9741.464219467927, 9742.318037737326, 9768.706938791847, 9639.325247232697, 9776.560054797552, 9789.461579613118, 9800.803983920354, 9810.018998100204, 39438.0, 39720.0, 39783.40324895129, 39810.20379592392, 39858.20283594312, 2655.8539280339573, 2757.600147978552, 3289.6216935052535, 3571.8571257149683, 3776.376897811858, 27732.30669233265, 28249.321096553067, 28290.717092829014, 28293.575596365867, 29653.851730741422, 2736.493748656505, 2766.833989960609, 2794.6646402431634, 2862.355969906775, 2902.3034471726633, 358959.0, 359558.0, 359682.0, 359708.0, 360369.19815400755, 60680.0, 60919.390806092255, 61192.0, 61227.775444490864, 61282.693586532674, 64180.35819641837, 64389.678051609444, 64427.0, 64464.67767661132, 64552.35447645558, 16427.425040123537, 16624.50126496207, 16630.66738665244, 16647.83352166463, 16660.41688540895, 12702.87297127017, 12738.0, 12753.043521735906, 12763.170393924365, 12766.61700148997, 14798.556043318718, 17686.695219095775, 18778.436646900616, 19207.903960480107, 19244.518887027938, 7255.637218139072, 8419.579021048923, 8669.60986755585, 8700.477971321741, 8750.95624521886, 855.5337341148964, 933.9813203735887, 999.195647503752, 1049.5277125293496, 1075.6289080267295, 24718.876405617855, 24974.37564060913, 28506.42987140287, 28724.712752872623, 29809.0, 1026.4559783314855, 1039.6725031615017, 1111.0278506306981, 1130.3726431830414, 1158.9942050289694, 13959.720805584035, 14166.433342666178, 14440.494582689555, 15304.846951530564, 15374.154421506924, 434649.0, 439307.62423315033, 439424.0, 439726.0, 683883.5805820939, 47365.76317118392, 55683.72158139183, 56782.0, 56799.71600141973, 56939.0, 1337.6054064050934, 1372.8009438631343, 1427.4290283886528, 1451.796748455217, 1572.1667516216423, 20997.685034724796, 24688.0, 25871.353216169748, 25873.09444169445, 27738.722612773614, 47409.762951185025, 47860.04279914452, 47883.28175077446, 47892.76053619709, 47903.5209647913, 423818.0, 432034.0, 432612.0, 432858.0, 433056.0, 29890.70109298879, 30160.84919575388, 30225.848870755504, 30245.09264722062, 30284.0, 40988.0, 42814.92962675958, 42918.35622465603, 43213.351799723656, 43394.78302608467, 32497.837510812296, 35283.647163529065, 36311.81844090763, 36334.273314533035, 36390.0, 30954.0, 35508.289834203686, 35738.64261357457, 35783.642163579076, 35997.82001089978, 34888.302233955685, 35637.82181089078, 35837.0, 35960.46059309165, 35997.82001089978, 30280.697193027787, 31338.843305783324, 31459.59565660855, 31492.842535787175, 31523.0, 20936.68594971107, 24111.0, 24140.51718965576, 24297.514049718553, 24789.50420991606], "unit": "score", "name": "ext.html", "value": 18948.234389581132}, {"lowerIsBetter": false, "replicates": [361.1999421281862, 362.8004597471391, 364.5060942423017, 367.9043448703337, 369.51224383813343, 14943.701125977474, 15556.688866222668, 18770.624587508242, 19882.801171988274, 20405.183792648295, 19527.707084393747, 19938.102785374656, 20202.888841113734, 20230.696539551882, 20423.897880510613, 5301.3373328333955, 6543.280239173687, 6546.378094081055, 6550.901736473957, 6554.442872355831, 4545.159145558082, 4702.741349225791, 6489.091527186198, 7054.18876829166, 7439.4792364534505, 7134.250903655119, 7280.0, 7380.852382952337, 7405.740799072034, 7409.0, 4501.729896206238, 5789.305283366023, 7332.340089391953, 7350.375218106467, 7352.595607241573, 5504.724763761796, 5559.555235581144, 5560.805371811967, 5564.221009058735, 5569.693666848321, 13057.934710326483, 14399.712005759826, 16597.91701041487, 18387.0, 23724.0, 2062.6905964105504, 2154.4613846538364, 2394.4253379189045, 2439.499902519979, 2651.8331933949003, 9808.068233517804, 10132.34139780912, 11582.478788454455, 11919.0, 13369.197848129143, 1718.2611477064856, 1732.523556022104, 1749.860011199101, 1756.7277072053853, 1773.4147731248656, 92346.0, 92385.53807230988, 93775.0, 94769.0, 98222.0, 10709.839352409721, 10994.395308257963, 11078.446077696082, 11102.111831053497, 11192.216544841784, 13181.868181318256, 13298.468061277634, 13305.93347033278, 13309.267990260629, 13327.533536326182, 6814.352636499525, 8399.328053755808, 8402.453840500348, 8479.0, 8502.319814414832, 8671.34964877624, 8678.739637810875, 8679.566021698889, 8772.166644168794, 8780.429272097294, 4089.2230476209425, 4228.8308467660945, 4285.057287396768, 4418.116376724668, 4564.908701826012, 1777.2802015183872, 1826.7625208723048, 1835.5869929266075, 1854.7959724430302, 1860.8325250727228, 833.9291160251325, 954.8854137503544, 982.7199248214224, 1028.1671845804922, 1031.4120951057976, 16138.838611613734, 20321.89839050825, 20508.0, 20668.276610318866, 20776.1689532417, 921.5898924978454, 943.2548286853446, 993.9403635781877, 1007.7984403119406, 1020.9841207997941, 9220.077374067738, 10290.485475726184, 10534.73663158412, 11156.832647510293, 11216.439178041066, 628948.0, 713359.0, 717037.0, 720346.0, 732179.0, 109665.35501967477, 110877.44561277142, 111886.44056779664, 112144.0, 112292.0, 1138.7608602193466, 1165.4638866121509, 1185.8754830742648, 1195.3843770458047, 1199.6041306368877, 17467.650646986735, 17813.73279400784, 18017.81982180214, 18443.89336639806, 18484.81515184831, 50693.49306506888, 51596.0, 51851.48148518467, 52563.73718131538, 53884.38346849601, 65283.67358163179, 65680.014799779, 66545.66727166333, 69051.05912819889, 69708.30291697221, 6419.518536109717, 7358.190599033995, 7424.665890035069, 7635.580043097683, 7821.530708157528, 5884.823035393024, 9228.40015398997, 11235.15736319763, 11858.208881269304, 11984.64046078619, 9780.951095244478, 10237.744056398351, 10301.845472318071, 10397.740056498647, 10600.0, 7317.963410182915, 10084.991500849856, 10190.3505088676, 10307.072363487323, 10332.91504392058, 9017.594208260512, 10377.066064054272, 10395.116415104801, 10665.9466702666, 10998.615048473264, 7511.3615342696485, 7584.355329796808, 7646.617669116411, 7667.386609071149, 7710.961445192738, 8798.988116366443, 9755.365901216399, 10157.187425005834, 10262.897371026493, 10584.735381615521], "unit": "score", "name": "jquery.html", "value": 9214.111130281737}, {"lowerIsBetter": false, "replicates": [1399.048646920094, 1517.142814309915, 1549.6125968507872, 1778.9021603811793, 1930.3629802165287, 7684.269994350535, 7876.645550950207, 7877.684892604296, 7893.526388416699, 7896.684132634688, 8051.315638170762, 8086.514809111442, 8261.834763304745, 8264.768512501636, 8278.254957053863, 2404.591219492682, 2441.8534887906694, 2445.4375493636476, 2448.8897999590063, 2451.0, 2141.0365335598963, 2195.0, 2383.368407372048, 2418.504206637635, 2434.0, 2339.5320935812906, 2404.110479122727, 2411.590029694947, 2413.891374888134, 2422.200673777658, 2133.903974321144, 2376.4415362389823, 2381.44036151506, 2386.3795413192606, 2389.593769059264, 2163.167180635451, 2382.070992312982, 2426.720927093389, 2433.5741245282006, 2435.0138194031447, 8251.711190108377, 8319.168083191693, 8325.542095184763, 8340.416170868042, 8351.039630442516, 5122.820701275475, 5236.21456781482, 5248.448912864133, 5249.396319423277, 5264.684118952837, 3455.58532976042, 3531.823408829574, 3576.2311103112697, 3651.379265524867, 3670.1925576373155, 1052.2371280821344, 1069.5775168808354, 1074.9946250268777, 1076.6285631457135, 1079.6976846482996, 11488.253263537843, 11489.482973266224, 11501.827472587835, 11508.654740357802, 11514.94242528782, 4676.50896655853, 4765.594924431392, 4841.15279826029, 4844.467108618049, 4847.878803029953, 9792.314537982273, 9812.460314682761, 9821.705348839547, 9831.115199632068, 9839.80320393588, 5338.279332290169, 5374.435684253175, 5381.219723140122, 5405.594580406485, 5433.538149257357, 4845.6608037437745, 4849.418069831643, 4856.562909338177, 4858.149823780825, 4868.075065737498, 3154.242981684379, 3637.4907512948207, 3722.664960153599, 3754.342989976743, 3787.242551489713, 1167.7563394984315, 1171.7129303320742, 1174.788538063157, 1177.5584155941522, 1190.0, 1304.5955753716378, 1314.3625341709264, 1318.4330737782846, 1321.2931081871345, 1353.316575129573, 7748.883766743504, 7774.689012439552, 7815.53106813593, 7872.055353357519, 7947.125816160218, 1185.8043422835308, 1187.6733898177897, 1189.976200476003, 1204.151073493185, 1222.2116734706065, 5705.600607957404, 5814.767409303665, 6093.146959425684, 6192.81421557354, 6298.779542715983, 8700.912990870136, 9922.958089400654, 10051.24615653829, 10271.126954208976, 10305.587776488857, 10215.02957219063, 10216.233782466345, 10222.182225421948, 10234.437105959094, 10235.027672371112, 7827.686892524349, 7855.214478552099, 7882.802929926683, 7999.240072193133, 8015.959920200362, 7847.254510821463, 7895.1315355309725, 7911.406644501801, 7918.524888506708, 7919.683212671659, 9026.18764311215, 9159.038300978567, 9437.764055898382, 9458.006909274702, 9471.10024547667, 9447.81104377895, 9801.264905132286, 9802.509874506104, 9812.754681133028, 9829.655962041294, 6752.527323087336, 6817.659117044227, 6840.042394064735, 6852.6916288768125, 6854.314568543105, 7904.249096335839, 7934.761957141295, 7946.8807967881685, 8010.038795344363, 8010.719624813103, 6380.649064301508, 7504.099508059068, 7536.660850261642, 7698.92301076982, 7703.422243331885, 6372.87254254903, 7348.448866334939, 7403.962980185064, 7407.8148046299275, 7619.847603048019, 7500.849983000418, 7560.243975602396, 7574.924250757422, 7579.696812127453, 7581.583012934121, 6758.155230596176, 6902.482313826383, 6913.170419549485, 6926.653667316513, 6931.480138989495, 6351.07909353132, 6945.826354340979, 6997.965010174917, 7022.2275549688475, 7023.894641580278], "unit": "score", "name": "mootools.html", "value": 4805.140622882891}, {"lowerIsBetter": false, "replicates": [318.2695713337889, 322.5307178055929, 327.88360132153093, 330.69080409816837, 333.8581103031211, 6380.872382552347, 6559.60642361458, 6572.3427657234315, 6598.703058362374, 6625.304343043983, 6308.0, 6493.1558897343275, 6506.642134682591, 6514.706838192281, 6564.04821300911, 4011.518617765872, 4787.042591481701, 4816.590589799863, 4848.684835485682, 4877.146499362615, 4619.976900115512, 4716.410448693913, 4731.550502702238, 4874.707517548958, 4888.682235654689, 4558.954410455886, 4716.4340279166545, 4830.227163653816, 4847.03059388122, 4854.36893203883, 4817.951820481803, 4821.686590371614, 4828.74452642312, 4831.806727730886, 4888.902221955576, 4157.5010998680045, 4164.5210800757695, 4170.457840480748, 4176.937345939813, 4176.979115104436, 6167.4757645600175, 6369.267534233576, 6388.0, 6399.168108145911, 6420.101185833941, 5697.743601537941, 5702.287214098238, 5703.5437165027115, 5723.885522289573, 5729.169270455761, 6937.930620693779, 6945.652717364112, 6959.721611135548, 6961.965190174067, 6975.860482790366, 3852.2680690668963, 4634.9073018539775, 4637.142128706167, 4649.767511624405, 4651.046535460223, 7028.437724981989, 7085.078939737801, 7240.348368646794, 7397.556146631219, 7444.851102977965, 4588.701734387254, 4645.954660201495, 4713.505081966413, 4720.527947205252, 4730.455997560324, 4757.429108507002, 4795.112904112751, 4801.039792041605, 4811.676788883015, 4847.854564363075, 5661.518770904519, 5674.120511320752, 5674.602777805597, 5688.800891968761, 5703.17303990919, 6807.931920680829, 6954.095967524189, 6980.197277313174, 7000.824979375557, 7003.754868579677, 1669.3656410564151, 1689.3073839725653, 1689.7803285572797, 1690.2900781671729, 1692.2976964559816, 1087.7552550676035, 1089.0470838016736, 1105.4638500327335, 1114.2979922648678, 1116.6817457024708, 5413.296271484682, 6605.0, 6621.536492445579, 6636.634985075771, 6643.036759669821, 7255.963720181471, 7265.2371500992695, 7269.781906542812, 7279.090113735783, 7285.271472852778, 5496.285482887199, 6352.2694890087305, 6577.967110164514, 6591.769288074895, 6625.138731964814, 3835.9041023974064, 3866.0914685048992, 3867.7099217558793, 3868.2263547290654, 3874.9612503875164, 6108.480779133734, 7603.543787372775, 7610.8097297568, 7657.57883316423, 7677.539347639159, 6000.249968753906, 7260.600666963368, 7482.551046937201, 7487.812804679927, 7497.1753107158165, 7596.696132154762, 7611.961940190264, 7618.733344332922, 7627.466077374753, 7637.274458926393, 7236.2401947796825, 7256.96371518139, 7262.237465066092, 7263.309985551364, 7277.490575659653, 5732.484076433141, 6875.1749790025515, 7135.464840136907, 7139.535930164523, 7143.4999550031, 6133.601315914451, 7428.33145016951, 7475.289847464483, 7481.0, 7601.049868766404, 4742.549457801503, 4769.093872164278, 4781.2350023996, 4791.0, 4805.783739731651, 6083.330833608388, 7134.286571342825, 7175.748848790267, 7193.064901562763, 7270.091238595176, 6849.1438570178725, 7034.753783617549, 7041.225465198721, 7047.894281585678, 7058.294170582901, 5995.820125396245, 6803.353681400259, 7058.858822823618, 7070.929290707233, 7071.434285257064, 6875.759348422981, 6899.689513971783, 6900.689468973807, 6902.274431392152, 6914.0, 6809.353111454404, 7071.080759501232, 7071.434285257064, 7086.893696594659, 7111.9288807113335, 6947.44420446353, 6955.061066755923, 6960.965195173992, 6983.860322793617, 6997.0], "unit": "score", "name": "prototype.html", "value": 5122.459857919872}, {"lowerIsBetter": false, "replicates": [733.6551820644298, 742.7660287009592, 745.5377665847176, 757.9924200757993, 782.6086956521739, 16716.0, 16986.49040528783, 16996.49010529683, 17026.91486542567, 17064.402745903895, 15346.616334591641, 15347.769783453257, 15367.846321536781, 15371.23230828455, 15375.846241537582, 697.3723648716145, 701.1726163127507, 845.2646197807916, 850.6682393866397, 859.7377799771067, 843.7637461510756, 849.9490030598184, 855.2687452228317, 857.618359829876, 857.9056303806576, 885.7032893980524, 893.1158153428124, 896.3187977137358, 897.5512243878061, 898.1781669772183, 726.4406407066582, 727.294524311417, 731.2102928836844, 731.6707481633233, 731.9707211711525, 586.7389011889711, 652.5627829354344, 662.1855118204635, 662.9237637671681, 663.6051549328142, 14743.926280368636, 14816.777748333783, 14828.481003164838, 14847.851521484756, 14871.925640371837, 12055.095867809949, 12207.816882746765, 12307.138500304982, 12462.12765106443, 12700.1744886583, 9682.612695492171, 9960.800783984352, 10044.146247568966, 10114.391914052068, 10190.184785217165, 3435.261418794971, 3470.687638112582, 3473.426884564044, 3478.7912725236565, 3479.652034796525, 70688.6465567674, 71115.0, 72097.63951180315, 72287.63856180738, 72371.0, 9185.724428267162, 9195.402298850553, 9215.49314787693, 9367.765805854908, 9454.33819632633, 16822.411215607393, 20545.48636284105, 20565.89717051405, 20611.58776824455, 20637.0, 6898.586084834926, 6975.197852246955, 7016.929830701628, 7263.818404539928, 7371.557706537517, 3658.8719394821587, 4149.502059752849, 4156.833726650961, 4161.83352665896, 4164.4586203793315, 3467.2718729066673, 3532.8056956867617, 3535.611082780892, 3541.8052007139854, 3550.2012047289154, 634.5875181132301, 634.8857205702925, 643.1831573901119, 656.3075954867566, 671.717878491035, 546.8687514996373, 593.9198208241831, 601.485729701108, 622.8100429368995, 625.4714766022704, 8560.957195214109, 8587.914120858712, 8737.563121843883, 8841.425307355, 8913.0, 514.9176131818966, 572.5934586443589, 604.9788257410969, 617.4967401567798, 622.707327556048, 3919.5884432134217, 4007.1785284016705, 4009.4587230724064, 4126.938095928564, 4169.958300417018, 85877.0, 86094.0, 86749.56625216834, 86860.0, 88195.11804881998, 72575.0, 73432.89850652244, 73768.26231737722, 74134.25865741381, 74218.62890685513, 65485.67257163684, 65665.01502477466, 66016.0, 66708.0, 66783.33216667868, 7264.200937896932, 8152.510849349058, 8372.623231954454, 8499.915000849913, 8756.51839148853, 45355.31967020431, 45767.54232457633, 46198.53801461942, 47431.051378972916, 48206.75896620635, 61283.38716612955, 61963.6901815488, 65064.37339066561, 65503.0, 65575.0, 10736.83894741564, 10765.89234107649, 10971.615993440191, 11015.614453494089, 11323.036937071958, 11940.10449216295, 11988.64034078979, 11990.760184796429, 11993.580224692094, 11999.1600587958, 11378.943105284421, 11392.031677307521, 11420.257683250895, 11437.714057148638, 11449.0, 9703.514824258618, 11162.665120046411, 11455.484503197209, 11629.302241865515, 11964.76070478603, 9705.915906531827, 10271.178305735373, 11148.609798657008, 11473.254238474472, 12124.454399552218, 8117.822915677312, 8263.256306932404, 8972.19250267479, 9181.403208791407, 9331.766705832408, 8533.696229816564, 9884.456354900261, 9931.851022234529, 9973.69086017511, 10122.848157277795], "unit": "score", "name": "yui.html", "value": 6722.971062596933}], "name": "dromaeo_css", "value": 7384.620930521332}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [107.0, 105.0, 110.0, 104.0, 107.0, 109.0, 114.0, 110.0, 108.0, 109.0], "unit": "score", "name": "ai-astar", "value": 108.3}, {"lowerIsBetter": true, "replicates": [157.0, 120.0, 143.0, 154.0, 122.0, 141.0, 142.0, 116.0, 179.0, 151.0], "unit": "score", "name": "audio-beat-detection", "value": 142.5}, {"lowerIsBetter": true, "replicates": [186.0, 185.0, 182.0, 186.0, 185.0, 186.0, 184.0, 181.0, 182.0, 182.0], "unit": "score", "name": "audio-dft", "value": 183.9}, {"lowerIsBetter": true, "replicates": [80.0, 72.0, 86.0, 76.0, 57.0, 58.0, 58.0, 80.0, 83.0, 81.0], "unit": "score", "name": "audio-fft", "value": 73.1}, {"lowerIsBetter": true, "replicates": [96.0, 94.0, 129.0, 78.0, 81.0, 93.0, 112.0, 76.0, 78.0, 112.0], "unit": "score", "name": "audio-oscillator", "value": 94.9}, {"lowerIsBetter": true, "replicates": [85.0, 96.0, 131.0, 91.0, 86.0, 91.0, 84.0, 91.0, 87.0, 91.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 93.3}, {"lowerIsBetter": true, "replicates": [98.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 99.0], "unit": "score", "name": "imaging-darkroom", "value": 95.0}, {"lowerIsBetter": true, "replicates": [88.0, 85.0, 86.0, 88.0, 85.0, 91.0, 88.0, 86.0, 87.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 86.9}, {"lowerIsBetter": true, "replicates": [58.0, 56.0, 54.0, 55.0, 55.0, 53.0, 55.0, 62.0, 53.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 55.3}, {"lowerIsBetter": true, "replicates": [66.0, 70.0, 72.0, 79.0, 71.0, 69.0, 67.0, 66.0, 66.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.4}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 83.0, 83.0, 82.0, 83.0, 83.0, 81.0, 83.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.8}, {"lowerIsBetter": true, "replicates": [123.0, 123.0, 123.0, 126.0, 123.0, 137.0, 128.0, 114.0, 125.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.4}, {"lowerIsBetter": true, "replicates": [141.0, 126.0, 138.0, 137.0, 137.0, 138.0, 137.0, 136.0, 139.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.6}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 65.0, 67.0, 68.0, 89.0, 93.0, 94.0, 94.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 76.9}], "name": "kraken", "value": 1423.3}]} 11:00:23 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1423.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7384.62"}}} 11:00:23 INFO - Return code: 0 11:00:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:00:23 INFO - # TBPL SUCCESS # 11:00:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:00:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:00:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:00:23 INFO - 2016-02-12 11:00:23.359 screenresolution[1686:9858] starting screenresolution argv=screenresolution get 11:00:23 INFO - 2016-02-12 11:00:23.361 screenresolution[1686:9858] Display 0: 1600x1200x32@60 11:00:23 INFO - 2016-02-12 11:00:23.367 screenresolution[1687:9860] starting screenresolution argv=screenresolution list 11:00:23 INFO - Available Modes on Display 0 11:00:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:00:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:00:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:00:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:00:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:00:23 INFO - Intel Iris: 11:00:23 INFO - Chipset Model: Intel Iris 11:00:23 INFO - Type: GPU 11:00:23 INFO - Bus: Built-In 11:00:23 INFO - VRAM (Dynamic, Max): 1536 MB 11:00:23 INFO - Vendor: Intel (0x8086) 11:00:23 INFO - Device ID: 0x0a2e 11:00:23 INFO - Revision ID: 0x0009 11:00:23 INFO - Displays: 11:00:23 INFO - Display: 11:00:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:00:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:00:23 INFO - Display Serial Number: 1600x1200 60 11:00:23 INFO - Main Display: Yes 11:00:23 INFO - Mirror: Off 11:00:23 INFO - Online: Yes 11:00:23 INFO - Rotation: Supported 11:00:23 INFO - Return code: 0 11:00:23 INFO - Running post-action listener: _resource_record_post_action 11:00:23 INFO - Running post-run listener: _resource_record_post_run 11:00:24 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 39220736; Write bytes: 709448192; Read time: 424; Write time: 1935 11:00:24 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 403945984; Write bytes: 405665792; Read time: 30289; Write time: 773 11:00:24 INFO - run-tests - Wall time: 1174s; CPU: 52.0%; Read bytes: 37406208; Write bytes: 302201344; Read time: 404; Write time: 1159 11:00:24 INFO - Running post-run listener: _upload_blobber_files 11:00:24 INFO - Blob upload gear active. 11:00:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:00:24 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 11:00:24 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'] 11:00:24 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 11:00:25 INFO - (blobuploader) - INFO - Open directory for files ... 11:00:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:00:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:00:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:00:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:00:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:00:26 INFO - (blobuploader) - INFO - Done attempting. 11:00:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:00:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:00:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:00:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:00:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:00:27 INFO - (blobuploader) - INFO - Done attempting. 11:00:27 INFO - (blobuploader) - INFO - Iteration through files over. 11:00:27 INFO - Return code: 0 11:00:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:00:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:00:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/448e90f5dc9fa810a0e48b9e20b7b81b4dd6f5aaff527e221c20bbce23b0fd9162883cd886f8eedad7ca4e8d4f6f5fb09bb80dcb1e470e97c15063f4cbad4e6a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/25bd3e35712e08fe727e11649875e7610dace2a0a901d75ca4147512dd31cde047bf08f068b3d7e38405a8ccfcab97820e0cde8ccd1cc06a20b9a0faaec8d82d"} 11:00:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:00:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:00:27 INFO - Contents: 11:00:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/448e90f5dc9fa810a0e48b9e20b7b81b4dd6f5aaff527e221c20bbce23b0fd9162883cd886f8eedad7ca4e8d4f6f5fb09bb80dcb1e470e97c15063f4cbad4e6a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/25bd3e35712e08fe727e11649875e7610dace2a0a901d75ca4147512dd31cde047bf08f068b3d7e38405a8ccfcab97820e0cde8ccd1cc06a20b9a0faaec8d82d"} 11:00:27 INFO - Running post-run listener: copy_logs_to_upload_dir 11:00:27 INFO - Copying logs to upload dir... 11:00:27 INFO - mkdir: /builds/slave/test/build/upload/logs 11:00:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.551635 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-02-12 11:00:27.635753) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-12 11:00:27.639877) ========= 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.7vIJXobspg/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.sQsLH9hmOo/Listeners TMPDIR=/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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/448e90f5dc9fa810a0e48b9e20b7b81b4dd6f5aaff527e221c20bbce23b0fd9162883cd886f8eedad7ca4e8d4f6f5fb09bb80dcb1e470e97c15063f4cbad4e6a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/25bd3e35712e08fe727e11649875e7610dace2a0a901d75ca4147512dd31cde047bf08f068b3d7e38405a8ccfcab97820e0cde8ccd1cc06a20b9a0faaec8d82d"} build_url:https://queue.taskcluster.net/v1/task/WCgrczzaQ0C7quE4c89qGQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011333 build_url: 'https://queue.taskcluster.net/v1/task/WCgrczzaQ0C7quE4c89qGQ/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/448e90f5dc9fa810a0e48b9e20b7b81b4dd6f5aaff527e221c20bbce23b0fd9162883cd886f8eedad7ca4e8d4f6f5fb09bb80dcb1e470e97c15063f4cbad4e6a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/25bd3e35712e08fe727e11649875e7610dace2a0a901d75ca4147512dd31cde047bf08f068b3d7e38405a8ccfcab97820e0cde8ccd1cc06a20b9a0faaec8d82d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-12 11:00:27.667526) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 11:00:27.667870) ========= 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.7vIJXobspg/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.sQsLH9hmOo/Listeners TMPDIR=/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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.005206 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 11:00:27.716997) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-12 11:00:27.717320) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-12 11:00:27.717705) ========= ========= Total master_lag: 0.26 =========