builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0138 starttime: 1455022657.9 results: success (0) buildid: 20160209030411 builduid: f5e5993d0e594408b14d49e5080b5cfd revision: 2dfb45d74f42d2a0010696f5fd47c7a7da94cedb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-09 04:57:37.897225) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-09 04:57:37.897646) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-09 04:57:37.897950) ========= 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.degx1neawc/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.0qpDrWMb28/Listeners TMPDIR=/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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.005280 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-09 04:57:37.920407) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-09 04:57:37.920680) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-09 04:57:37.936828) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 04:57:37.937093) ========= 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.degx1neawc/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.0qpDrWMb28/Listeners TMPDIR=/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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.005862 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 04:57:37.984705) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-09 04:57:37.985043) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-09 04:57:37.985431) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 04:57:37.985704) ========= 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.degx1neawc/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.0qpDrWMb28/Listeners TMPDIR=/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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-09 04:57:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 178M=0s 2016-02-09 04:57:38 (178 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.167406 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 04:57:38.167907) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 04:57:38.168263) ========= 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.degx1neawc/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.0qpDrWMb28/Listeners TMPDIR=/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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.025551 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 04:57:38.216538) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-09 04:57:38.216886) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2dfb45d74f42d2a0010696f5fd47c7a7da94cedb --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 2dfb45d74f42d2a0010696f5fd47c7a7da94cedb --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.degx1neawc/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.0qpDrWMb28/Listeners TMPDIR=/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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-09 04:57:38,288 truncating revision to first 12 chars 2016-02-09 04:57:38,288 Setting DEBUG logging. 2016-02-09 04:57:38,288 attempt 1/10 2016-02-09 04:57:38,288 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2dfb45d74f42?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-09 04:57:39,621 unpacking tar archive at: mozilla-central-2dfb45d74f42/testing/mozharness/ program finished with exit code 0 elapsedTime=1.581107 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-09 04:57:39.813507) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-09 04:57:39.813872) ========= echo 2dfb45d74f42d2a0010696f5fd47c7a7da94cedb in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'2dfb45d74f42d2a0010696f5fd47c7a7da94cedb'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.degx1neawc/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.0qpDrWMb28/Listeners TMPDIR=/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 2dfb45d74f42d2a0010696f5fd47c7a7da94cedb program finished with exit code 0 elapsedTime=0.005421 script_repo_revision: '2dfb45d74f42d2a0010696f5fd47c7a7da94cedb' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-09 04:57:39.863622) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-09 04:57:39.864558) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-09 04:57:39.876907) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-02-09 04:57:39.877181) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.degx1neawc/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.0qpDrWMb28/Listeners TMPDIR=/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 04:57:40 INFO - MultiFileLogger online at 20160209 04:57:40 in /builds/slave/test 04:57:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:57:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:57:40 INFO - {'append_to_log': False, 04:57:40 INFO - 'base_work_dir': '/builds/slave/test', 04:57:40 INFO - 'blob_upload_branch': 'Firefox', 04:57:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:57:40 INFO - 'branch': 'Firefox', 04:57:40 INFO - 'buildbot_json_path': 'buildprops.json', 04:57:40 INFO - 'config_files': ('talos/mac_config.py',), 04:57:40 INFO - 'default_actions': ('clobber', 04:57:40 INFO - 'read-buildbot-config', 04:57:40 INFO - 'download-and-extract', 04:57:40 INFO - 'populate-webroot', 04:57:40 INFO - 'create-virtualenv', 04:57:40 INFO - 'install', 04:57:40 INFO - 'run-tests'), 04:57:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:57:40 INFO - 'download_minidump_stackwalk': True, 04:57:40 INFO - 'download_symbols': 'ondemand', 04:57:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:57:40 INFO - 'tooltool.py': '/tools/tooltool.py', 04:57:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:57:40 INFO - '/tools/misc-python/virtualenv.py')}, 04:57:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:57:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:57:40 INFO - 'installer_path': 'installer.exe', 04:57:40 INFO - 'log_level': 'info', 04:57:40 INFO - 'log_name': 'talos', 04:57:40 INFO - 'log_to_console': True, 04:57:40 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:57:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:57:40 INFO - 'opt_config_files': (), 04:57:40 INFO - 'pip_index': False, 04:57:40 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:57:40 INFO - 'cmd': ('bash', 04:57:40 INFO - '-c', 04:57:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:57:40 INFO - 'enabled': True, 04:57:40 INFO - 'halt_on_failure': False, 04:57:40 INFO - 'name': 'check_screen_resolution'},), 04:57:40 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:57:40 INFO - 'cmd': ('bash', 04:57:40 INFO - '-c', 04:57:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:57:40 INFO - 'enabled': True, 04:57:40 INFO - 'halt_on_failure': False, 04:57:40 INFO - 'name': 'check_screen_resolution'},), 04:57:40 INFO - 'run_cmd_checks_enabled': True, 04:57:40 INFO - 'sps_profile': False, 04:57:40 INFO - 'sps_profile_interval': 0, 04:57:40 INFO - 'suite': 'dromaeojs', 04:57:40 INFO - 'system_bits': '32', 04:57:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:57:40 INFO - 'title': 't-yosemite-r7-0138', 04:57:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:57:40 INFO - 'use_talos_json': True, 04:57:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:57:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:57:40 INFO - 'work_dir': 'build'} 04:57:40 INFO - ##### 04:57:40 INFO - ##### Running clobber step. 04:57:40 INFO - ##### 04:57:40 INFO - Running pre-action listener: _resource_record_pre_action 04:57:40 INFO - Running main action method: clobber 04:57:40 INFO - rmtree: /builds/slave/test/build 04:57:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:57:41 INFO - Running post-action listener: _resource_record_post_action 04:57:41 INFO - ##### 04:57:41 INFO - ##### Running read-buildbot-config step. 04:57:41 INFO - ##### 04:57:41 INFO - Running pre-action listener: _resource_record_pre_action 04:57:41 INFO - Running main action method: read_buildbot_config 04:57:41 INFO - Using buildbot properties: 04:57:41 INFO - { 04:57:41 INFO - "project": "", 04:57:41 INFO - "product": "firefox", 04:57:41 INFO - "script_repo_revision": "production", 04:57:41 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:57:41 INFO - "repository": "", 04:57:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:57:41 INFO - "buildid": "20160209030411", 04:57:41 INFO - "pgo_build": "False", 04:57:41 INFO - "basedir": "/builds/slave/test", 04:57:41 INFO - "buildnumber": 110, 04:57:41 INFO - "slavename": "t-yosemite-r7-0138", 04:57:41 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 04:57:41 INFO - "platform": "yosemite_r7", 04:57:41 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:57:41 INFO - "branch": "mozilla-central", 04:57:41 INFO - "repo_path": "mozilla-central", 04:57:41 INFO - "revision": "2dfb45d74f42d2a0010696f5fd47c7a7da94cedb", 04:57:41 INFO - "stage_platform": "macosx64", 04:57:41 INFO - "builduid": "f5e5993d0e594408b14d49e5080b5cfd", 04:57:41 INFO - "slavebuilddir": "test" 04:57:41 INFO - } 04:57:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZQHtpXkxTuqikQvta1RKDA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 04:57:41 INFO - Running post-action listener: _resource_record_post_action 04:57:41 INFO - ##### 04:57:41 INFO - ##### Running download-and-extract step. 04:57:41 INFO - ##### 04:57:41 INFO - Running pre-action listener: _resource_record_pre_action 04:57:41 INFO - Running main action method: download_and_extract 04:57:41 INFO - mkdir: /builds/slave/test/build/tests 04:57:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:41 INFO - https://queue.taskcluster.net/v1/task/ZQHtpXkxTuqikQvta1RKDA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:57:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZQHtpXkxTuqikQvta1RKDA/artifacts/public/build/test_packages.json 04:57:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZQHtpXkxTuqikQvta1RKDA/artifacts/public/build/test_packages.json 04:57:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZQHtpXkxTuqikQvta1RKDA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:57:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZQHtpXkxTuqikQvta1RKDA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:57:43 INFO - Downloaded 1277 bytes. 04:57:43 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:57:43 INFO - Using the following test package requirements: 04:57:43 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:57:43 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:57:43 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 04:57:43 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:57:43 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 04:57:43 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:57:43 INFO - u'jsshell-mac.zip'], 04:57:43 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:57:43 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 04:57:43 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:57:43 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:57:43 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 04:57:43 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:57:43 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 04:57:43 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:57:43 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 04:57:43 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:57:43 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:57:43 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 04:57:43 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:57:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:43 INFO - https://queue.taskcluster.net/v1/task/ZQHtpXkxTuqikQvta1RKDA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:57:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZQHtpXkxTuqikQvta1RKDA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:57:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZQHtpXkxTuqikQvta1RKDA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:57:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZQHtpXkxTuqikQvta1RKDA/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 04:57:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZQHtpXkxTuqikQvta1RKDA/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 04:57:44 INFO - Downloaded 17747860 bytes. 04:57:44 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'] 04:57:44 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 04:57:47 INFO - Return code: 0 04:57:47 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 04:57:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:47 INFO - https://queue.taskcluster.net/v1/task/ZQHtpXkxTuqikQvta1RKDA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:57:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZQHtpXkxTuqikQvta1RKDA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:57:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZQHtpXkxTuqikQvta1RKDA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:57:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZQHtpXkxTuqikQvta1RKDA/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 04:57:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZQHtpXkxTuqikQvta1RKDA/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 04:57:48 INFO - Downloaded 17747860 bytes. 04:57:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:57:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:57:52 INFO - Return code: 0 04:57: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')]} 04:57:52 INFO - https://queue.taskcluster.net/v1/task/ZQHtpXkxTuqikQvta1RKDA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:57:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZQHtpXkxTuqikQvta1RKDA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 04:57:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZQHtpXkxTuqikQvta1RKDA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 04:57:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZQHtpXkxTuqikQvta1RKDA/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 04:57:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZQHtpXkxTuqikQvta1RKDA/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 04:57:53 INFO - Downloaded 10706547 bytes. 04:57:53 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'] 04:57:53 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 04:57:53 INFO - Return code: 0 04:57:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:53 INFO - https://queue.taskcluster.net/v1/task/ZQHtpXkxTuqikQvta1RKDA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 04:57:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZQHtpXkxTuqikQvta1RKDA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:57:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZQHtpXkxTuqikQvta1RKDA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:57:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZQHtpXkxTuqikQvta1RKDA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 04:57:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZQHtpXkxTuqikQvta1RKDA/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 04:57:56 INFO - Downloaded 111265726 bytes. 04:57:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZQHtpXkxTuqikQvta1RKDA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:57:56 INFO - mkdir: /builds/slave/test/properties 04:57:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:57:56 INFO - Writing to file /builds/slave/test/properties/build_url 04:57:56 INFO - Contents: 04:57:56 INFO - build_url:https://queue.taskcluster.net/v1/task/ZQHtpXkxTuqikQvta1RKDA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:57:58 INFO - Running post-action listener: _resource_record_post_action 04:57:58 INFO - Running post-action listener: set_extra_try_arguments 04:57:58 INFO - ##### 04:57:58 INFO - ##### Running populate-webroot step. 04:57:58 INFO - ##### 04:57:58 INFO - Running pre-action listener: _resource_record_pre_action 04:57:58 INFO - Running main action method: populate_webroot 04:57:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:57:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:57:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:57:58 INFO - '--tppagecycles', 04:57:58 INFO - '7'], 04:57:58 INFO - 'tests': ['tsvgm']}}, 04:57:58 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:57:58 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:57:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:57:58 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:57:58 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:57:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:57:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:57:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:58 INFO - 'talos_options': ['--e10s'], 04:57:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:57:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:58 INFO - 'tests': ['damp', 'tps']}, 04:57:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:58 INFO - 'talos_options': ['--e10s'], 04:57:58 INFO - 'tests': ['damp', 'tps']}, 04:57:58 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:57:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:57:58 INFO - 'other': {'tests': ['a11yr', 04:57:58 INFO - 'ts_paint', 04:57:58 INFO - 'tpaint', 04:57:58 INFO - 'sessionrestore', 04:57:58 INFO - 'sessionrestore_no_auto_restore']}, 04:57:58 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:57:58 INFO - 'tests': ['a11yr', 04:57:58 INFO - 'ts_paint', 04:57:58 INFO - 'tpaint', 04:57:58 INFO - 'sessionrestore', 04:57:58 INFO - 'sessionrestore_no_auto_restore']}, 04:57:58 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:57:58 INFO - 'tests': ['a11yr', 04:57:58 INFO - 'ts_paint', 04:57:58 INFO - 'tpaint', 04:57:58 INFO - 'sessionrestore', 04:57:58 INFO - 'sessionrestore_no_auto_restore']}, 04:57:58 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:57:58 INFO - 'tests': ['a11yr', 04:57:58 INFO - 'ts_paint', 04:57:58 INFO - 'tpaint', 04:57:58 INFO - 'sessionrestore', 04:57:58 INFO - 'sessionrestore_no_auto_restore']}, 04:57:58 INFO - 'other_l64': {'tests': ['a11yr', 04:57:58 INFO - 'ts_paint', 04:57:58 INFO - 'tpaint', 04:57:58 INFO - 'sessionrestore', 04:57:58 INFO - 'sessionrestore_no_auto_restore']}, 04:57:58 INFO - 'other_nol64': {'tests': ['a11yr', 04:57:58 INFO - 'ts_paint', 04:57:58 INFO - 'tpaint', 04:57:58 INFO - 'sessionrestore', 04:57:58 INFO - 'sessionrestore_no_auto_restore']}, 04:57:58 INFO - 'svgr': {'tests': ['tsvgx', 04:57:58 INFO - 'tsvgr_opacity', 04:57:58 INFO - 'tart', 04:57:58 INFO - 'tscrollx', 04:57:58 INFO - 'cart']}, 04:57:58 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:57:58 INFO - 'tests': ['tsvgx', 04:57:58 INFO - 'tsvgr_opacity', 04:57:58 INFO - 'tart', 04:57:58 INFO - 'tscrollx', 04:57:58 INFO - 'cart']}, 04:57:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:58 INFO - 'tests': ['tp5o']}, 04:57:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:58 INFO - 'talos_options': ['--e10s'], 04:57:58 INFO - 'tests': ['tp5o']}, 04:57:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:58 INFO - 'talos_options': ['--xperf_path', 04:57:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:57:58 INFO - 'tests': ['tp5n']}, 04:57:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:58 INFO - 'talos_options': ['--e10s', 04:57:58 INFO - '--xperf_path', 04:57:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:57:58 INFO - 'tests': ['tp5n']}}, 04:57:58 INFO - 'talos.zip': {'path': '', 04:57:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:57:58 INFO - Running post-action listener: _resource_record_post_action 04:57:58 INFO - ##### 04:57:58 INFO - ##### Running create-virtualenv step. 04:57:58 INFO - ##### 04:57:58 INFO - Running pre-action listener: _resource_record_pre_action 04:57:58 INFO - Running main action method: create_virtualenv 04:57:58 INFO - Creating virtualenv /builds/slave/test/build/venv 04:57:58 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 04:57:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:57:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:57:58 INFO - Using real prefix '/tools/python27' 04:57:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:57:58 INFO - Installing distribute.............................................................................................................................................................................................done. 04:58:01 INFO - Installing pip.................done. 04:58:01 INFO - Return code: 0 04:58:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:58: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')]} 04:58:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58: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')]} 04:58:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101e21a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e294c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcde34b4a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cc5d30>, '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 0x101ae9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cbcb20>, '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.degx1neawc/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.0qpDrWMb28/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 04:58:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:58:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:58:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.degx1neawc/Render', 04:58:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:58:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:58:01 INFO - 'HOME': '/Users/cltbld', 04:58:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:58:01 INFO - 'LOGNAME': 'cltbld', 04:58:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:01 INFO - 'MOZ_NO_REMOTE': '1', 04:58:01 INFO - 'NO_EM_RESTART': '1', 04:58:01 INFO - 'PAGER': '/bin/cat', 04:58:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:58:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:01 INFO - 'PWD': '/builds/slave/test', 04:58:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:58:01 INFO - 'SHELL': '/bin/bash', 04:58:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0qpDrWMb28/Listeners', 04:58:01 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 04:58:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:58:01 INFO - 'USER': 'cltbld', 04:58:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:58:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:58:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:01 INFO - 'XPC_FLAGS': '0x0', 04:58:01 INFO - 'XPC_SERVICE_NAME': '0', 04:58:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:58:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:02 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 04:58:02 INFO - Cleaning up... 04:58:02 INFO - Return code: 0 04:58:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:58:02 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')]} 04:58:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:02 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')]} 04:58:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:02 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 0x101e21a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e294c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcde34b4a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cc5d30>, '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 0x101ae9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cbcb20>, '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.degx1neawc/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.0qpDrWMb28/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 04:58:02 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 04:58:02 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 04:58:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.degx1neawc/Render', 04:58:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:58:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:58:02 INFO - 'HOME': '/Users/cltbld', 04:58:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:58:02 INFO - 'LOGNAME': 'cltbld', 04:58:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:02 INFO - 'MOZ_NO_REMOTE': '1', 04:58:02 INFO - 'NO_EM_RESTART': '1', 04:58:02 INFO - 'PAGER': '/bin/cat', 04:58:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:58:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:02 INFO - 'PWD': '/builds/slave/test', 04:58:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:58:02 INFO - 'SHELL': '/bin/bash', 04:58:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0qpDrWMb28/Listeners', 04:58:02 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 04:58:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:58:02 INFO - 'USER': 'cltbld', 04:58:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:58:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:58:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:02 INFO - 'XPC_FLAGS': '0x0', 04:58:02 INFO - 'XPC_SERVICE_NAME': '0', 04:58:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:58:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:02 INFO - Downloading/unpacking psutil>=0.7.1 04:58:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:58:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:58:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:58:05 INFO - Installing collected packages: psutil 04:58:05 INFO - Running setup.py install for psutil 04:58:05 INFO - building 'psutil._psutil_osx' extension 04:58:05 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 04:58:05 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 04:58:05 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 04:58:06 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 04:58:06 INFO - building 'psutil._psutil_posix' extension 04:58:06 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 04:58:06 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:58:06 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:58:06 INFO - ^ 04:58:06 INFO - 1 warning generated. 04:58:06 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 04:58:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:58:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:58:06 INFO - Successfully installed psutil 04:58:06 INFO - Cleaning up... 04:58:06 INFO - Return code: 0 04:58:06 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:58: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')]} 04:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58: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')]} 04:58:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:06 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 0x101e21a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e294c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcde34b4a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cc5d30>, '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 0x101ae9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cbcb20>, '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.degx1neawc/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.0qpDrWMb28/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 04:58:06 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 04:58:06 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 04:58:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.degx1neawc/Render', 04:58:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:58:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:58:06 INFO - 'HOME': '/Users/cltbld', 04:58:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:58:06 INFO - 'LOGNAME': 'cltbld', 04:58:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:06 INFO - 'MOZ_NO_REMOTE': '1', 04:58:06 INFO - 'NO_EM_RESTART': '1', 04:58:06 INFO - 'PAGER': '/bin/cat', 04:58:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:58:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:06 INFO - 'PWD': '/builds/slave/test', 04:58:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:58:06 INFO - 'SHELL': '/bin/bash', 04:58:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0qpDrWMb28/Listeners', 04:58:06 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 04:58:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:58:06 INFO - 'USER': 'cltbld', 04:58:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:58:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:58:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:06 INFO - 'XPC_FLAGS': '0x0', 04:58:06 INFO - 'XPC_SERVICE_NAME': '0', 04:58:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:58:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:58:06 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 04:58:06 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 04:58:06 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 04:58:06 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 04:58:06 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 04:58:06 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 04:58:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:58:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:58:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:58:09 INFO - Installing collected packages: mozsystemmonitor 04:58:09 INFO - Running setup.py install for mozsystemmonitor 04:58:09 INFO - Successfully installed mozsystemmonitor 04:58:09 INFO - Cleaning up... 04:58:09 INFO - Return code: 0 04:58:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:58:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:09 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 0x101e21a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e294c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcde34b4a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cc5d30>, '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 0x101ae9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cbcb20>, '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.degx1neawc/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.0qpDrWMb28/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 04:58:09 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 04:58:09 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 04:58:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.degx1neawc/Render', 04:58:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:58:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:58:09 INFO - 'HOME': '/Users/cltbld', 04:58:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:58:09 INFO - 'LOGNAME': 'cltbld', 04:58:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:09 INFO - 'MOZ_NO_REMOTE': '1', 04:58:09 INFO - 'NO_EM_RESTART': '1', 04:58:09 INFO - 'PAGER': '/bin/cat', 04:58:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:58:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:09 INFO - 'PWD': '/builds/slave/test', 04:58:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:58:09 INFO - 'SHELL': '/bin/bash', 04:58:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0qpDrWMb28/Listeners', 04:58:09 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 04:58:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:58:09 INFO - 'USER': 'cltbld', 04:58:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:58:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:58:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:09 INFO - 'XPC_FLAGS': '0x0', 04:58:09 INFO - 'XPC_SERVICE_NAME': '0', 04:58:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:58:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:09 INFO - Downloading/unpacking blobuploader==1.2.4 04:58: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 04:58: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 04:58: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 04:58: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 04:58: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 04:58: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 04:58:11 INFO - Downloading blobuploader-1.2.4.tar.gz 04:58:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:58:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:58: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 04:58: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 04:58: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 04:58: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 04:58: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 04:58: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 04:58:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:58:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:58:12 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 04:58:12 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 04:58:12 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 04:58:12 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 04:58:12 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 04:58:12 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 04:58:12 INFO - Downloading docopt-0.6.1.tar.gz 04:58:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:58:13 INFO - Installing collected packages: blobuploader, requests, docopt 04:58:13 INFO - Running setup.py install for blobuploader 04:58:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:58:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:58:13 INFO - Running setup.py install for requests 04:58:13 INFO - Running setup.py install for docopt 04:58:13 INFO - Successfully installed blobuploader requests docopt 04:58:13 INFO - Cleaning up... 04:58:13 INFO - Return code: 0 04:58:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:58:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101e21a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e294c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcde34b4a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cc5d30>, '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 0x101ae9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cbcb20>, '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.degx1neawc/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.0qpDrWMb28/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 04:58:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:58:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:58:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.degx1neawc/Render', 04:58:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:58:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:58:13 INFO - 'HOME': '/Users/cltbld', 04:58:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:58:13 INFO - 'LOGNAME': 'cltbld', 04:58:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:13 INFO - 'MOZ_NO_REMOTE': '1', 04:58:13 INFO - 'NO_EM_RESTART': '1', 04:58:13 INFO - 'PAGER': '/bin/cat', 04:58:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:58:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:13 INFO - 'PWD': '/builds/slave/test', 04:58:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:58:13 INFO - 'SHELL': '/bin/bash', 04:58:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0qpDrWMb28/Listeners', 04:58:13 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 04:58:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:58:13 INFO - 'USER': 'cltbld', 04:58:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:58:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:58:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:13 INFO - 'XPC_FLAGS': '0x0', 04:58:13 INFO - 'XPC_SERVICE_NAME': '0', 04:58:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:58:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:58:14 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-Wsmgrp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:58:14 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-Pmrgbi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:58:14 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-XkZ6wP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:58:14 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-WIBeSN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:58:14 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-IQHbp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:58:14 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-akPpRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:58:14 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-C17Rvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:58:14 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-9YdHV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:58:15 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-BZEsLc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:58:15 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-skbDPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:58:15 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-LT1v2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:58:15 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-qqsFOk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:58:15 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-_n6pcu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:58:15 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-ip0S_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:58:15 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-jgDTNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:58:15 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-wlndcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:58:15 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-TFJHnD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:58:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:58:15 INFO - Running setup.py install for manifestparser 04:58:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:58:16 INFO - Running setup.py install for mozcrash 04:58:16 INFO - Running setup.py install for mozdebug 04:58:16 INFO - Running setup.py install for mozdevice 04:58:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:58:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:58:16 INFO - Running setup.py install for mozfile 04:58:16 INFO - Running setup.py install for mozhttpd 04:58:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:58:16 INFO - Running setup.py install for mozinfo 04:58:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:58:17 INFO - Running setup.py install for mozInstall 04:58:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:58:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:58:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:58:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:58:17 INFO - Running setup.py install for mozleak 04:58:17 INFO - Running setup.py install for mozlog 04:58:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:58:17 INFO - Running setup.py install for moznetwork 04:58:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:58:17 INFO - Running setup.py install for mozprocess 04:58:17 INFO - Running setup.py install for mozprofile 04:58:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:58:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:58:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:58:17 INFO - Running setup.py install for mozrunner 04:58:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:58:18 INFO - Running setup.py install for mozscreenshot 04:58:18 INFO - Running setup.py install for moztest 04:58:18 INFO - Running setup.py install for mozversion 04:58:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:58:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:58:18 INFO - Cleaning up... 04:58:18 INFO - Return code: 0 04:58:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:58:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:18 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 0x101e21a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e294c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcde34b4a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cc5d30>, '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 0x101ae9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cbcb20>, '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.degx1neawc/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.0qpDrWMb28/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 04:58:18 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 04:58:18 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 04:58:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.degx1neawc/Render', 04:58:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:58:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:58:18 INFO - 'HOME': '/Users/cltbld', 04:58:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:58:18 INFO - 'LOGNAME': 'cltbld', 04:58:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:18 INFO - 'MOZ_NO_REMOTE': '1', 04:58:18 INFO - 'NO_EM_RESTART': '1', 04:58:18 INFO - 'PAGER': '/bin/cat', 04:58:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:58:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:18 INFO - 'PWD': '/builds/slave/test', 04:58:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:58:18 INFO - 'SHELL': '/bin/bash', 04:58:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0qpDrWMb28/Listeners', 04:58:18 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 04:58:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:58:18 INFO - 'USER': 'cltbld', 04:58:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:58:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:58:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:18 INFO - 'XPC_FLAGS': '0x0', 04:58:18 INFO - 'XPC_SERVICE_NAME': '0', 04:58:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:58:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:58:18 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-gfbnGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:58:18 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)) 04:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:58:18 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-OzhJlW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:58:19 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)) 04:58:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:58:19 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-tGL_A3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:58:19 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)) 04:58:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:58:19 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-hCEWZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:58:19 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)) 04:58:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:58:19 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-tz9sOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:58:19 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)) 04:58:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:58:19 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-HP_jvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:58:19 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)) 04:58:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:58:19 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-ktn4Z2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:58:19 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)) 04:58:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:58:19 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-cdCVRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:58:19 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)) 04:58:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:58:19 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-7uNd6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:58:19 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)) 04:58:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:58:19 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-qhj2xo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:58:19 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)) 04:58:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:58:19 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-Vr4yL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:58:19 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)) 04:58:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:58:20 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-4wG5Nz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:58:20 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)) 04:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:58:20 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-qRv2Ht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:58:20 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)) 04:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:58:20 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-m1eZ4Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:58:20 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)) 04:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:58:20 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-NJm0A9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:58:20 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)) 04:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:58:20 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-5IDiJb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:58:20 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)) 04:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:58:20 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-fzC4Id-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:58:20 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)) 04:58:20 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)) 04:58:20 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)) 04:58:20 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)) 04:58:20 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)) 04:58:20 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)) 04:58:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:58:20 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 04:58:20 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 04:58:20 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 04:58:20 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 04:58:20 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 04:58:20 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 04:58:22 INFO - Downloading blessings-1.6.tar.gz 04:58:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:58:23 INFO - Installing collected packages: blessings 04:58:23 INFO - Running setup.py install for blessings 04:58:23 INFO - Successfully installed blessings 04:58:23 INFO - Cleaning up... 04:58:23 INFO - Return code: 0 04:58:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:58:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:58:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:58:23 INFO - Reading from file tmpfile_stdout 04:58:23 INFO - Current package versions: 04:58:23 INFO - blessings == 1.6 04:58:23 INFO - blobuploader == 1.2.4 04:58:23 INFO - docopt == 0.6.1 04:58:23 INFO - manifestparser == 1.1 04:58:23 INFO - mozInstall == 1.12 04:58:23 INFO - mozcrash == 0.16 04:58:23 INFO - mozdebug == 0.1 04:58:23 INFO - mozdevice == 0.48 04:58:23 INFO - mozfile == 1.2 04:58:23 INFO - mozhttpd == 0.7 04:58:23 INFO - mozinfo == 0.9 04:58:23 INFO - mozleak == 0.1 04:58:23 INFO - mozlog == 3.1 04:58:23 INFO - moznetwork == 0.27 04:58:23 INFO - mozprocess == 0.22 04:58:23 INFO - mozprofile == 0.28 04:58:23 INFO - mozrunner == 6.11 04:58:23 INFO - mozscreenshot == 0.1 04:58:23 INFO - mozsystemmonitor == 0.0 04:58:23 INFO - moztest == 0.7 04:58:23 INFO - mozversion == 1.4 04:58:23 INFO - psutil == 3.1.1 04:58:23 INFO - requests == 1.2.3 04:58:23 INFO - wsgiref == 0.1.2 04:58:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:58:23 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')]} 04:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:23 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')]} 04:58:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:23 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 0x101e21a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e294c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcde34b4a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cc5d30>, '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 0x101ae9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cbcb20>, '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.degx1neawc/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.0qpDrWMb28/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 04:58:23 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 04:58:23 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 04:58:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.degx1neawc/Render', 04:58:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:58:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:58:23 INFO - 'HOME': '/Users/cltbld', 04:58:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:58:23 INFO - 'LOGNAME': 'cltbld', 04:58:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:23 INFO - 'MOZ_NO_REMOTE': '1', 04:58:23 INFO - 'NO_EM_RESTART': '1', 04:58:23 INFO - 'PAGER': '/bin/cat', 04:58:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:58:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:23 INFO - 'PWD': '/builds/slave/test', 04:58:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:58:23 INFO - 'SHELL': '/bin/bash', 04:58:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0qpDrWMb28/Listeners', 04:58:23 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 04:58:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:58:23 INFO - 'USER': 'cltbld', 04:58:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:58:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:58:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:23 INFO - 'XPC_FLAGS': '0x0', 04:58:23 INFO - 'XPC_SERVICE_NAME': '0', 04:58:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:58:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:23 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)) 04:58:23 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)) 04:58:23 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)) 04:58:23 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)) 04:58:23 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)) 04:58:23 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)) 04:58:23 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)) 04:58:23 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)) 04:58:23 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)) 04:58:23 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)) 04:58:23 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)) 04:58:23 INFO - Cleaning up... 04:58:23 INFO - Return code: 0 04:58:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:58:23 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')]} 04:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:23 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')]} 04:58:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:23 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 0x101e21a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e294c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcde34b4a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cc5d30>, '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 0x101ae9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cbcb20>, '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.degx1neawc/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.0qpDrWMb28/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 04:58:23 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 04:58:23 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 04:58:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.degx1neawc/Render', 04:58:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:58:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:58:23 INFO - 'HOME': '/Users/cltbld', 04:58:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:58:23 INFO - 'LOGNAME': 'cltbld', 04:58:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:23 INFO - 'MOZ_NO_REMOTE': '1', 04:58:23 INFO - 'NO_EM_RESTART': '1', 04:58:23 INFO - 'PAGER': '/bin/cat', 04:58:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:58:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:23 INFO - 'PWD': '/builds/slave/test', 04:58:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:58:23 INFO - 'SHELL': '/bin/bash', 04:58:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0qpDrWMb28/Listeners', 04:58:23 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 04:58:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:58:23 INFO - 'USER': 'cltbld', 04:58:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:58:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:58:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:23 INFO - 'XPC_FLAGS': '0x0', 04:58:23 INFO - 'XPC_SERVICE_NAME': '0', 04:58:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:58:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:24 INFO - Downloading/unpacking jsonschema 04:58:24 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 04:58:24 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 04:58:24 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 04:58:24 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 04:58:24 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 04:58:24 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 04:58:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:58:26 INFO - Downloading/unpacking functools32 (from jsonschema) 04:58:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:26 INFO - Downloading functools32-3.2.3-2.tar.gz 04:58:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:58:26 INFO - warning: no files found matching '*.txt' 04:58:26 INFO - no previously-included directories found matching 'build' 04:58:26 INFO - no previously-included directories found matching 'dist' 04:58:26 INFO - no previously-included directories found matching '.git*' 04:58:26 INFO - Installing collected packages: jsonschema, functools32 04:58:26 INFO - Running setup.py install for functools32 04:58:27 INFO - warning: no files found matching '*.txt' 04:58:27 INFO - no previously-included directories found matching 'build' 04:58:27 INFO - no previously-included directories found matching 'dist' 04:58:27 INFO - no previously-included directories found matching '.git*' 04:58:27 INFO - Successfully installed jsonschema functools32 04:58:27 INFO - Cleaning up... 04:58:27 INFO - Return code: 0 04:58:27 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:58:27 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')]} 04:58:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:27 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')]} 04:58:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:27 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 0x101e21a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e294c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcde34b4a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cc5d30>, '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 0x101ae9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cbcb20>, '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.degx1neawc/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.0qpDrWMb28/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 04:58:27 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 04:58:27 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 04:58:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.degx1neawc/Render', 04:58:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:58:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:58:27 INFO - 'HOME': '/Users/cltbld', 04:58:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:58:27 INFO - 'LOGNAME': 'cltbld', 04:58:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:27 INFO - 'MOZ_NO_REMOTE': '1', 04:58:27 INFO - 'NO_EM_RESTART': '1', 04:58:27 INFO - 'PAGER': '/bin/cat', 04:58:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:58:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:27 INFO - 'PWD': '/builds/slave/test', 04:58:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:58:27 INFO - 'SHELL': '/bin/bash', 04:58:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0qpDrWMb28/Listeners', 04:58:27 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 04:58:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:58:27 INFO - 'USER': 'cltbld', 04:58:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:58:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:58:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:27 INFO - 'XPC_FLAGS': '0x0', 04:58:27 INFO - 'XPC_SERVICE_NAME': '0', 04:58:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:58:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:27 INFO - Downloading/unpacking flake8 04:58:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:29 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:58:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:58:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:58:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:58:30 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 04:58:30 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 04:58:30 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 04:58:30 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 04:58:30 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 04:58:30 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 04:58:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:58:30 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 04:58:30 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 04:58:30 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 04:58:30 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 04:58:30 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 04:58:30 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 04:58:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:58:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:58:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:58:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:58:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:58:30 INFO - no previously-included directories found matching 'docs/_build' 04:58:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:58:30 INFO - Running setup.py install for pep8 04:58:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:58:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:58:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:58:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:58:31 INFO - no previously-included directories found matching 'docs/_build' 04:58:31 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:58:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:58:31 INFO - Cleaning up... 04:58:31 INFO - Return code: 0 04:58:31 INFO - Running post-action listener: _resource_record_post_action 04:58:31 INFO - Running post-action listener: _start_resource_monitoring 04:58:31 INFO - Starting resource monitoring. 04:58:31 INFO - ##### 04:58:31 INFO - ##### Running install step. 04:58:31 INFO - ##### 04:58:31 INFO - Running pre-action listener: _resource_record_pre_action 04:58:31 INFO - Running main action method: install 04:58:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:58:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:58:31 INFO - Reading from file tmpfile_stdout 04:58:31 INFO - Detecting whether we're running mozinstall >=1.0... 04:58:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:58:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:58:31 INFO - Reading from file tmpfile_stdout 04:58:31 INFO - Output received: 04:58:31 INFO - Usage: mozinstall [options] installer 04:58:31 INFO - Options: 04:58:31 INFO - -h, --help show this help message and exit 04:58:31 INFO - -d DEST, --destination=DEST 04:58:31 INFO - Directory to install application into. [default: 04:58:31 INFO - "/builds/slave/test"] 04:58:31 INFO - --app=APP Application being installed. [default: firefox] 04:58:31 INFO - mkdir: /builds/slave/test/build/application 04:58:31 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'] 04:58:31 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 04:59:05 INFO - Reading from file tmpfile_stdout 04:59:05 INFO - Output received: 04:59:05 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:59:05 INFO - Running post-action listener: _resource_record_post_action 04:59:05 INFO - ##### 04:59:05 INFO - ##### Running run-tests step. 04:59:05 INFO - ##### 04:59:05 INFO - Running pre-action listener: _resource_record_pre_action 04:59:05 INFO - Running main action method: run_tests 04:59:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:59:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:59:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:59:05 INFO - 2016-02-09 04:59:05.548 screenresolution[1656:7609] starting screenresolution argv=screenresolution get 04:59:05 INFO - 2016-02-09 04:59:05.550 screenresolution[1656:7609] Display 0: 1600x1200x32@60 04:59:05 INFO - 2016-02-09 04:59:05.556 screenresolution[1657:7612] starting screenresolution argv=screenresolution list 04:59:05 INFO - Available Modes on Display 0 04:59:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:59:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:59:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:59:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:59:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:59:05 INFO - Intel Iris: 04:59:05 INFO - Chipset Model: Intel Iris 04:59:05 INFO - Type: GPU 04:59:05 INFO - Bus: Built-In 04:59:05 INFO - VRAM (Dynamic, Max): 1536 MB 04:59:05 INFO - Vendor: Intel (0x8086) 04:59:05 INFO - Device ID: 0x0a2e 04:59:05 INFO - Revision ID: 0x0009 04:59:05 INFO - Displays: 04:59:05 INFO - Display: 04:59:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:59:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:59:05 INFO - Display Serial Number: 1600x1200 60 04:59:05 INFO - Main Display: Yes 04:59:05 INFO - Mirror: Off 04:59:05 INFO - Online: Yes 04:59:05 INFO - Rotation: Supported 04:59:05 INFO - Return code: 0 04:59:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:59:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:59:05 INFO - Python 2.7.3 04:59:05 INFO - Return code: 0 04:59:05 INFO - grabbing minidump binary from tooltool 04:59:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:05 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 0x101cc5d30>, '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 0x101ae9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cbcb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:59:05 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 04:59:05 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 04:59:05 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:59:05 INFO - Return code: 0 04:59:05 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:59:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:59:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:59:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:59:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:59:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:59:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:59:07 INFO - Return code: 0 04:59:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZQHtpXkxTuqikQvta1RKDA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0138', '--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 04:59:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZQHtpXkxTuqikQvta1RKDA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0138 --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 04:59:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.degx1neawc/Render', 04:59:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:59:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:59:07 INFO - 'HOME': '/Users/cltbld', 04:59:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:59:07 INFO - 'LOGNAME': 'cltbld', 04:59:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:59:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:59:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:07 INFO - 'MOZ_NO_REMOTE': '1', 04:59:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:59:07 INFO - 'NO_EM_RESTART': '1', 04:59:07 INFO - 'PAGER': '/bin/cat', 04:59:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:59:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:59:07 INFO - 'PWD': '/builds/slave/test', 04:59:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:59:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:59:07 INFO - 'SHELL': '/bin/bash', 04:59:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0qpDrWMb28/Listeners', 04:59:07 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 04:59:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:59:07 INFO - 'USER': 'cltbld', 04:59:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:59:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:59:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:07 INFO - 'XPC_FLAGS': '0x0', 04:59:07 INFO - 'XPC_SERVICE_NAME': '0', 04:59:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:59:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZQHtpXkxTuqikQvta1RKDA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0138', '--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 04:59:07 INFO - mozversion application_buildid: 20160209030411 04:59:07 INFO - mozversion application_changeset: 2dfb45d74f42d2a0010696f5fd47c7a7da94cedb 04:59:07 INFO - mozversion application_display_name: Nightly 04:59:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:59:07 INFO - mozversion application_name: Firefox 04:59:07 INFO - mozversion application_remotingname: firefox 04:59:07 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:59:07 INFO - mozversion application_vendor: Mozilla 04:59:07 INFO - mozversion application_version: 47.0a1 04:59:07 INFO - mozversion platform_buildid: 20160209030411 04:59:07 INFO - mozversion platform_changeset: 2dfb45d74f42d2a0010696f5fd47c7a7da94cedb 04:59:07 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:59:07 INFO - mozversion platform_version: 47.0a1 04:59:07 INFO - using testdate: 1455022747 04:59:07 INFO - actual date: 1455022747 04:59:07 INFO - starting webserver on 'localhost:49285' 04:59:07 INFO - SUITE-START | Running 2 tests 04:59:07 INFO - TEST-START | dromaeo_css 04:59:07 INFO - operating with platform_type : mac_ 04:59:07 INFO - Initialising browser for dromaeo_css test... 04:59:07 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/tmpAaDViy/profile http://localhost:49285/getInfo.html) 04:59:10 INFO - PROCESS | 1675 | __metrics Screen width/height:1600/1200 04:59:10 INFO - PROCESS | 1675 | colorDepth:24 04:59:10 INFO - PROCESS | 1675 | Browser inner width/height: 1024/689 04:59:10 INFO - PROCESS | 1675 | __metrics 04:59:10 INFO - PROCESS | 1675 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:59:10 INFO - PROCESS | 1675 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:59:10 INFO - TEST-INFO | 1675: exit 0 04:59:10 INFO - Browser initialized. 04:59:10 INFO - Running cycle 1/1 for dromaeo_css test... 04:59:10 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/tmpAaDViy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:59:22 INFO - PROCESS | 1678 | RSS: Main: 245026816 04:59:22 INFO - PROCESS | 1678 | 05:00:13 INFO - PROCESS | 1678 | 1455022813833 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] 05:02:24 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49285/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49285/tests/dromaeo/cssquery-ext.html) 05:02:26 INFO - PROCESS | 1678 | RSS: Main: 354603008 05:02:26 INFO - PROCESS | 1678 | 05:05:28 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49285/tests/dromaeo/cssquery-ext.html (next: http://localhost:49285/tests/dromaeo/cssquery-jquery.html) 05:05:29 INFO - PROCESS | 1678 | RSS: Main: 382730240 05:05:29 INFO - PROCESS | 1678 | 05:08:31 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49285/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49285/tests/dromaeo/cssquery-mootools.html) 05:08:32 INFO - PROCESS | 1678 | RSS: Main: 381747200 05:08:32 INFO - PROCESS | 1678 | 05:11:34 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49285/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49285/tests/dromaeo/cssquery-prototype.html) 05:11:35 INFO - PROCESS | 1678 | RSS: Main: 348585984 05:11:35 INFO - PROCESS | 1678 | 05:14:38 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49285/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49285/tests/dromaeo/cssquery-yui.html) 05:14:38 INFO - PROCESS | 1678 | RSS: Main: 344608768 05:14:38 INFO - PROCESS | 1678 | 05:17:41 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49285/tests/dromaeo/cssquery-yui.html (next: http://localhost:49285/tests/dromaeo/cssquery-dojo.html) 05:17:41 INFO - PROCESS | 1678 | RSS: Main: 390307840 05:17:41 INFO - PROCESS | 1678 | 05:17:41 INFO - PROCESS | 1678 | __start_tp_report 05:17:41 INFO - PROCESS | 1678 | _x_x_mozilla_page_load 05:17:41 INFO - PROCESS | 1678 | _x_x_mozilla_page_load_details 05:17:41 INFO - PROCESS | 1678 | |i|pagename|runs| 05:17:41 INFO - PROCESS | 1678 | |0;dojo.html;3446.8621255149797;3476.669716376943;3501.8774342897987;3547.7339199560033;3567;5637.943620563793;5738.7991420300295;5749.396313387092;5783.248177736894;5793.33376661684;5246.42607217835;5389.380221274555;5677.886442271152;5765.365809760923;5788.5369170466365;5210.400803907552;5230.7646155922885;5254.81608143715;5263.26314315996;5314.468553144693;4421.557844215585;5339.466053394649;5340.813071542497;5344.064788661969;5345.732713364336;5285.233641122035;5304.787808487656;5306.628536002481;5308.840734777963;5312.4687531246955;5323.547498462635;5325.068113080215;5326;5336.066188417011;5342.465753424665;5208.5572726318305;5256.106461901486;5354.678719276856;5361.571074314045;5386.380566234894;4689.7655117244;5678.148277758328;5726.484616384545;5777.19119323295;5794.97102514489;6282.4974002079725;6310.5267104967315;6315.24217093947;6331.398517140864;6332.240131184241;5147.613928955306;6170.8765824683705;6290.182276304097;6346.6509341986175;6373.776917807901;5788.5369170466265;5847.561432892508;5849.532037436995;5850.707464626752;5853.385394533598;6255.0617407388345;6325.209348831396;6325.778597749057;6329.905051424233;6330.746770129235;6108.5545605439265;6110.4195101466175;6228.719707613168;6234.251889773256;6236.03341482071;5717.456841600041;6081.179040829431;6319.115323854664;6337.049442583557;6344.619322840645;6106.490508973763;6149.354317796657;6266.968665156645;6276.6547839869245;6278.6860656966965;6164.506839452833;6304.464120549713;6310.337414571496;6314.052892066226;6319.0837328587095;4918.163912134945;4921.26181072842;4936.950630493649;4939.160342741742;4941.703497790144;4328.588784065509;4349.06495103548;4417.491988421372;4424.269995450714;4444.28891377378;5758.913616295759;5789.189513468118;5796.681182535001;5820.30156381237;5825.912611310834;6308.936910630927;6324.114623952651;6327.810165695037;6334.3665633436285;6335.398137177053;4770.475247722748;5663.178839068312;5777.711114444345;5817.534597232211;5863.501602363762;5411.161270003156;5417;5421.186821976735;5438.483344082306;5441.102218134043;6364.363563643598;6411.4229719325485;6419;6427.196600424947;6433.131527243856;6187.876242475215;6215;6314;6339.809805705651;6354.555181137276;6296.622202667854;6314.368563143649;6316.936830631635;6318.368163183645;6321.841953951188;6121.724522396592;6159.538034647329;6174.043023331391;6177.536684748572;6180.7527698891545;5380.92381523689;6199.752009919733;6234.906476402948;6276.811695649138;6285.214348206474;6118.755249789959;6143.052618484886;6158.784442544489;6163.599366041193;6206.255249369924;6075.635461872302;6151;6157.507399408126;6170.475509581735;6183.536234782319;5829.329627092939;5934.3175534814045;5940.8811823764145;5963.165156878127;6022.54830887694;5106.948930510647;6186.381361863778;6187.381261873777;6199.1011303361665;6206.286277078013;6004.909926351021;6014.879702406015;6018.277806663228;6039.094135879654;6045.576809623284 05:17:41 INFO - PROCESS | 1678 | |1;ext.html;457.599600349694;479.8268234167462;484.83757941089743;557.197635405017;561.8230257468897;37674.43488347677;37949.24101517968;37975.62024379755;37984.43023354652;38205.23589528208;36812.815935920284;37336.81331593338;41095.79452102743;41151;41163.58836411635;9434.66978655749;9670.032996700309;9681.854772178423;9686.031396860328;9715.902840971607;9484.66803661872;9522.381045232072;9584.904150958506;9672.90327096727;9708.708738737849;9730.562124704406;9799.804003919917;9824.21406287499;9833.704988850346;9856.112949834513;8945.597448114786;9210.171084602418;9692.806143877118;9784;9787.070228328263;9572.32993690442;9735.513224338754;9744.75638109046;9746.610135594568;9748.31761776676;39406.877105976324;39802.80098599517;39824.00439989023;39878.401823972665;40201.79899100515;3140.262038420969;3190.5533225348468;3213.0682102190335;3331.7834340768013;3455.6544345565494;28024.43951120966;28265.434691306058;28355.432891342058;29776.8511157445;29883.10350689483;2781.3463835998523;2804.467151241258;2815.8310501369983;2831.1506548035713;2855.7858160638034;414376;417713.999999997;418494;418526;419160;55362;56662;61530.69234653798;62069.068963965576;62165.68917155385;54679.17981230285;56541;71068;71111;71339.2866071343;16064.919675401548;16129.919350403174;16336.183190840411;16358.182090895407;16368;12468.875311246953;12530.248185108923;12537.686557835945;12542;12545.874541254652;17322.48032559025;18515;19840.60318793616;21167;21232.150713971576;8847.98571145066;9129.589168487433;9147.2682185425;9159.816803663889;9244.3991140577;979.7893452907659;995.2983146881431;1007.2143727892255;1037.994810025945;1087.9728006799735;27784.30539236495;27802.44395112127;27814.66858100006;27912.02307919213;28168.71831281661;914.346242436661;1052.273930987616;1102.536934487517;1116.1851848150734;1210.6126039667397;14558.199299038442;14579.489717860037;14633.975621706591;14749;14938.402463901539;595076;653646.7317663381;655985;658865;660774;57692.55768605734;58486;58556;58611;58631.82736345249;1460.8466111058185;1467.5523965190505;1479.6892652543086;1495.327102803721;1502.9248537573078;28039.158825235274;28098.438031239668;28595.428091438473;28698.139055827523;28713.85643071771;48121.75939120282;48322.03355932932;48456.27315590339;48508;48535.5146448531;612438;618050;643019;643065;644233;32582;32694.509582355808;32695.673043269264;32969.505457418636;32976.505352420216;38908;42213.94465138396;43265;43494.34758478688;43756.56243437652;34248.65751342455;35681.46477802783;36662.450063248536;36815;36901.26197476089;36145.27709445849;36547.634523655484;36636.084097897765;36836.44745328876;36855.63144368522;35138.47292290567;36234.27531449409;36593.81703091467;36681.816590916875;36772.44841327329;30042.69957300399;32708;32788.83605581957;33048.834755826065;33057.00828975135;21851.890740546194;22163;22612;24276.542522241863;24953.500929981663 05:17:41 INFO - PROCESS | 1678 | |2;jquery.html;360.1123231235006;363.32421695646104;363.52015339751523;367.7646306363926;369.58790948092883;8261.91738082619;10365.740856478591;11638.767224655501;12190.81713774294;18798.718019229724;18178.4546463606;19400.902995485;20025.499362515944;20431.795682043175;20585.897070514628;3884.961150388502;5410.648307859977;6629.801105966804;6636.170478690164;6656.101426307459;4622.306654001893;7199.244079371643;7525.285097915689;7538.283863033003;7539.623018849063;7074.752383666572;7369.410447164214;7374.188839227681;7380.1512826025155;7390.667419966115;6259.874802503924;7354.2645735426295;7450.739224127184;7466.328030477229;7471.290227428385;6434.745224681189;6484.967575162141;7098.716051357939;7129.215786263507;7188.101487314086;27064.32339191536;27182.864085679445;27197.320066998484;27317.863410682818;27386;2182.9126834926583;2277.5900337939165;2384.5588566115152;2673.8395696258094;3127.766889841714;15160.848391516165;15693.764593531107;15860.762088568681;15890;16109.597260068593;1792.7221280701513;1813.184067169779;1882.6234753049307;1888.055972013993;1949.4249196487071;89403;93848.53075734645;102408;104583.4770826141;113656;15464.304106315243;15505.9224703878;16959.660806783795;17628.501577365812;19780.60438791216;28499.430011399654;28880.833937454776;28891;28918.855405722836;29008.85495572551;10643;10661.307015043998;10693.144548436107;10698.51856666452;10735.624253151102;9059.048799875918;9062.410943288665;9067.727968160965;9151.496667683208;9216.95391523038;7302.146668321132;7337.74317898871;7382.815429614303;8271.503709777433;8659.523726194993;2757.7104404037286;3367.393869103585;3479.443289073736;3543.291341731664;3570.071781336871;890.5636238243214;920.2408013388981;932.4312169576552;998.4758002048983;1010.2271762101851;13255.867441325463;19616.11727472267;20014.599708006048;20103.39689809308;20213.292534761214;891.3270480786964;924.5608336040461;953.4803532075035;975.3855071305032;982.872226610536;9943.502824858728;10437.708761642141;10672.893271067345;10746.24776265654;10860.13118950482;724877;731870;734904;745906;754309.2284538542;79567;115164.27253591202;117669;118624.40687796679;123949;1030.721705139623;1043.9217058720626;1052.8841827398826;1067.3222503710044;1069.2301542889106;13539.729205416033;16089.115098669685;17539.473815785546;18059.909700451415;18148.637027259643;34904.77833275823;48431.30490432818;48899;49576.752116239186;49989.500104998486;65443.69112617626;66509.33490665225;67259;68486.65756671184;70667.64666176842;7326.635507070361;7372.004779354933;7588.962055189689;7589.279018493235;7607.809804754926;9086;12083.275003499819;12285.75428491443;12298.938505307775;12303.384830758605;9881;10280.434576098387;10366.118879895294;10403.375797452178;10648.733781655521;3934.527856657105;10076.143527800219;10360.844587331347;10415.94792026035;10588.4705764713;10534.104601108991;10782.838257425989;10945.507452164513;11018.834717479405;11034.172437067413;7667.731629392944;7780.84438311242;7790;7792.337651299703;7840.921590784019;9947.204223662235;10796.528485616074;10809.729756756144;10901.454927253764;10922.235443518877 05:17:41 INFO - PROCESS | 1678 | |3;mootools.html;1319.4524272426943;1402.4390243902444;1555.292341984397;1737.4527023987443;1939.9709004364936;8053.275205231528;8616.224539791418;8709.477431354107;8714;8720.694775682852;8467.153284671529;8742.825143497126;8746.081661425555;8756;8771.91228087719;2120.4380839077658;2162.1783722185546;2165.069020321261;2457.520783447224;2486.639437281593;2068.7620923593827;2208.403730992631;2209.823214142865;2264.954700905981;2516.7609077137736;2389.1279682915697;2461.212412028152;2466.6803260255765;2467.2721547143638;2469.506098780242;2448.853068815868;2449.7550244975537;2454.8158888083467;2459.053264493165;2460.2004348586693;2371.2886134159685;2421.8425802322968;2426.963595546051;2427.963580546293;2434.403571125086;8625.611847466878;8719.956400217958;8726.563671816384;8851.955740221321;8859.955700221522;5363.222332761728;5454.672719636835;5497.147942068986;5500;5501.14732216507;3481.9129521761906;3579.713622910161;3649.5255616769914;3664.193877346979;3668.6881615062753;1067.3169171730099;1070.6948519671935;1089.967300980964;1099.1756182862853;1107.645553422905;12244.448999795031;12276.508939642403;12278.877211227862;12284.692882678004;12298.938505307417;4790.640701947368;4867.099586576494;4883.438404583448;4898.657094003457;4902.1911384621135;10009.599616015277;10041.397516148909;10047.547860346302;10055.547500362502;10060.798784024279;5438.7280635968045;5486.643368181056;5498.532624726943;5499.257600223918;5501.724913754297;4102.425660407545;4930.087933732271;4932.630052746058;4975.179095449211;4983.700977941335;3702.9444558331647;3988.062805240766;4023.657989070962;4044.6854772199154;4071.89820254496;1213.1144264686827;1294.566320282697;1296.461968283152;1302.7459645369252;1314.4085161677283;1281.9807702884464;1307.45740517686;1351.1622793867864;1353.1407556201882;1364.6383708317303;7974.800629984296;8045.477043992122;8068.031836179579;8093.231143041402;8100.878486822702;1161.4018780328138;1177.717347836513;1182.8757980412106;1190.595197632809;1207.2032458577296;6236.438720515084;6299.6535190564955;6302.8424289392215;6307.873842523124;6314.684265786692;10248.59005639781;10431.269811113301;10464.843027354596;10575.682729518127;10587.682369528926;10114.393136411838;10419.479026048819;10419.583216671399;10420.478976051167;10456.686299410878;8181.568225560503;8234.958825205955;8269.173082691803;8305.46014509055;8329.791755206168;8105.9867516560425;8135.389845761473;8149.918500814916;8215.137410572042;8315.584220788814;9617.759556010877;9644.95177524108;9654.662086826927;9891.159251463418;9894.851577226491;9990.550425231027;10052.195824334181;10182.439965801952;10227.693169204937;10372.325798823053;7578.848423031619;7601.0878694557005;7612.8477430452185;7653.617319134132;7704.730334438268;7255.383292420203;7437.367823735043;8283;8351.081381047958;8360.95488063992;7660.157382688011;7735.845283094194;7739.458237923292;7777.338926191337;7908.84182316362;7644.197359277196;7649.158592554926;7702.922970770221;7797.298243158143;7829.7259595913865;7760.805979850549;7790.065192176975;7798.493097948615;7835.764927052198;7836.84326313482;5972.970135149297;7083.645817708991;7101.4673899458785;7154.069970903749;7187.2453392393045;7172.426205903411;7209.531380460253;7252.093488313961;7252.818679532843;7279.854402911807 05:17:41 INFO - PROCESS | 1678 | |4;prototype.html;293.11811774889225;317.04095112285336;322.9079712282;326.3212517962638;332.03874782504636;6277.372262773721;6651.534392592521;6680.6993685284215;6745.797626071213;6757.054012438262;6607.570507916982;6627.37039981201;6628.33716628337;6648.933510664892;6657.267700552935;4710.19926612475;4795.640326975474;4834.758262086882;4968.701877887329;4979.950200497985;4876.9268460972935;4922.8030878764985;4923.58149557288;4925.556699897009;4954.479779623141;4064.3700226464944;4789.946211833391;4856.927146092811;4899.853004409855;4905.509449055084;4646.442426908776;4732.384789977315;4766.952330476685;4830.468648448667;4902.460729319772;3454.3954807908767;4131.772752498611;4168.937465938014;4178.6657067434535;4188.874333769992;6137.048757442603;6255.155554000197;6314.242290925073;6336.904946425807;6350.555461117724;5213.504717051874;5392.946070539284;5751.511121554673;5751.568632352591;5757.193992841006;6306.243250809886;6987.650617469157;7005.579665220052;7008.19405768338;7013.228544860061;3796.4115562087923;3858.4019476980834;4553.089382123589;4575.4738205106505;4635.513271106519;7294.234105418907;7436.66535005926;7538.660760265801;7547.245275472409;7547.622618869034;4607.401037865123;4643.628509719214;4643.955110100201;4646.83736069236;4656.743879086615;4684;4710.24636058229;4720.740359280273;4731.030138821533;4736.502667219892;5593.776248950077;5619.7471113799975;5628.127640215773;5634.661920284796;5644.491995720405;5758.654480731169;6849.965750171317;7150.356467917913;7153.141623005273;7153.928460715326;1358.3208395802098;1608.107500337324;1638.2218446237941;1640.23728966029;1641.0809946430038;1030.2324768047852;1035.316690983962;1045.1795340657548;1052.315994603514;1056.587930707025;6699.43054840344;6708.094407255056;6737.730490780314;6745.224299205556;6747.190337159474;5637.773079633522;7366.7053317866685;7380.74167404149;7383.6677349519405;7389.965404843326;6462.515311351667;6700.83247918806;6712.463002959751;6714.932850671431;6732.293109223461;3338.6812209177724;3805.8858234253016;3892.4939757831303;3913.3934240192816;3928.03763078042;7700.03448224165;7725.806854828675;7740.92259077402;7741.922580774233;7772.65023073963;7246.855062898712;7581.203973582805;7599.278068583476;7599.696012159452;7601.08786945559;7692.576908269987;7694.615269236628;7713;7720.9190713301305;7722.768316950501;6361.936380636134;7342.449316301192;7344.632768361667;7350.19147893742;7350.926490735024;6971.372576468142;7259.709611615476;7262.6731797070315;7263.6005019724425;7277.636118194175;7695.23047695226;7710.344620707303;7718.614069296625;7720.613969301625;7747;4643.883902902455;4666.3700400445505;4684.180268452939;4687.765611719332;4698.483166851712;7082.504224704221;7320.780376588711;7338.192798792022;7346.302101300368;7383.630818458948;7086.929130708627;7102.3962963148715;7112.964435177791;7127.2516385778745;7150.64246787669;6866.519343646097;7077.363037326665;7092.716291348288;7102.14774227096;7139.107611548557;6662.500312476487;6953.165620125617;6956.339147780953;6957.234704182435;6965.616891071039;6935.965320173367;7003.54476958996;7025.789226323219;7102.289771022856;7186.317299856505;6667.166604174478;6792.21889482696;6914.101166848278;6952.582845029315;6997.195322537973 05:17:41 INFO - PROCESS | 1678 | |5;yui.html;664.7241394821149;695.0790202981049;709.1808960650447;720.1610124205301;769.1001528211991;14775.408983640642;14790.556283311491;14959.700805983874;14983.175925324103;15059.322330495126;13724;13786.586402407918;13797.96515261357;13798.172109673427;13799.379027943742;699.2133849419403;703.9718411263543;709.4785332780402;841.8021764885247;862.3187681731424;845.9280961118282;859.7420773767844;870.4124715816798;871.172386233078;871.7776966873438;898.1422741282059;913.1234015345276;914.1178762494192;915.9084091590854;916.7708072981754;727.3889932456735;736.6316841579211;888.4846788862444;895.5164211325877;910.8588168833842;562.6961440821992;670.4703284405363;670.577536152221;670.6680193304345;671.0571646836203;15014.849851501564;15037.248137593077;15041.548753537301;15114.319855606414;15162.469313574082;13063.412146453433;13105.148165369315;13213.86786132136;13474.305138972244;13583.252921089335;10096.040876116756;10172.745681357952;10252.74368140795;10291.485425728684;10410.011048950337;3565.8217089145696;3620.348337299285;3621.5835178954494;3624.2026754114318;3793.848246070154;82201;82949;83205;84209;84260.57869710673;8279.69266514759;9494.335396522316;9848.310618256653;9914.157296629723;9928.205743540499;21644.02601882919;21723;21734.13063477475;21751.456213594785;21775.020124094455;7507.662155203029;7515.8121046973165;7538.585377804164;7598.962005189938;7661.387089032864;3978.224246271949;4122.670186385082;4147;4161.438205842233;4168.062186008185;3383.6447173046968;3410.113370523632;3422.264213194175;3437.6906078453057;3443.018739659185;639.6929473852576;652.5366989437553;654.5123882707413;670.7752902777527;675.8715843989626;562.5836880708329;620.2649859916014;632.4940047961612;640.4012248547623;643.9323870993572;8559.486430814171;8579.82840343202;8621.396502244908;8824.617353314568;9055.547222638841;516.3468212710849;569.6667449541982;602.9276486821609;606.8513214262446;618.5886385553647;3779.640934111255;3950.150717595673;4005.599440055971;4032.3749818778138;4132.421460995463;90817;92180.0781992185;92772;93302.53348733213;93325.06674933164;75560.24439755642;76199.61900190574;76202;78452;79426;70100.6494967532;70844;71194;71334.28665713276;71832.56334873273;8036.4776289541;8075;8168.754937351889;8365.121662225622;8376.455530390505;42045.94885127896;49038;49425.50574494209;49715.75142124266;49884;66364.33635663775;67020;69040.3095969054;69583.17292548959;71309.64345178241;8750.767939823547;10938.781224375309;11047.558097676003;11208.991190792867;11617.302961822317;12057.15599908033;12063.879361206627;12105.757884842078;12178.147529673191;12555.183913045988;11733.882661173278;11778.352190629255;11780.998615117469;11806.173567850168;11857.407129643656;11234;11340.94329528347;11621.709457263298;11878.584249551224;11921.940390297994;11162.218644694793;11310.773784524099;11614.896584824428;11626.88373116258;11911.166218364979;9276.536173191449;9319.720408387759;9474.38416502925;9613.903860961302;9835.655752048644;9773.560189791335;10050.597976080875;10078.496075196064;10080.899191007997;10087.24345674092 05:17:41 INFO - PROCESS | 1678 | __end_tp_report 05:17:41 INFO - PROCESS | 1678 | __start_cc_report 05:17:41 INFO - PROCESS | 1678 | _x_x_mozilla_cycle_collect,1278 05:17:41 INFO - PROCESS | 1678 | __end_cc_report 05:17:41 INFO - PROCESS | 1678 | __startTimestamp1455023861913__endTimestamp 05:17:41 INFO - PROCESS | 1678 | 05:17:41 INFO - PROCESS | 1678 | ------- Summary: start ------- 05:17:41 INFO - PROCESS | 1678 | Number of tests: 6 05:17:41 INFO - PROCESS | 1678 | 05:17:41 INFO - PROCESS | 1678 | [#0] dojo.html Cycles:165 Average:5758.57 Median:5963.17 stddev:648.66 (10.9%) stddev-sans-first:624.78 05:17:41 INFO - PROCESS | 1678 | Values: 3446.9 3476.7 3501.9 3547.7 3567.0 5637.9 5738.8 5749.4 5783.2 5793.3 5246.4 5389.4 5677.9 5765.4 5788.5 5210.4 5230.8 5254.8 5263.3 5314.5 4421.6 5339.5 5340.8 5344.1 5345.7 5285.2 5304.8 5306.6 5308.8 5312.5 5323.5 5325.1 5326.0 5336.1 5342.5 5208.6 5256.1 5354.7 5361.6 5386.4 4689.8 5678.1 5726.5 5777.2 5795.0 6282.5 6310.5 6315.2 6331.4 6332.2 5147.6 6170.9 6290.2 6346.7 6373.8 5788.5 5847.6 5849.5 5850.7 5853.4 6255.1 6325.2 6325.8 6329.9 6330.7 6108.6 6110.4 6228.7 6234.3 6236.0 5717.5 6081.2 6319.1 6337.0 6344.6 6106.5 6149.4 6267.0 6276.7 6278.7 6164.5 6304.5 6310.3 6314.1 6319.1 4918.2 4921.3 4937.0 4939.2 4941.7 4328.6 4349.1 4417.5 4424.3 4444.3 5758.9 5789.2 5796.7 5820.3 5825.9 6308.9 6324.1 6327.8 6334.4 6335.4 4770.5 5663.2 5777.7 5817.5 5863.5 5411.2 5417.0 5421.2 5438.5 5441.1 6364.4 6411.4 6419.0 6427.2 6433.1 6187.9 6215.0 6314.0 6339.8 6354.6 6296.6 6314.4 6316.9 6318.4 6321.8 6121.7 6159.5 6174.0 6177.5 6180.8 5380.9 6199.8 6234.9 6276.8 6285.2 6118.8 6143.1 6158.8 6163.6 6206.3 6075.6 6151.0 6157.5 6170.5 6183.5 5829.3 5934.3 5940.9 5963.2 6022.5 5106.9 6186.4 6187.4 6199.1 6206.3 6004.9 6014.9 6018.3 6039.1 6045.6 05:17:41 INFO - PROCESS | 1678 | 05:17:41 INFO - PROCESS | 1678 | [#1] ext.html Cycles:180 Average:69405.93 Median:37962.43 stddev:153899.74 (405.4%) stddev-sans-first:154244.41 05:17:41 INFO - PROCESS | 1678 | Values: 457.6 479.8 484.8 557.2 561.8 37674.4 37949.2 37975.6 37984.4 38205.2 36812.8 37336.8 41095.8 41151.0 41163.6 9434.7 9670.0 9681.9 9686.0 9715.9 9484.7 9522.4 9584.9 9672.9 9708.7 9730.6 9799.8 9824.2 9833.7 9856.1 8945.6 9210.2 9692.8 9784.0 9787.1 9572.3 9735.5 9744.8 9746.6 9748.3 39406.9 39802.8 39824.0 39878.4 40201.8 3140.3 3190.6 3213.1 3331.8 3455.7 28024.4 28265.4 28355.4 29776.9 29883.1 2781.3 2804.5 2815.8 2831.2 2855.8 414376.0 417714.0 418494.0 418526.0 419160.0 55362.0 56662.0 61530.7 62069.1 62165.7 54679.2 56541.0 71068.0 71111.0 71339.3 16064.9 16129.9 16336.2 16358.2 16368.0 12468.9 12530.2 12537.7 12542.0 12545.9 17322.5 18515.0 19840.6 21167.0 21232.2 8848.0 9129.6 9147.3 9159.8 9244.4 979.8 995.3 1007.2 1038.0 1088.0 27784.3 27802.4 27814.7 27912.0 28168.7 914.3 1052.3 1102.5 1116.2 1210.6 14558.2 14579.5 14634.0 14749.0 14938.4 595076.0 653646.7 655985.0 658865.0 660774.0 57692.6 58486.0 58556.0 58611.0 58631.8 1460.8 1467.6 1479.7 1495.3 1502.9 28039.2 28098.4 28595.4 28698.1 28713.9 48121.8 48322.0 48456.3 48508.0 48535.5 612438.0 618050.0 643019.0 643065.0 644233.0 32582.0 32694.5 32695.7 32969.5 32976.5 38908.0 42213.9 43265.0 43494.3 43756.6 34248.7 35681.5 36662.5 36815.0 36901.3 36145.3 36547.6 36636.1 36836.4 36855.6 35138.5 36234.3 36593.8 36681.8 36772.4 30042.7 32708.0 32788.8 33048.8 33057.0 21851.9 22163.0 22612.0 24276.5 24953.5 05:17:41 INFO - PROCESS | 1678 | 05:17:41 INFO - PROCESS | 1678 | [#2] jquery.html Cycles:180 Average:38095.89 Median:28963.86 stddev:121356.53 (419.0%) stddev-sans-first:121663.89 05:17:41 INFO - PROCESS | 1678 | Values: 360.1 363.3 363.5 367.8 369.6 8261.9 10365.7 11638.8 12190.8 18798.7 18178.5 19400.9 20025.5 20431.8 20585.9 3885.0 5410.6 6629.8 6636.2 6656.1 4622.3 7199.2 7525.3 7538.3 7539.6 7074.8 7369.4 7374.2 7380.2 7390.7 6259.9 7354.3 7450.7 7466.3 7471.3 6434.7 6485.0 7098.7 7129.2 7188.1 27064.3 27182.9 27197.3 27317.9 27386.0 2182.9 2277.6 2384.6 2673.8 3127.8 15160.8 15693.8 15860.8 15890.0 16109.6 1792.7 1813.2 1882.6 1888.1 1949.4 89403.0 93848.5 102408.0 104583.5 113656.0 15464.3 15505.9 16959.7 17628.5 19780.6 28499.4 28880.8 28891.0 28918.9 29008.9 10643.0 10661.3 10693.1 10698.5 10735.6 9059.0 9062.4 9067.7 9151.5 9217.0 7302.1 7337.7 7382.8 8271.5 8659.5 2757.7 3367.4 3479.4 3543.3 3570.1 890.6 920.2 932.4 998.5 1010.2 13255.9 19616.1 20014.6 20103.4 20213.3 891.3 924.6 953.5 975.4 982.9 9943.5 10437.7 10672.9 10746.2 10860.1 724877.0 731870.0 734904.0 745906.0 754309.2 79567.0 115164.3 117669.0 118624.4 123949.0 1030.7 1043.9 1052.9 1067.3 1069.2 13539.7 16089.1 17539.5 18059.9 18148.6 34904.8 48431.3 48899.0 49576.8 49989.5 65443.7 66509.3 67259.0 68486.7 70667.6 7326.6 7372.0 7589.0 7589.3 7607.8 9086.0 12083.3 12285.8 12298.9 12303.4 9881.0 10280.4 10366.1 10403.4 10648.7 3934.5 10076.1 10360.8 10415.9 10588.5 10534.1 10782.8 10945.5 11018.8 11034.2 7667.7 7780.8 7790.0 7792.3 7840.9 9947.2 10796.5 10809.7 10901.5 10922.2 05:17:41 INFO - PROCESS | 1678 | 05:17:41 INFO - PROCESS | 1678 | [#3] mootools.html Cycles:180 Average:6093.59 Median:4931.36 stddev:3215.79 (65.2%) stddev-sans-first:3204.78 05:17:41 INFO - PROCESS | 1678 | Values: 1319.5 1402.4 1555.3 1737.5 1940.0 8053.3 8616.2 8709.5 8714.0 8720.7 8467.2 8742.8 8746.1 8756.0 8771.9 2120.4 2162.2 2165.1 2457.5 2486.6 2068.8 2208.4 2209.8 2265.0 2516.8 2389.1 2461.2 2466.7 2467.3 2469.5 2448.9 2449.8 2454.8 2459.1 2460.2 2371.3 2421.8 2427.0 2428.0 2434.4 8625.6 8720.0 8726.6 8852.0 8860.0 5363.2 5454.7 5497.1 5500.0 5501.1 3481.9 3579.7 3649.5 3664.2 3668.7 1067.3 1070.7 1090.0 1099.2 1107.6 12244.4 12276.5 12278.9 12284.7 12298.9 4790.6 4867.1 4883.4 4898.7 4902.2 10009.6 10041.4 10047.5 10055.5 10060.8 5438.7 5486.6 5498.5 5499.3 5501.7 4102.4 4930.1 4932.6 4975.2 4983.7 3702.9 3988.1 4023.7 4044.7 4071.9 1213.1 1294.6 1296.5 1302.7 1314.4 1282.0 1307.5 1351.2 1353.1 1364.6 7974.8 8045.5 8068.0 8093.2 8100.9 1161.4 1177.7 1182.9 1190.6 1207.2 6236.4 6299.7 6302.8 6307.9 6314.7 10248.6 10431.3 10464.8 10575.7 10587.7 10114.4 10419.5 10419.6 10420.5 10456.7 8181.6 8235.0 8269.2 8305.5 8329.8 8106.0 8135.4 8149.9 8215.1 8315.6 9617.8 9645.0 9654.7 9891.2 9894.9 9990.6 10052.2 10182.4 10227.7 10372.3 7578.8 7601.1 7612.8 7653.6 7704.7 7255.4 7437.4 8283.0 8351.1 8361.0 7660.2 7735.8 7739.5 7777.3 7908.8 7644.2 7649.2 7702.9 7797.3 7829.7 7760.8 7790.1 7798.5 7835.8 7836.8 5973.0 7083.6 7101.5 7154.1 7187.2 7172.4 7209.5 7252.1 7252.8 7279.9 05:17:41 INFO - PROCESS | 1678 | 05:17:41 INFO - PROCESS | 1678 | [#4] prototype.html Cycles:180 Average:5776.29 Median:6654.40 stddev:1879.11 (28.2%) stddev-sans-first:1838.76 05:17:41 INFO - PROCESS | 1678 | Values: 293.1 317.0 322.9 326.3 332.0 6277.4 6651.5 6680.7 6745.8 6757.1 6607.6 6627.4 6628.3 6648.9 6657.3 4710.2 4795.6 4834.8 4968.7 4980.0 4876.9 4922.8 4923.6 4925.6 4954.5 4064.4 4789.9 4856.9 4899.9 4905.5 4646.4 4732.4 4767.0 4830.5 4902.5 3454.4 4131.8 4168.9 4178.7 4188.9 6137.0 6255.2 6314.2 6336.9 6350.6 5213.5 5392.9 5751.5 5751.6 5757.2 6306.2 6987.7 7005.6 7008.2 7013.2 3796.4 3858.4 4553.1 4575.5 4635.5 7294.2 7436.7 7538.7 7547.2 7547.6 4607.4 4643.6 4644.0 4646.8 4656.7 4684.0 4710.2 4720.7 4731.0 4736.5 5593.8 5619.7 5628.1 5634.7 5644.5 5758.7 6850.0 7150.4 7153.1 7153.9 1358.3 1608.1 1638.2 1640.2 1641.1 1030.2 1035.3 1045.2 1052.3 1056.6 6699.4 6708.1 6737.7 6745.2 6747.2 5637.8 7366.7 7380.7 7383.7 7390.0 6462.5 6700.8 6712.5 6714.9 6732.3 3338.7 3805.9 3892.5 3913.4 3928.0 7700.0 7725.8 7740.9 7741.9 7772.7 7246.9 7581.2 7599.3 7599.7 7601.1 7692.6 7694.6 7713.0 7720.9 7722.8 6361.9 7342.4 7344.6 7350.2 7350.9 6971.4 7259.7 7262.7 7263.6 7277.6 7695.2 7710.3 7718.6 7720.6 7747.0 4643.9 4666.4 4684.2 4687.8 4698.5 7082.5 7320.8 7338.2 7346.3 7383.6 7086.9 7102.4 7113.0 7127.3 7150.6 6866.5 7077.4 7092.7 7102.1 7139.1 6662.5 6953.2 6956.3 6957.2 6965.6 6936.0 7003.5 7025.8 7102.3 7186.3 6667.2 6792.2 6914.1 6952.6 6997.2 05:17:41 INFO - PROCESS | 1678 | 05:17:41 INFO - PROCESS | 1678 | [#5] yui.html Cycles:180 Average:18412.98 Median:626.38 stddev:25863.44 (4129.0%) stddev-sans-first:25901.65 05:17:41 INFO - PROCESS | 1678 | Values: 664.7 695.1 709.2 720.2 769.1 14775.4 14790.6 14959.7 14983.2 15059.3 13724.0 13786.6 13798.0 13798.2 13799.4 699.2 704.0 709.5 841.8 862.3 845.9 859.7 870.4 871.2 871.8 898.1 913.1 914.1 915.9 916.8 727.4 736.6 888.5 895.5 910.9 562.7 670.5 670.6 670.7 671.1 15014.8 15037.2 15041.5 15114.3 15162.5 13063.4 13105.1 13213.9 13474.3 13583.3 10096.0 10172.7 10252.7 10291.5 10410.0 3565.8 3620.3 3621.6 3624.2 3793.8 82201.0 82949.0 83205.0 84209.0 84260.6 8279.7 9494.3 9848.3 9914.2 9928.2 21644.0 21723.0 21734.1 21751.5 21775.0 7507.7 7515.8 7538.6 7599.0 7661.4 3978.2 4122.7 4147.0 4161.4 4168.1 3383.6 3410.1 3422.3 3437.7 3443.0 639.7 652.5 654.5 670.8 675.9 562.6 620.3 632.5 640.4 643.9 8559.5 8579.8 8621.4 8824.6 9055.5 516.3 569.7 602.9 606.9 618.6 3779.6 3950.2 4005.6 4032.4 4132.4 90817.0 92180.1 92772.0 93302.5 93325.1 75560.2 76199.6 76202.0 78452.0 79426.0 70100.6 70844.0 71194.0 71334.3 71832.6 8036.5 8075.0 8168.8 8365.1 8376.5 42045.9 49038.0 49425.5 49715.8 49884.0 66364.3 67020.0 69040.3 69583.2 71309.6 8750.8 10938.8 11047.6 11209.0 11617.3 12057.2 12063.9 12105.8 12178.1 12555.2 11733.9 11778.4 11781.0 11806.2 11857.4 11234.0 11340.9 11621.7 11878.6 11921.9 11162.2 11310.8 11614.9 11626.9 11911.2 9276.5 9319.7 9474.4 9613.9 9835.7 9773.6 10050.6 10078.5 10080.9 10087.2 05:17:41 INFO - PROCESS | 1678 | -------- Summary: end -------- 05:17:41 INFO - PROCESS | 1678 | 05:17:42 INFO - TEST-INFO | 1678: exit 0 05:17:42 INFO - TEST-OK | dromaeo_css | took 1114771ms 05:17:42 INFO - TEST-START | kraken 05:17:42 INFO - operating with platform_type : mac_ 05:17:42 INFO - Initialising browser for kraken test... 05:17:42 INFO - TEST-INFO | started process 1687 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/tmptHr9Ai/profile http://localhost:49285/getInfo.html) 05:17:44 INFO - PROCESS | 1687 | __metrics Screen width/height:1600/1200 05:17:44 INFO - PROCESS | 1687 | colorDepth:24 05:17:44 INFO - PROCESS | 1687 | Browser inner width/height: 1024/689 05:17:44 INFO - PROCESS | 1687 | __metrics 05:17:44 INFO - PROCESS | 1687 | 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" 05:17:44 INFO - PROCESS | 1687 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:17:45 INFO - TEST-INFO | 1687: exit 0 05:17:45 INFO - Browser initialized. 05:17:45 INFO - Running cycle 1/1 for kraken test... 05:17:45 INFO - TEST-INFO | started process 1689 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/tmptHr9Ai/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:17:57 INFO - PROCESS | 1689 | RSS: Main: 245469184 05:17:57 INFO - PROCESS | 1689 | 05:17:59 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49285/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49285/tests/kraken/driver.html?testName=audio-beat-detection) 05:18:00 INFO - PROCESS | 1689 | RSS: Main: 290361344 05:18:00 INFO - PROCESS | 1689 | 05:18:03 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49285/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49285/tests/kraken/driver.html?testName=audio-dft) 05:18:03 INFO - PROCESS | 1689 | RSS: Main: 300900352 05:18:03 INFO - PROCESS | 1689 | 05:18:07 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49285/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49285/tests/kraken/driver.html?testName=audio-fft) 05:18:07 INFO - PROCESS | 1689 | RSS: Main: 288395264 05:18:07 INFO - PROCESS | 1689 | 05:18:09 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49285/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49285/tests/kraken/driver.html?testName=audio-oscillator) 05:18:10 INFO - PROCESS | 1689 | RSS: Main: 290336768 05:18:10 INFO - PROCESS | 1689 | 05:18:12 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49285/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49285/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:18:12 INFO - PROCESS | 1689 | RSS: Main: 290734080 05:18:12 INFO - PROCESS | 1689 | 05:18:15 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49285/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49285/tests/kraken/driver.html?testName=imaging-darkroom) 05:18:16 INFO - PROCESS | 1689 | RSS: Main: 290631680 05:18:16 INFO - PROCESS | 1689 | 05:18:19 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49285/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49285/tests/kraken/driver.html?testName=imaging-desaturate) 05:18:19 INFO - PROCESS | 1689 | RSS: Main: 292184064 05:18:19 INFO - PROCESS | 1689 | 05:18:22 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49285/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49285/tests/kraken/driver.html?testName=json-parse-financial) 05:18:23 INFO - PROCESS | 1689 | RSS: Main: 293031936 05:18:23 INFO - PROCESS | 1689 | 05:18:24 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49285/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49285/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:18:25 INFO - PROCESS | 1689 | RSS: Main: 326086656 05:18:25 INFO - PROCESS | 1689 | 05:18:27 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49285/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49285/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:18:27 INFO - PROCESS | 1689 | RSS: Main: 324743168 05:18:27 INFO - PROCESS | 1689 | 05:18:29 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49285/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49285/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:18:30 INFO - PROCESS | 1689 | RSS: Main: 333737984 05:18:30 INFO - PROCESS | 1689 | 05:18:32 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49285/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49285/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:18:33 INFO - PROCESS | 1689 | RSS: Main: 334856192 05:18:33 INFO - PROCESS | 1689 | 05:18:35 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49285/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49285/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:18:36 INFO - PROCESS | 1689 | RSS: Main: 334508032 05:18:36 INFO - PROCESS | 1689 | 05:18:38 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49285/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49285/tests/kraken/driver.html?testName=ai-astar) 05:18:38 INFO - PROCESS | 1689 | RSS: Main: 395649024 05:18:38 INFO - PROCESS | 1689 | 05:18:38 INFO - PROCESS | 1689 | __start_tp_report 05:18:38 INFO - PROCESS | 1689 | _x_x_mozilla_page_load 05:18:38 INFO - PROCESS | 1689 | _x_x_mozilla_page_load_details 05:18:38 INFO - PROCESS | 1689 | |i|pagename|runs| 05:18:38 INFO - PROCESS | 1689 | |0;ai-astar;111;109;111;110;111;112;116;110;111;111 05:18:38 INFO - PROCESS | 1689 | |1;audio-beat-detection;159;120;155;182;147;144;117;157;145;118 05:18:38 INFO - PROCESS | 1689 | |2;audio-dft;183;182;186;183;184;184;184;184;180;182 05:18:38 INFO - PROCESS | 1689 | |3;audio-fft;75;72;91;77;57;57;64;76;75;55 05:18:38 INFO - PROCESS | 1689 | |4;audio-oscillator;94;92;121;78;63;76;132;113;114;121 05:18:38 INFO - PROCESS | 1689 | |5;imaging-gaussian-blur;85;91;85;91;85;93;131;130;85;93 05:18:38 INFO - PROCESS | 1689 | |6;imaging-darkroom;106;149;94;95;94;94;94;93;93;94 05:18:38 INFO - PROCESS | 1689 | |7;imaging-desaturate;87;86;95;135;131;86;87;84;83;88 05:18:38 INFO - PROCESS | 1689 | |8;json-parse-financial;55;54;53;53;53;54;55;66;52;53 05:18:38 INFO - PROCESS | 1689 | |9;json-stringify-tinderbox;65;62;72;73;70;66;65;64;65;67 05:18:38 INFO - PROCESS | 1689 | |10;stanford-crypto-aes;84;85;84;83;83;82;81;82;84;82 05:18:38 INFO - PROCESS | 1689 | |11;stanford-crypto-ccm;126;128;133;129;127;107;123;126;119;132 05:18:38 INFO - PROCESS | 1689 | |12;stanford-crypto-pbkdf2;140;126;136;137;140;127;138;139;138;138 05:18:38 INFO - PROCESS | 1689 | |13;stanford-crypto-sha256-iterative;67;67;67;67;67;66;66;68;96;93 05:18:38 INFO - PROCESS | 1689 | __end_tp_report 05:18:38 INFO - PROCESS | 1689 | __start_cc_report 05:18:38 INFO - PROCESS | 1689 | _x_x_mozilla_cycle_collect,1174 05:18:38 INFO - PROCESS | 1689 | __end_cc_report 05:18:38 INFO - PROCESS | 1689 | __startTimestamp1455023918559__endTimestamp 05:18:38 INFO - PROCESS | 1689 | 05:18:38 INFO - PROCESS | 1689 | ------- Summary: start ------- 05:18:38 INFO - PROCESS | 1689 | Number of tests: 14 05:18:38 INFO - PROCESS | 1689 | 05:18:38 INFO - PROCESS | 1689 | [#0] ai-astar Cycles:10 Average:111.20 Median:111.00 stddev:1.87 (1.7%) stddev-sans-first:1.99 05:18:38 INFO - PROCESS | 1689 | Values: 111.0 109.0 111.0 110.0 111.0 112.0 116.0 110.0 111.0 111.0 05:18:38 INFO - PROCESS | 1689 | 05:18:38 INFO - PROCESS | 1689 | [#1] audio-beat-detection Cycles:10 Average:144.40 Median:151.00 stddev:20.95 (13.9%) stddev-sans-first:21.54 05:18:38 INFO - PROCESS | 1689 | Values: 159.0 120.0 155.0 182.0 147.0 144.0 117.0 157.0 145.0 118.0 05:18:38 INFO - PROCESS | 1689 | 05:18:38 INFO - PROCESS | 1689 | [#2] audio-dft Cycles:10 Average:183.20 Median:184.00 stddev:1.62 (0.9%) stddev-sans-first:1.72 05:18:38 INFO - PROCESS | 1689 | Values: 183.0 182.0 186.0 183.0 184.0 184.0 184.0 184.0 180.0 182.0 05:18:38 INFO - PROCESS | 1689 | 05:18:38 INFO - PROCESS | 1689 | [#3] audio-fft Cycles:10 Average:69.90 Median:75.00 stddev:11.45 (15.3%) stddev-sans-first:11.99 05:18:38 INFO - PROCESS | 1689 | Values: 75.0 72.0 91.0 77.0 57.0 57.0 64.0 76.0 75.0 55.0 05:18:38 INFO - PROCESS | 1689 | 05:18:38 INFO - PROCESS | 1689 | [#4] audio-oscillator Cycles:10 Average:100.40 Median:69.50 stddev:23.09 (33.2%) stddev-sans-first:24.37 05:18:38 INFO - PROCESS | 1689 | Values: 94.0 92.0 121.0 78.0 63.0 76.0 132.0 113.0 114.0 121.0 05:18:38 INFO - PROCESS | 1689 | 05:18:38 INFO - PROCESS | 1689 | [#5] imaging-gaussian-blur Cycles:10 Average:96.90 Median:88.00 stddev:18.03 (20.5%) stddev-sans-first:18.60 05:18:38 INFO - PROCESS | 1689 | Values: 85.0 91.0 85.0 91.0 85.0 93.0 131.0 130.0 85.0 93.0 05:18:38 INFO - PROCESS | 1689 | 05:18:38 INFO - PROCESS | 1689 | [#6] imaging-darkroom Cycles:10 Average:100.60 Median:94.00 stddev:17.44 (18.5%) stddev-sans-first:18.38 05:18:38 INFO - PROCESS | 1689 | Values: 106.0 149.0 94.0 95.0 94.0 94.0 94.0 93.0 93.0 94.0 05:18:38 INFO - PROCESS | 1689 | 05:18:38 INFO - PROCESS | 1689 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:86.50 stddev:19.68 (22.8%) stddev-sans-first:20.59 05:18:38 INFO - PROCESS | 1689 | Values: 87.0 86.0 95.0 135.0 131.0 86.0 87.0 84.0 83.0 88.0 05:18:38 INFO - PROCESS | 1689 | 05:18:38 INFO - PROCESS | 1689 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:54.00 stddev:4.05 (7.5%) stddev-sans-first:4.29 05:18:38 INFO - PROCESS | 1689 | Values: 55.0 54.0 53.0 53.0 53.0 54.0 55.0 66.0 52.0 53.0 05:18:38 INFO - PROCESS | 1689 | 05:18:38 INFO - PROCESS | 1689 | [#9] json-stringify-tinderbox Cycles:10 Average:66.90 Median:66.50 stddev:3.60 (5.4%) stddev-sans-first:3.76 05:18:38 INFO - PROCESS | 1689 | Values: 65.0 62.0 72.0 73.0 70.0 66.0 65.0 64.0 65.0 67.0 05:18:38 INFO - PROCESS | 1689 | 05:18:38 INFO - PROCESS | 1689 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:83.50 stddev:1.25 (1.5%) stddev-sans-first:1.27 05:18:38 INFO - PROCESS | 1689 | Values: 84.0 85.0 84.0 83.0 83.0 82.0 81.0 82.0 84.0 82.0 05:18:38 INFO - PROCESS | 1689 | 05:18:38 INFO - PROCESS | 1689 | [#11] stanford-crypto-ccm Cycles:10 Average:125.00 Median:127.50 stddev:7.51 (5.9%) stddev-sans-first:7.96 05:18:38 INFO - PROCESS | 1689 | Values: 126.0 128.0 133.0 129.0 127.0 107.0 123.0 126.0 119.0 132.0 05:18:38 INFO - PROCESS | 1689 | 05:18:38 INFO - PROCESS | 1689 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.90 Median:138.00 stddev:5.11 (3.7%) stddev-sans-first:5.20 05:18:38 INFO - PROCESS | 1689 | Values: 140.0 126.0 136.0 137.0 140.0 127.0 138.0 139.0 138.0 138.0 05:18:38 INFO - PROCESS | 1689 | 05:18:38 INFO - PROCESS | 1689 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.40 Median:67.00 stddev:11.68 (17.4%) stddev-sans-first:12.23 05:18:38 INFO - PROCESS | 1689 | Values: 67.0 67.0 67.0 67.0 67.0 66.0 66.0 68.0 96.0 93.0 05:18:38 INFO - PROCESS | 1689 | -------- Summary: end -------- 05:18:38 INFO - PROCESS | 1689 | 05:18:39 INFO - TEST-INFO | 1689: exit 0 05:18:39 INFO - TEST-OK | kraken | took 56851ms 05:18:39 INFO - SUITE-END | took 1171s 05:18:39 INFO - Completed test suite (00:19:32) 05:18:39 INFO - Working with test: dromaeo_css 05:18:39 INFO - Generating results file: dromaeo_css 05:18:39 INFO - Working with test: kraken 05:18:39 INFO - Generating results file: kraken 05:18:39 INFO - javascript benchmark 05:18:39 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:18:39 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,59]] 05:18:39 INFO - process_Request line: dromaeo_css 7659.22 graph.html#tests=[[72,1,59]] 05:18:39 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:18:39 INFO - process_Request line: kraken 1440.80 graph.html#tests=[[232,1,59]] 05:18:39 INFO - RETURN: dromaeo_css: 7659.22 05:18:39 INFO - RETURN: kraken: 1440.80 05:18:39 INFO - javascript benchmark 05:18:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3446.8621255149797, 3476.669716376943, 3501.8774342897987, 3547.7339199560033, 3567.0, 5637.943620563793, 5738.7991420300295, 5749.396313387092, 5783.248177736894, 5793.33376661684, 5246.42607217835, 5389.380221274555, 5677.886442271152, 5765.365809760923, 5788.5369170466365, 5210.400803907552, 5230.7646155922885, 5254.81608143715, 5263.26314315996, 5314.468553144693, 4421.557844215585, 5339.466053394649, 5340.813071542497, 5344.064788661969, 5345.732713364336, 5285.233641122035, 5304.787808487656, 5306.628536002481, 5308.840734777963, 5312.4687531246955, 5323.547498462635, 5325.068113080215, 5326.0, 5336.066188417011, 5342.465753424665, 5208.5572726318305, 5256.106461901486, 5354.678719276856, 5361.571074314045, 5386.380566234894, 4689.7655117244, 5678.148277758328, 5726.484616384545, 5777.19119323295, 5794.97102514489, 6282.4974002079725, 6310.5267104967315, 6315.24217093947, 6331.398517140864, 6332.240131184241, 5147.613928955306, 6170.8765824683705, 6290.182276304097, 6346.6509341986175, 6373.776917807901, 5788.5369170466265, 5847.561432892508, 5849.532037436995, 5850.707464626752, 5853.385394533598, 6255.0617407388345, 6325.209348831396, 6325.778597749057, 6329.905051424233, 6330.746770129235, 6108.5545605439265, 6110.4195101466175, 6228.719707613168, 6234.251889773256, 6236.03341482071, 5717.456841600041, 6081.179040829431, 6319.115323854664, 6337.049442583557, 6344.619322840645, 6106.490508973763, 6149.354317796657, 6266.968665156645, 6276.6547839869245, 6278.6860656966965, 6164.506839452833, 6304.464120549713, 6310.337414571496, 6314.052892066226, 6319.0837328587095, 4918.163912134945, 4921.26181072842, 4936.950630493649, 4939.160342741742, 4941.703497790144, 4328.588784065509, 4349.06495103548, 4417.491988421372, 4424.269995450714, 4444.28891377378, 5758.913616295759, 5789.189513468118, 5796.681182535001, 5820.30156381237, 5825.912611310834, 6308.936910630927, 6324.114623952651, 6327.810165695037, 6334.3665633436285, 6335.398137177053, 4770.475247722748, 5663.178839068312, 5777.711114444345, 5817.534597232211, 5863.501602363762, 5411.161270003156, 5417.0, 5421.186821976735, 5438.483344082306, 5441.102218134043, 6364.363563643598, 6411.4229719325485, 6419.0, 6427.196600424947, 6433.131527243856, 6187.876242475215, 6215.0, 6314.0, 6339.809805705651, 6354.555181137276, 6296.622202667854, 6314.368563143649, 6316.936830631635, 6318.368163183645, 6321.841953951188, 6121.724522396592, 6159.538034647329, 6174.043023331391, 6177.536684748572, 6180.7527698891545, 5380.92381523689, 6199.752009919733, 6234.906476402948, 6276.811695649138, 6285.214348206474, 6118.755249789959, 6143.052618484886, 6158.784442544489, 6163.599366041193, 6206.255249369924, 6075.635461872302, 6151.0, 6157.507399408126, 6170.475509581735, 6183.536234782319, 5829.329627092939, 5934.3175534814045, 5940.8811823764145, 5963.165156878127, 6022.54830887694, 5106.948930510647, 6186.381361863778, 6187.381261873777, 6199.1011303361665, 6206.286277078013, 6004.909926351021, 6014.879702406015, 6018.277806663228, 6039.094135879654, 6045.576809623284], "unit": "score", "name": "dojo.html", "value": 5719.623544869954}, {"lowerIsBetter": false, "replicates": [457.599600349694, 479.8268234167462, 484.83757941089743, 557.197635405017, 561.8230257468897, 37674.43488347677, 37949.24101517968, 37975.62024379755, 37984.43023354652, 38205.23589528208, 36812.815935920284, 37336.81331593338, 41095.79452102743, 41151.0, 41163.58836411635, 9434.66978655749, 9670.032996700309, 9681.854772178423, 9686.031396860328, 9715.902840971607, 9484.66803661872, 9522.381045232072, 9584.904150958506, 9672.90327096727, 9708.708738737849, 9730.562124704406, 9799.804003919917, 9824.21406287499, 9833.704988850346, 9856.112949834513, 8945.597448114786, 9210.171084602418, 9692.806143877118, 9784.0, 9787.070228328263, 9572.32993690442, 9735.513224338754, 9744.75638109046, 9746.610135594568, 9748.31761776676, 39406.877105976324, 39802.80098599517, 39824.00439989023, 39878.401823972665, 40201.79899100515, 3140.262038420969, 3190.5533225348468, 3213.0682102190335, 3331.7834340768013, 3455.6544345565494, 28024.43951120966, 28265.434691306058, 28355.432891342058, 29776.8511157445, 29883.10350689483, 2781.3463835998523, 2804.467151241258, 2815.8310501369983, 2831.1506548035713, 2855.7858160638034, 414376.0, 417713.999999997, 418494.0, 418526.0, 419160.0, 55362.0, 56662.0, 61530.69234653798, 62069.068963965576, 62165.68917155385, 54679.17981230285, 56541.0, 71068.0, 71111.0, 71339.2866071343, 16064.919675401548, 16129.919350403174, 16336.183190840411, 16358.182090895407, 16368.0, 12468.875311246953, 12530.248185108923, 12537.686557835945, 12542.0, 12545.874541254652, 17322.48032559025, 18515.0, 19840.60318793616, 21167.0, 21232.150713971576, 8847.98571145066, 9129.589168487433, 9147.2682185425, 9159.816803663889, 9244.3991140577, 979.7893452907659, 995.2983146881431, 1007.2143727892255, 1037.994810025945, 1087.9728006799735, 27784.30539236495, 27802.44395112127, 27814.66858100006, 27912.02307919213, 28168.71831281661, 914.346242436661, 1052.273930987616, 1102.536934487517, 1116.1851848150734, 1210.6126039667397, 14558.199299038442, 14579.489717860037, 14633.975621706591, 14749.0, 14938.402463901539, 595076.0, 653646.7317663381, 655985.0, 658865.0, 660774.0, 57692.55768605734, 58486.0, 58556.0, 58611.0, 58631.82736345249, 1460.8466111058185, 1467.5523965190505, 1479.6892652543086, 1495.327102803721, 1502.9248537573078, 28039.158825235274, 28098.438031239668, 28595.428091438473, 28698.139055827523, 28713.85643071771, 48121.75939120282, 48322.03355932932, 48456.27315590339, 48508.0, 48535.5146448531, 612438.0, 618050.0, 643019.0, 643065.0, 644233.0, 32582.0, 32694.509582355808, 32695.673043269264, 32969.505457418636, 32976.505352420216, 38908.0, 42213.94465138396, 43265.0, 43494.34758478688, 43756.56243437652, 34248.65751342455, 35681.46477802783, 36662.450063248536, 36815.0, 36901.26197476089, 36145.27709445849, 36547.634523655484, 36636.084097897765, 36836.44745328876, 36855.63144368522, 35138.47292290567, 36234.27531449409, 36593.81703091467, 36681.816590916875, 36772.44841327329, 30042.69957300399, 32708.0, 32788.83605581957, 33048.834755826065, 33057.00828975135, 21851.890740546194, 22163.0, 22612.0, 24276.542522241863, 24953.500929981663], "unit": "score", "name": "ext.html", "value": 19745.993421698575}, {"lowerIsBetter": false, "replicates": [360.1123231235006, 363.32421695646104, 363.52015339751523, 367.7646306363926, 369.58790948092883, 8261.91738082619, 10365.740856478591, 11638.767224655501, 12190.81713774294, 18798.718019229724, 18178.4546463606, 19400.902995485, 20025.499362515944, 20431.795682043175, 20585.897070514628, 3884.961150388502, 5410.648307859977, 6629.801105966804, 6636.170478690164, 6656.101426307459, 4622.306654001893, 7199.244079371643, 7525.285097915689, 7538.283863033003, 7539.623018849063, 7074.752383666572, 7369.410447164214, 7374.188839227681, 7380.1512826025155, 7390.667419966115, 6259.874802503924, 7354.2645735426295, 7450.739224127184, 7466.328030477229, 7471.290227428385, 6434.745224681189, 6484.967575162141, 7098.716051357939, 7129.215786263507, 7188.101487314086, 27064.32339191536, 27182.864085679445, 27197.320066998484, 27317.863410682818, 27386.0, 2182.9126834926583, 2277.5900337939165, 2384.5588566115152, 2673.8395696258094, 3127.766889841714, 15160.848391516165, 15693.764593531107, 15860.762088568681, 15890.0, 16109.597260068593, 1792.7221280701513, 1813.184067169779, 1882.6234753049307, 1888.055972013993, 1949.4249196487071, 89403.0, 93848.53075734645, 102408.0, 104583.4770826141, 113656.0, 15464.304106315243, 15505.9224703878, 16959.660806783795, 17628.501577365812, 19780.60438791216, 28499.430011399654, 28880.833937454776, 28891.0, 28918.855405722836, 29008.85495572551, 10643.0, 10661.307015043998, 10693.144548436107, 10698.51856666452, 10735.624253151102, 9059.048799875918, 9062.410943288665, 9067.727968160965, 9151.496667683208, 9216.95391523038, 7302.146668321132, 7337.74317898871, 7382.815429614303, 8271.503709777433, 8659.523726194993, 2757.7104404037286, 3367.393869103585, 3479.443289073736, 3543.291341731664, 3570.071781336871, 890.5636238243214, 920.2408013388981, 932.4312169576552, 998.4758002048983, 1010.2271762101851, 13255.867441325463, 19616.11727472267, 20014.599708006048, 20103.39689809308, 20213.292534761214, 891.3270480786964, 924.5608336040461, 953.4803532075035, 975.3855071305032, 982.872226610536, 9943.502824858728, 10437.708761642141, 10672.893271067345, 10746.24776265654, 10860.13118950482, 724877.0, 731870.0, 734904.0, 745906.0, 754309.2284538542, 79567.0, 115164.27253591202, 117669.0, 118624.40687796679, 123949.0, 1030.721705139623, 1043.9217058720626, 1052.8841827398826, 1067.3222503710044, 1069.2301542889106, 13539.729205416033, 16089.115098669685, 17539.473815785546, 18059.909700451415, 18148.637027259643, 34904.77833275823, 48431.30490432818, 48899.0, 49576.752116239186, 49989.500104998486, 65443.69112617626, 66509.33490665225, 67259.0, 68486.65756671184, 70667.64666176842, 7326.635507070361, 7372.004779354933, 7588.962055189689, 7589.279018493235, 7607.809804754926, 9086.0, 12083.275003499819, 12285.75428491443, 12298.938505307775, 12303.384830758605, 9881.0, 10280.434576098387, 10366.118879895294, 10403.375797452178, 10648.733781655521, 3934.527856657105, 10076.143527800219, 10360.844587331347, 10415.94792026035, 10588.4705764713, 10534.104601108991, 10782.838257425989, 10945.507452164513, 11018.834717479405, 11034.172437067413, 7667.731629392944, 7780.84438311242, 7790.0, 7792.337651299703, 7840.921590784019, 9947.204223662235, 10796.528485616074, 10809.729756756144, 10901.454927253764, 10922.235443518877], "unit": "score", "name": "jquery.html", "value": 10183.206364559297}, {"lowerIsBetter": false, "replicates": [1319.4524272426943, 1402.4390243902444, 1555.292341984397, 1737.4527023987443, 1939.9709004364936, 8053.275205231528, 8616.224539791418, 8709.477431354107, 8714.0, 8720.694775682852, 8467.153284671529, 8742.825143497126, 8746.081661425555, 8756.0, 8771.91228087719, 2120.4380839077658, 2162.1783722185546, 2165.069020321261, 2457.520783447224, 2486.639437281593, 2068.7620923593827, 2208.403730992631, 2209.823214142865, 2264.954700905981, 2516.7609077137736, 2389.1279682915697, 2461.212412028152, 2466.6803260255765, 2467.2721547143638, 2469.506098780242, 2448.853068815868, 2449.7550244975537, 2454.8158888083467, 2459.053264493165, 2460.2004348586693, 2371.2886134159685, 2421.8425802322968, 2426.963595546051, 2427.963580546293, 2434.403571125086, 8625.611847466878, 8719.956400217958, 8726.563671816384, 8851.955740221321, 8859.955700221522, 5363.222332761728, 5454.672719636835, 5497.147942068986, 5500.0, 5501.14732216507, 3481.9129521761906, 3579.713622910161, 3649.5255616769914, 3664.193877346979, 3668.6881615062753, 1067.3169171730099, 1070.6948519671935, 1089.967300980964, 1099.1756182862853, 1107.645553422905, 12244.448999795031, 12276.508939642403, 12278.877211227862, 12284.692882678004, 12298.938505307417, 4790.640701947368, 4867.099586576494, 4883.438404583448, 4898.657094003457, 4902.1911384621135, 10009.599616015277, 10041.397516148909, 10047.547860346302, 10055.547500362502, 10060.798784024279, 5438.7280635968045, 5486.643368181056, 5498.532624726943, 5499.257600223918, 5501.724913754297, 4102.425660407545, 4930.087933732271, 4932.630052746058, 4975.179095449211, 4983.700977941335, 3702.9444558331647, 3988.062805240766, 4023.657989070962, 4044.6854772199154, 4071.89820254496, 1213.1144264686827, 1294.566320282697, 1296.461968283152, 1302.7459645369252, 1314.4085161677283, 1281.9807702884464, 1307.45740517686, 1351.1622793867864, 1353.1407556201882, 1364.6383708317303, 7974.800629984296, 8045.477043992122, 8068.031836179579, 8093.231143041402, 8100.878486822702, 1161.4018780328138, 1177.717347836513, 1182.8757980412106, 1190.595197632809, 1207.2032458577296, 6236.438720515084, 6299.6535190564955, 6302.8424289392215, 6307.873842523124, 6314.684265786692, 10248.59005639781, 10431.269811113301, 10464.843027354596, 10575.682729518127, 10587.682369528926, 10114.393136411838, 10419.479026048819, 10419.583216671399, 10420.478976051167, 10456.686299410878, 8181.568225560503, 8234.958825205955, 8269.173082691803, 8305.46014509055, 8329.791755206168, 8105.9867516560425, 8135.389845761473, 8149.918500814916, 8215.137410572042, 8315.584220788814, 9617.759556010877, 9644.95177524108, 9654.662086826927, 9891.159251463418, 9894.851577226491, 9990.550425231027, 10052.195824334181, 10182.439965801952, 10227.693169204937, 10372.325798823053, 7578.848423031619, 7601.0878694557005, 7612.8477430452185, 7653.617319134132, 7704.730334438268, 7255.383292420203, 7437.367823735043, 8283.0, 8351.081381047958, 8360.95488063992, 7660.157382688011, 7735.845283094194, 7739.458237923292, 7777.338926191337, 7908.84182316362, 7644.197359277196, 7649.158592554926, 7702.922970770221, 7797.298243158143, 7829.7259595913865, 7760.805979850549, 7790.065192176975, 7798.493097948615, 7835.764927052198, 7836.84326313482, 5972.970135149297, 7083.645817708991, 7101.4673899458785, 7154.069970903749, 7187.2453392393045, 7172.426205903411, 7209.531380460253, 7252.093488313961, 7252.818679532843, 7279.854402911807], "unit": "score", "name": "mootools.html", "value": 4960.832879360255}, {"lowerIsBetter": false, "replicates": [293.11811774889225, 317.04095112285336, 322.9079712282, 326.3212517962638, 332.03874782504636, 6277.372262773721, 6651.534392592521, 6680.6993685284215, 6745.797626071213, 6757.054012438262, 6607.570507916982, 6627.37039981201, 6628.33716628337, 6648.933510664892, 6657.267700552935, 4710.19926612475, 4795.640326975474, 4834.758262086882, 4968.701877887329, 4979.950200497985, 4876.9268460972935, 4922.8030878764985, 4923.58149557288, 4925.556699897009, 4954.479779623141, 4064.3700226464944, 4789.946211833391, 4856.927146092811, 4899.853004409855, 4905.509449055084, 4646.442426908776, 4732.384789977315, 4766.952330476685, 4830.468648448667, 4902.460729319772, 3454.3954807908767, 4131.772752498611, 4168.937465938014, 4178.6657067434535, 4188.874333769992, 6137.048757442603, 6255.155554000197, 6314.242290925073, 6336.904946425807, 6350.555461117724, 5213.504717051874, 5392.946070539284, 5751.511121554673, 5751.568632352591, 5757.193992841006, 6306.243250809886, 6987.650617469157, 7005.579665220052, 7008.19405768338, 7013.228544860061, 3796.4115562087923, 3858.4019476980834, 4553.089382123589, 4575.4738205106505, 4635.513271106519, 7294.234105418907, 7436.66535005926, 7538.660760265801, 7547.245275472409, 7547.622618869034, 4607.401037865123, 4643.628509719214, 4643.955110100201, 4646.83736069236, 4656.743879086615, 4684.0, 4710.24636058229, 4720.740359280273, 4731.030138821533, 4736.502667219892, 5593.776248950077, 5619.7471113799975, 5628.127640215773, 5634.661920284796, 5644.491995720405, 5758.654480731169, 6849.965750171317, 7150.356467917913, 7153.141623005273, 7153.928460715326, 1358.3208395802098, 1608.107500337324, 1638.2218446237941, 1640.23728966029, 1641.0809946430038, 1030.2324768047852, 1035.316690983962, 1045.1795340657548, 1052.315994603514, 1056.587930707025, 6699.43054840344, 6708.094407255056, 6737.730490780314, 6745.224299205556, 6747.190337159474, 5637.773079633522, 7366.7053317866685, 7380.74167404149, 7383.6677349519405, 7389.965404843326, 6462.515311351667, 6700.83247918806, 6712.463002959751, 6714.932850671431, 6732.293109223461, 3338.6812209177724, 3805.8858234253016, 3892.4939757831303, 3913.3934240192816, 3928.03763078042, 7700.03448224165, 7725.806854828675, 7740.92259077402, 7741.922580774233, 7772.65023073963, 7246.855062898712, 7581.203973582805, 7599.278068583476, 7599.696012159452, 7601.08786945559, 7692.576908269987, 7694.615269236628, 7713.0, 7720.9190713301305, 7722.768316950501, 6361.936380636134, 7342.449316301192, 7344.632768361667, 7350.19147893742, 7350.926490735024, 6971.372576468142, 7259.709611615476, 7262.6731797070315, 7263.6005019724425, 7277.636118194175, 7695.23047695226, 7710.344620707303, 7718.614069296625, 7720.613969301625, 7747.0, 4643.883902902455, 4666.3700400445505, 4684.180268452939, 4687.765611719332, 4698.483166851712, 7082.504224704221, 7320.780376588711, 7338.192798792022, 7346.302101300368, 7383.630818458948, 7086.929130708627, 7102.3962963148715, 7112.964435177791, 7127.2516385778745, 7150.64246787669, 6866.519343646097, 7077.363037326665, 7092.716291348288, 7102.14774227096, 7139.107611548557, 6662.500312476487, 6953.165620125617, 6956.339147780953, 6957.234704182435, 6965.616891071039, 6935.965320173367, 7003.54476958996, 7025.789226323219, 7102.289771022856, 7186.317299856505, 6667.166604174478, 6792.21889482696, 6914.101166848278, 6952.582845029315, 6997.195322537973], "unit": "score", "name": "prototype.html", "value": 5139.203844214391}, {"lowerIsBetter": false, "replicates": [664.7241394821149, 695.0790202981049, 709.1808960650447, 720.1610124205301, 769.1001528211991, 14775.408983640642, 14790.556283311491, 14959.700805983874, 14983.175925324103, 15059.322330495126, 13724.0, 13786.586402407918, 13797.96515261357, 13798.172109673427, 13799.379027943742, 699.2133849419403, 703.9718411263543, 709.4785332780402, 841.8021764885247, 862.3187681731424, 845.9280961118282, 859.7420773767844, 870.4124715816798, 871.172386233078, 871.7776966873438, 898.1422741282059, 913.1234015345276, 914.1178762494192, 915.9084091590854, 916.7708072981754, 727.3889932456735, 736.6316841579211, 888.4846788862444, 895.5164211325877, 910.8588168833842, 562.6961440821992, 670.4703284405363, 670.577536152221, 670.6680193304345, 671.0571646836203, 15014.849851501564, 15037.248137593077, 15041.548753537301, 15114.319855606414, 15162.469313574082, 13063.412146453433, 13105.148165369315, 13213.86786132136, 13474.305138972244, 13583.252921089335, 10096.040876116756, 10172.745681357952, 10252.74368140795, 10291.485425728684, 10410.011048950337, 3565.8217089145696, 3620.348337299285, 3621.5835178954494, 3624.2026754114318, 3793.848246070154, 82201.0, 82949.0, 83205.0, 84209.0, 84260.57869710673, 8279.69266514759, 9494.335396522316, 9848.310618256653, 9914.157296629723, 9928.205743540499, 21644.02601882919, 21723.0, 21734.13063477475, 21751.456213594785, 21775.020124094455, 7507.662155203029, 7515.8121046973165, 7538.585377804164, 7598.962005189938, 7661.387089032864, 3978.224246271949, 4122.670186385082, 4147.0, 4161.438205842233, 4168.062186008185, 3383.6447173046968, 3410.113370523632, 3422.264213194175, 3437.6906078453057, 3443.018739659185, 639.6929473852576, 652.5366989437553, 654.5123882707413, 670.7752902777527, 675.8715843989626, 562.5836880708329, 620.2649859916014, 632.4940047961612, 640.4012248547623, 643.9323870993572, 8559.486430814171, 8579.82840343202, 8621.396502244908, 8824.617353314568, 9055.547222638841, 516.3468212710849, 569.6667449541982, 602.9276486821609, 606.8513214262446, 618.5886385553647, 3779.640934111255, 3950.150717595673, 4005.599440055971, 4032.3749818778138, 4132.421460995463, 90817.0, 92180.0781992185, 92772.0, 93302.53348733213, 93325.06674933164, 75560.24439755642, 76199.61900190574, 76202.0, 78452.0, 79426.0, 70100.6494967532, 70844.0, 71194.0, 71334.28665713276, 71832.56334873273, 8036.4776289541, 8075.0, 8168.754937351889, 8365.121662225622, 8376.455530390505, 42045.94885127896, 49038.0, 49425.50574494209, 49715.75142124266, 49884.0, 66364.33635663775, 67020.0, 69040.3095969054, 69583.17292548959, 71309.64345178241, 8750.767939823547, 10938.781224375309, 11047.558097676003, 11208.991190792867, 11617.302961822317, 12057.15599908033, 12063.879361206627, 12105.757884842078, 12178.147529673191, 12555.183913045988, 11733.882661173278, 11778.352190629255, 11780.998615117469, 11806.173567850168, 11857.407129643656, 11234.0, 11340.94329528347, 11621.709457263298, 11878.584249551224, 11921.940390297994, 11162.218644694793, 11310.773784524099, 11614.896584824428, 11626.88373116258, 11911.166218364979, 9276.536173191449, 9319.720408387759, 9474.38416502925, 9613.903860961302, 9835.655752048644, 9773.560189791335, 10050.597976080875, 10078.496075196064, 10080.899191007997, 10087.24345674092], "unit": "score", "name": "yui.html", "value": 6884.7724444843625}], "name": "dromaeo_css", "value": 7659.217726889205}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 109.0, 111.0, 110.0, 111.0, 112.0, 116.0, 110.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.2}, {"lowerIsBetter": true, "replicates": [159.0, 120.0, 155.0, 182.0, 147.0, 144.0, 117.0, 157.0, 145.0, 118.0], "unit": "score", "name": "audio-beat-detection", "value": 144.4}, {"lowerIsBetter": true, "replicates": [183.0, 182.0, 186.0, 183.0, 184.0, 184.0, 184.0, 184.0, 180.0, 182.0], "unit": "score", "name": "audio-dft", "value": 183.2}, {"lowerIsBetter": true, "replicates": [75.0, 72.0, 91.0, 77.0, 57.0, 57.0, 64.0, 76.0, 75.0, 55.0], "unit": "score", "name": "audio-fft", "value": 69.9}, {"lowerIsBetter": true, "replicates": [94.0, 92.0, 121.0, 78.0, 63.0, 76.0, 132.0, 113.0, 114.0, 121.0], "unit": "score", "name": "audio-oscillator", "value": 100.4}, {"lowerIsBetter": true, "replicates": [85.0, 91.0, 85.0, 91.0, 85.0, 93.0, 131.0, 130.0, 85.0, 93.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 96.9}, {"lowerIsBetter": true, "replicates": [106.0, 149.0, 94.0, 95.0, 94.0, 94.0, 94.0, 93.0, 93.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 100.6}, {"lowerIsBetter": true, "replicates": [87.0, 86.0, 95.0, 135.0, 131.0, 86.0, 87.0, 84.0, 83.0, 88.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [55.0, 54.0, 53.0, 53.0, 53.0, 54.0, 55.0, 66.0, 52.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 54.8}, {"lowerIsBetter": true, "replicates": [65.0, 62.0, 72.0, 73.0, 70.0, 66.0, 65.0, 64.0, 65.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.9}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 84.0, 83.0, 83.0, 82.0, 81.0, 82.0, 84.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.0}, {"lowerIsBetter": true, "replicates": [126.0, 128.0, 133.0, 129.0, 127.0, 107.0, 123.0, 126.0, 119.0, 132.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.0}, {"lowerIsBetter": true, "replicates": [140.0, 126.0, 136.0, 137.0, 140.0, 127.0, 138.0, 139.0, 138.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 135.9}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 67.0, 67.0, 66.0, 66.0, 68.0, 96.0, 93.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.4}], "name": "kraken", "value": 1440.8000000000002}]} 05:18:39 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,59]]", "result": "1440.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,59]]", "result": "7659.22"}}} 05:18:39 INFO - Return code: 0 05:18:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:18:39 INFO - # TBPL SUCCESS # 05:18:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:18:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:18:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:18:39 INFO - 2016-02-09 05:18:39.902 screenresolution[1693:9973] starting screenresolution argv=screenresolution get 05:18:39 INFO - 2016-02-09 05:18:39.905 screenresolution[1693:9973] Display 0: 1600x1200x32@60 05:18:39 INFO - 2016-02-09 05:18:39.910 screenresolution[1694:9976] starting screenresolution argv=screenresolution list 05:18:39 INFO - Available Modes on Display 0 05:18:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:18:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:18:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:18:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:18:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:18:40 INFO - Intel Iris: 05:18:40 INFO - Chipset Model: Intel Iris 05:18:40 INFO - Type: GPU 05:18:40 INFO - Bus: Built-In 05:18:40 INFO - VRAM (Dynamic, Max): 1536 MB 05:18:40 INFO - Vendor: Intel (0x8086) 05:18:40 INFO - Device ID: 0x0a2e 05:18:40 INFO - Revision ID: 0x0009 05:18:40 INFO - Displays: 05:18:40 INFO - Display: 05:18:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:18:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:18:40 INFO - Display Serial Number: 1600x1200 60 05:18:40 INFO - Main Display: Yes 05:18:40 INFO - Mirror: Off 05:18:40 INFO - Online: Yes 05:18:40 INFO - Rotation: Supported 05:18:40 INFO - Return code: 0 05:18:40 INFO - Running post-action listener: _resource_record_post_action 05:18:40 INFO - Running post-run listener: _resource_record_post_run 05:18:41 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 39220736; Write bytes: 706888192; Read time: 423; Write time: 2007 05:18:41 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 401736192; Write bytes: 396323840; Read time: 30025; Write time: 691 05:18:41 INFO - run-tests - Wall time: 1175s; CPU: 53.0%; Read bytes: 37398016; Write bytes: 299075072; Read time: 402; Write time: 1283 05:18:41 INFO - Running post-run listener: _upload_blobber_files 05:18:41 INFO - Blob upload gear active. 05:18:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:18:41 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 05:18:41 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:18:41 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:18:41 INFO - (blobuploader) - INFO - Open directory for files ... 05:18:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:18:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:18:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:18:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:18:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:18:42 INFO - (blobuploader) - INFO - Done attempting. 05:18:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:18:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:18:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:18:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:18:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:18:43 INFO - (blobuploader) - INFO - Done attempting. 05:18:43 INFO - (blobuploader) - INFO - Iteration through files over. 05:18:43 INFO - Return code: 0 05:18:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:18:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:18:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a99fc216b28677cb99a5ba2cfb2d49488c1274485e7c059e67f37653e394561c37e7434291777ffc3ff4fbf89ea885ce5b9acb9474020328d01423ee980431f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ce2cb1db1b49626f15f4dd0a11547ea461170d996feb22139d7d7155bd7eb467aefc52aad81f13e9b1d557487b825c2494f1c493c88da10aed2a9f3d335693c"} 05:18:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:18:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:18:43 INFO - Contents: 05:18:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a99fc216b28677cb99a5ba2cfb2d49488c1274485e7c059e67f37653e394561c37e7434291777ffc3ff4fbf89ea885ce5b9acb9474020328d01423ee980431f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ce2cb1db1b49626f15f4dd0a11547ea461170d996feb22139d7d7155bd7eb467aefc52aad81f13e9b1d557487b825c2494f1c493c88da10aed2a9f3d335693c"} 05:18:43 INFO - Running post-run listener: copy_logs_to_upload_dir 05:18:43 INFO - Copying logs to upload dir... 05:18:43 INFO - mkdir: /builds/slave/test/build/upload/logs 05:18:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.786960 ========= master_lag: 1.93 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-02-09 05:18:45.590442) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-09 05:18:45.595278) ========= 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.degx1neawc/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.0qpDrWMb28/Listeners TMPDIR=/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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/Firefox/sha512/7a99fc216b28677cb99a5ba2cfb2d49488c1274485e7c059e67f37653e394561c37e7434291777ffc3ff4fbf89ea885ce5b9acb9474020328d01423ee980431f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ce2cb1db1b49626f15f4dd0a11547ea461170d996feb22139d7d7155bd7eb467aefc52aad81f13e9b1d557487b825c2494f1c493c88da10aed2a9f3d335693c"} build_url:https://queue.taskcluster.net/v1/task/ZQHtpXkxTuqikQvta1RKDA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011434 build_url: 'https://queue.taskcluster.net/v1/task/ZQHtpXkxTuqikQvta1RKDA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a99fc216b28677cb99a5ba2cfb2d49488c1274485e7c059e67f37653e394561c37e7434291777ffc3ff4fbf89ea885ce5b9acb9474020328d01423ee980431f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ce2cb1db1b49626f15f4dd0a11547ea461170d996feb22139d7d7155bd7eb467aefc52aad81f13e9b1d557487b825c2494f1c493c88da10aed2a9f3d335693c"}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-09 05:18:45.643913) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 05:18:45.644271) ========= 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.degx1neawc/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.0qpDrWMb28/Listeners TMPDIR=/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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.004960 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 05:18:45.696554) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-09 05:18:45.699925) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-09 05:18:45.700308) ========= ========= Total master_lag: 2.17 =========