builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0194 starttime: 1456151182.43 results: success (0) buildid: 20160222030212 builduid: c4c5afe0268442618a2d2c650e205c99 revision: e1cf617a1f2813b6cd66f460313a61c223406c9b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:22.425765) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:22.426369) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:22.426721) ========= 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.HPf9hVXmO8/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.DHC4bRKkjA/Listeners TMPDIR=/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/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.005129 basedir: '/builds/slave/test' ========= master_lag: 0.10 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:22.529436) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:22.529770) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:22.896164) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:22.896447) ========= 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.HPf9hVXmO8/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.DHC4bRKkjA/Listeners TMPDIR=/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/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.006167 ========= master_lag: 0.20 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:23.098204) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:23.098507) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:23.099091) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:23.099407) ========= 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.HPf9hVXmO8/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.DHC4bRKkjA/Listeners TMPDIR=/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/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-22 06:26:23-- 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% 161M=0s 2016-02-22 06:26:23 (161 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.572342 ========= master_lag: 0.14 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:23.807141) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:23.807450) ========= 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.HPf9hVXmO8/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.DHC4bRKkjA/Listeners TMPDIR=/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/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.027090 ========= master_lag: 0.11 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:23.941779) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:23.942130) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e1cf617a1f2813b6cd66f460313a61c223406c9b --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 e1cf617a1f2813b6cd66f460313a61c223406c9b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.HPf9hVXmO8/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.DHC4bRKkjA/Listeners TMPDIR=/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/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-22 06:26:24,032 truncating revision to first 12 chars 2016-02-22 06:26:24,032 Setting DEBUG logging. 2016-02-22 06:26:24,032 attempt 1/10 2016-02-22 06:26:24,032 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e1cf617a1f28?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-22 06:26:24,624 unpacking tar archive at: mozilla-central-e1cf617a1f28/testing/mozharness/ program finished with exit code 0 elapsedTime=0.841541 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:24.834808) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:24.835177) ========= echo e1cf617a1f2813b6cd66f460313a61c223406c9b in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'e1cf617a1f2813b6cd66f460313a61c223406c9b'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.HPf9hVXmO8/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.DHC4bRKkjA/Listeners TMPDIR=/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/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 e1cf617a1f2813b6cd66f460313a61c223406c9b program finished with exit code 0 elapsedTime=0.005475 script_repo_revision: 'e1cf617a1f2813b6cd66f460313a61c223406c9b' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:24.887017) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:24.887440) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:24.929670) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-02-22 06:26:24.930006) ========= /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.HPf9hVXmO8/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.DHC4bRKkjA/Listeners TMPDIR=/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/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 06:26:25 INFO - MultiFileLogger online at 20160222 06:26:25 in /builds/slave/test 06:26:25 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 06:26:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:26:25 INFO - {'append_to_log': False, 06:26:25 INFO - 'base_work_dir': '/builds/slave/test', 06:26:25 INFO - 'blob_upload_branch': 'Firefox', 06:26:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:26:25 INFO - 'branch': 'Firefox', 06:26:25 INFO - 'buildbot_json_path': 'buildprops.json', 06:26:25 INFO - 'config_files': ('talos/mac_config.py',), 06:26:25 INFO - 'default_actions': ('clobber', 06:26:25 INFO - 'read-buildbot-config', 06:26:25 INFO - 'download-and-extract', 06:26:25 INFO - 'populate-webroot', 06:26:25 INFO - 'create-virtualenv', 06:26:25 INFO - 'install', 06:26:25 INFO - 'run-tests'), 06:26:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:26:25 INFO - 'download_minidump_stackwalk': True, 06:26:25 INFO - 'download_symbols': 'ondemand', 06:26:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:26:25 INFO - 'tooltool.py': '/tools/tooltool.py', 06:26:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:26:25 INFO - '/tools/misc-python/virtualenv.py')}, 06:26:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:26:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:26:25 INFO - 'installer_path': 'installer.exe', 06:26:25 INFO - 'log_level': 'info', 06:26:25 INFO - 'log_name': 'talos', 06:26:25 INFO - 'log_to_console': True, 06:26:25 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:26:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:26:25 INFO - 'opt_config_files': (), 06:26:25 INFO - 'pip_index': False, 06:26:25 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:26:25 INFO - 'cmd': ('bash', 06:26:25 INFO - '-c', 06:26:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:26:25 INFO - 'enabled': True, 06:26:25 INFO - 'halt_on_failure': False, 06:26:25 INFO - 'name': 'check_screen_resolution'},), 06:26:25 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:26:25 INFO - 'cmd': ('bash', 06:26:25 INFO - '-c', 06:26:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:26:25 INFO - 'enabled': True, 06:26:25 INFO - 'halt_on_failure': False, 06:26:25 INFO - 'name': 'check_screen_resolution'},), 06:26:25 INFO - 'run_cmd_checks_enabled': True, 06:26:25 INFO - 'sps_profile': False, 06:26:25 INFO - 'sps_profile_interval': 0, 06:26:25 INFO - 'suite': 'dromaeojs', 06:26:25 INFO - 'system_bits': '32', 06:26:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:26:25 INFO - 'title': 't-yosemite-r7-0194', 06:26:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:26:25 INFO - 'use_talos_json': True, 06:26:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:26:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:26:25 INFO - 'work_dir': 'build'} 06:26:25 INFO - ##### 06:26:25 INFO - ##### Running clobber step. 06:26:25 INFO - ##### 06:26:25 INFO - Running pre-action listener: _resource_record_pre_action 06:26:25 INFO - Running main action method: clobber 06:26:25 INFO - rmtree: /builds/slave/test/build 06:26:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:26:26 INFO - Running post-action listener: _resource_record_post_action 06:26:26 INFO - ##### 06:26:26 INFO - ##### Running read-buildbot-config step. 06:26:26 INFO - ##### 06:26:26 INFO - Running pre-action listener: _resource_record_pre_action 06:26:26 INFO - Running main action method: read_buildbot_config 06:26:26 INFO - Using buildbot properties: 06:26:26 INFO - { 06:26:26 INFO - "project": "", 06:26:26 INFO - "product": "firefox", 06:26:26 INFO - "script_repo_revision": "production", 06:26:26 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 06:26:26 INFO - "repository": "", 06:26:26 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 06:26:26 INFO - "buildid": "20160222030212", 06:26:26 INFO - "stage_platform": "macosx64", 06:26:26 INFO - "basedir": "/builds/slave/test", 06:26:26 INFO - "nightly_build": "True", 06:26:26 INFO - "buildnumber": 149, 06:26:26 INFO - "slavename": "t-yosemite-r7-0194", 06:26:26 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 06:26:26 INFO - "platform": "yosemite_r7", 06:26:26 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 06:26:26 INFO - "branch": "mozilla-central", 06:26:26 INFO - "repo_path": "mozilla-central", 06:26:26 INFO - "revision": "e1cf617a1f2813b6cd66f460313a61c223406c9b", 06:26:26 INFO - "pgo_build": "False", 06:26:26 INFO - "builduid": "c4c5afe0268442618a2d2c650e205c99", 06:26:26 INFO - "slavebuilddir": "test" 06:26:26 INFO - } 06:26:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 06:26:26 INFO - Running post-action listener: _resource_record_post_action 06:26:26 INFO - ##### 06:26:26 INFO - ##### Running download-and-extract step. 06:26:26 INFO - ##### 06:26:26 INFO - Running pre-action listener: _resource_record_pre_action 06:26:26 INFO - Running main action method: download_and_extract 06:26:26 INFO - mkdir: /builds/slave/test/build/tests 06:26:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:26:26 INFO - https://queue.taskcluster.net/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:26:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/test_packages.json 06:26:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/test_packages.json 06:26:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 06:26:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 06:26:28 INFO - Downloaded 1277 bytes. 06:26:28 INFO - Reading from file /builds/slave/test/build/test_packages.json 06:26:28 INFO - Using the following test package requirements: 06:26:28 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 06:26:28 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:26:28 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 06:26:28 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:26:28 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 06:26:28 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:26:28 INFO - u'jsshell-mac.zip'], 06:26:28 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:26:28 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 06:26:28 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 06:26:28 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:26:28 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 06:26:28 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:26:28 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 06:26:28 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:26:28 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 06:26:28 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 06:26:28 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:26:28 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 06:26:28 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:26:28 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')]} 06:26:28 INFO - https://queue.taskcluster.net/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:26:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 06:26:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 06:26:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/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 06:26:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/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 06:26:29 INFO - Downloaded 17825439 bytes. 06:26:29 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'] 06:26:29 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 06:26:32 INFO - Return code: 0 06:26:32 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 06:26:32 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')]} 06:26:32 INFO - https://queue.taskcluster.net/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:26:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 06:26:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 06:26:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/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 06:26:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/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 06:26:35 INFO - Downloaded 17825439 bytes. 06:26:35 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'] 06:26:35 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 06:26:38 INFO - Return code: 0 06:26:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:26:38 INFO - https://queue.taskcluster.net/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 06:26:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 06:26:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 06:26:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/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 06:26:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/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 06:26:39 INFO - Downloaded 10707015 bytes. 06:26:39 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'] 06:26:39 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 06:26:40 INFO - Return code: 0 06:26:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:26:40 INFO - https://queue.taskcluster.net/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 06:26:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 06:26:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 06:26:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 06:26:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/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 06:26:42 INFO - Downloaded 111382499 bytes. 06:26:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 06:26:42 INFO - mkdir: /builds/slave/test/properties 06:26:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:26:42 INFO - Writing to file /builds/slave/test/properties/build_url 06:26:42 INFO - Contents: 06:26:42 INFO - build_url:https://queue.taskcluster.net/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 06:26:43 INFO - Running post-action listener: _resource_record_post_action 06:26:43 INFO - Running post-action listener: set_extra_try_arguments 06:26:43 INFO - ##### 06:26:43 INFO - ##### Running populate-webroot step. 06:26:43 INFO - ##### 06:26:43 INFO - Running pre-action listener: _resource_record_pre_action 06:26:43 INFO - Running main action method: populate_webroot 06:26:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:26:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:26:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:26:43 INFO - '--tppagecycles', 06:26:43 INFO - '7'], 06:26:43 INFO - 'tests': ['tsvgm']}}, 06:26:43 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:26:43 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:26:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:26:43 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 06:26:43 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:26:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:26:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:26:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:26:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:26:43 INFO - 'talos_options': ['--e10s'], 06:26:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:26:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:26:43 INFO - 'tests': ['damp', 'tps']}, 06:26:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:26:43 INFO - 'talos_options': ['--e10s'], 06:26:43 INFO - 'tests': ['damp', 'tps']}, 06:26:43 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:26:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:26:43 INFO - 'other': {'tests': ['a11yr', 06:26:43 INFO - 'ts_paint', 06:26:43 INFO - 'tpaint', 06:26:43 INFO - 'sessionrestore', 06:26:43 INFO - 'sessionrestore_no_auto_restore']}, 06:26:43 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:26:43 INFO - 'tests': ['a11yr', 06:26:43 INFO - 'ts_paint', 06:26:43 INFO - 'tpaint', 06:26:43 INFO - 'sessionrestore', 06:26:43 INFO - 'sessionrestore_no_auto_restore']}, 06:26:43 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:26:43 INFO - 'tests': ['a11yr', 06:26:43 INFO - 'ts_paint', 06:26:43 INFO - 'tpaint', 06:26:43 INFO - 'sessionrestore', 06:26:43 INFO - 'sessionrestore_no_auto_restore']}, 06:26:43 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:26:43 INFO - 'tests': ['a11yr', 06:26:43 INFO - 'ts_paint', 06:26:43 INFO - 'tpaint', 06:26:43 INFO - 'sessionrestore', 06:26:43 INFO - 'sessionrestore_no_auto_restore']}, 06:26:43 INFO - 'other_l64': {'tests': ['a11yr', 06:26:43 INFO - 'ts_paint', 06:26:43 INFO - 'tpaint', 06:26:43 INFO - 'sessionrestore', 06:26:43 INFO - 'sessionrestore_no_auto_restore']}, 06:26:43 INFO - 'other_nol64': {'tests': ['a11yr', 06:26:43 INFO - 'ts_paint', 06:26:43 INFO - 'tpaint', 06:26:43 INFO - 'sessionrestore', 06:26:43 INFO - 'sessionrestore_no_auto_restore']}, 06:26:43 INFO - 'svgr': {'tests': ['tsvgx', 06:26:43 INFO - 'tsvgr_opacity', 06:26:43 INFO - 'tart', 06:26:43 INFO - 'tscrollx', 06:26:43 INFO - 'cart']}, 06:26:43 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:26:43 INFO - 'tests': ['tsvgx', 06:26:43 INFO - 'tsvgr_opacity', 06:26:43 INFO - 'tart', 06:26:43 INFO - 'tscrollx', 06:26:43 INFO - 'cart']}, 06:26:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:26:43 INFO - 'tests': ['tp5o']}, 06:26:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:26:43 INFO - 'talos_options': ['--e10s'], 06:26:43 INFO - 'tests': ['tp5o']}, 06:26:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:26:43 INFO - 'talos_options': ['--xperf_path', 06:26:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:26:43 INFO - 'tests': ['tp5n']}, 06:26:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:26:43 INFO - 'talos_options': ['--e10s', 06:26:43 INFO - '--xperf_path', 06:26:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:26:43 INFO - 'tests': ['tp5n']}}, 06:26:43 INFO - 'talos.zip': {'path': '', 06:26:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:26:43 INFO - Running post-action listener: _resource_record_post_action 06:26:43 INFO - ##### 06:26:43 INFO - ##### Running create-virtualenv step. 06:26:43 INFO - ##### 06:26:43 INFO - Running pre-action listener: _resource_record_pre_action 06:26:43 INFO - Running main action method: create_virtualenv 06:26:43 INFO - Creating virtualenv /builds/slave/test/build/venv 06:26:43 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 06:26:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:26:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:26:43 INFO - Using real prefix '/tools/python27' 06:26:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:26:44 INFO - Installing distribute.............................................................................................................................................................................................done. 06:26:47 INFO - Installing pip.................done. 06:26:47 INFO - Return code: 0 06:26:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:26: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')]} 06:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:26:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26: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')]} 06:26:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:26:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1030cca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030d44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc849d181a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f70d30>, '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 0x102d94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f67b20>, '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.HPf9hVXmO8/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.DHC4bRKkjA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/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 06:26:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:26:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:26:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HPf9hVXmO8/Render', 06:26:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:26:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:26:47 INFO - 'HOME': '/Users/cltbld', 06:26:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:26:47 INFO - 'LOGNAME': 'cltbld', 06:26:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:26:47 INFO - 'MOZ_NO_REMOTE': '1', 06:26:47 INFO - 'NO_EM_RESTART': '1', 06:26:47 INFO - 'PAGER': '/bin/cat', 06:26:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:26:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:26:47 INFO - 'PWD': '/builds/slave/test', 06:26:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:26:47 INFO - 'SHELL': '/bin/bash', 06:26:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DHC4bRKkjA/Listeners', 06:26:47 INFO - 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/', 06:26:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:26:47 INFO - 'USER': 'cltbld', 06:26:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:26:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:26:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:26:47 INFO - 'XPC_FLAGS': '0x0', 06:26:47 INFO - 'XPC_SERVICE_NAME': '0', 06:26:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:26:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:26:47 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 06:26:47 INFO - Cleaning up... 06:26:47 INFO - Return code: 0 06:26:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:26: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')]} 06:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:26:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26: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')]} 06:26:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:26:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1030cca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030d44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc849d181a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f70d30>, '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 0x102d94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f67b20>, '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.HPf9hVXmO8/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.DHC4bRKkjA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/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 06:26:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 06:26:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 06:26:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HPf9hVXmO8/Render', 06:26:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:26:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:26:47 INFO - 'HOME': '/Users/cltbld', 06:26:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:26:47 INFO - 'LOGNAME': 'cltbld', 06:26:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:26:47 INFO - 'MOZ_NO_REMOTE': '1', 06:26:47 INFO - 'NO_EM_RESTART': '1', 06:26:47 INFO - 'PAGER': '/bin/cat', 06:26:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:26:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:26:47 INFO - 'PWD': '/builds/slave/test', 06:26:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:26:47 INFO - 'SHELL': '/bin/bash', 06:26:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DHC4bRKkjA/Listeners', 06:26:47 INFO - 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/', 06:26:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:26:47 INFO - 'USER': 'cltbld', 06:26:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:26:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:26:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:26:47 INFO - 'XPC_FLAGS': '0x0', 06:26:47 INFO - 'XPC_SERVICE_NAME': '0', 06:26:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:26:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:26:47 INFO - Downloading/unpacking psutil>=0.7.1 06:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:26:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:26:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:26:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:26:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:26:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:26:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:26:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:26:51 INFO - Installing collected packages: psutil 06:26:51 INFO - Running setup.py install for psutil 06:26:51 INFO - building 'psutil._psutil_osx' extension 06:26:51 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 06:26:51 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 06:26:51 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 06:26:52 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 06:26:52 INFO - building 'psutil._psutil_posix' extension 06:26:52 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 06:26:52 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:26:52 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:26:52 INFO - ^ 06:26:52 INFO - 1 warning generated. 06:26:52 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 06:26:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:26:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:26:52 INFO - Successfully installed psutil 06:26:52 INFO - Cleaning up... 06:26:52 INFO - Return code: 0 06:26:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:26: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')]} 06:26:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:26:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26: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')]} 06:26:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:26:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1030cca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030d44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc849d181a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f70d30>, '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 0x102d94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f67b20>, '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.HPf9hVXmO8/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.DHC4bRKkjA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/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 06:26:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 06:26:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 06:26:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HPf9hVXmO8/Render', 06:26:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:26:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:26:52 INFO - 'HOME': '/Users/cltbld', 06:26:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:26:52 INFO - 'LOGNAME': 'cltbld', 06:26:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:26:52 INFO - 'MOZ_NO_REMOTE': '1', 06:26:52 INFO - 'NO_EM_RESTART': '1', 06:26:52 INFO - 'PAGER': '/bin/cat', 06:26:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:26:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:26:52 INFO - 'PWD': '/builds/slave/test', 06:26:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:26:52 INFO - 'SHELL': '/bin/bash', 06:26:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DHC4bRKkjA/Listeners', 06:26:52 INFO - 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/', 06:26:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:26:52 INFO - 'USER': 'cltbld', 06:26:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:26:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:26:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:26:52 INFO - 'XPC_FLAGS': '0x0', 06:26:52 INFO - 'XPC_SERVICE_NAME': '0', 06:26:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:26:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:26:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:26:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:26:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:26:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:26:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:26:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:26:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:26:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:26:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:26:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:26:55 INFO - Installing collected packages: mozsystemmonitor 06:26:55 INFO - Running setup.py install for mozsystemmonitor 06:26:55 INFO - Successfully installed mozsystemmonitor 06:26:55 INFO - Cleaning up... 06:26:55 INFO - Return code: 0 06:26:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:26:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:26:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:26:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:26:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:26:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1030cca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030d44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc849d181a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f70d30>, '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 0x102d94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f67b20>, '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.HPf9hVXmO8/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.DHC4bRKkjA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/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 06:26:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:26:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:26:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HPf9hVXmO8/Render', 06:26:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:26:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:26:55 INFO - 'HOME': '/Users/cltbld', 06:26:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:26:55 INFO - 'LOGNAME': 'cltbld', 06:26:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:26:55 INFO - 'MOZ_NO_REMOTE': '1', 06:26:55 INFO - 'NO_EM_RESTART': '1', 06:26:55 INFO - 'PAGER': '/bin/cat', 06:26:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:26:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:26:55 INFO - 'PWD': '/builds/slave/test', 06:26:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:26:55 INFO - 'SHELL': '/bin/bash', 06:26:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DHC4bRKkjA/Listeners', 06:26:55 INFO - 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/', 06:26:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:26:55 INFO - 'USER': 'cltbld', 06:26:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:26:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:26:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:26:55 INFO - 'XPC_FLAGS': '0x0', 06:26:55 INFO - 'XPC_SERVICE_NAME': '0', 06:26:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:26:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:26:55 INFO - Downloading/unpacking blobuploader==1.2.4 06:26:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:26:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:26:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:26:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:26:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:26:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:26:57 INFO - Downloading blobuploader-1.2.4.tar.gz 06:26:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:26:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:26:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:26:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:26:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:26:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:26:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:26:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:26:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:26:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:26:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:26:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:26:59 INFO - Downloading docopt-0.6.1.tar.gz 06:26:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:26:59 INFO - Installing collected packages: blobuploader, requests, docopt 06:26:59 INFO - Running setup.py install for blobuploader 06:26:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:26:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:26:59 INFO - Running setup.py install for requests 06:26:59 INFO - Running setup.py install for docopt 06:26:59 INFO - Successfully installed blobuploader requests docopt 06:26:59 INFO - Cleaning up... 06:27:00 INFO - Return code: 0 06:27:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:27:00 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')]} 06:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:00 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')]} 06:27:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:00 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 0x1030cca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030d44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc849d181a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f70d30>, '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 0x102d94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f67b20>, '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.HPf9hVXmO8/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.DHC4bRKkjA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/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 06:27:00 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 06:27:00 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 06:27:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HPf9hVXmO8/Render', 06:27:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:27:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:27:00 INFO - 'HOME': '/Users/cltbld', 06:27:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:27:00 INFO - 'LOGNAME': 'cltbld', 06:27:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:00 INFO - 'MOZ_NO_REMOTE': '1', 06:27:00 INFO - 'NO_EM_RESTART': '1', 06:27:00 INFO - 'PAGER': '/bin/cat', 06:27:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:27:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:00 INFO - 'PWD': '/builds/slave/test', 06:27:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:27:00 INFO - 'SHELL': '/bin/bash', 06:27:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DHC4bRKkjA/Listeners', 06:27:00 INFO - 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/', 06:27:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:27:00 INFO - 'USER': 'cltbld', 06:27:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:27:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:27:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:00 INFO - 'XPC_FLAGS': '0x0', 06:27:00 INFO - 'XPC_SERVICE_NAME': '0', 06:27:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:27:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:27:00 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-M98A0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:27:00 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-x5mjZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:27:00 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-fZSKDy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:27:00 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-wInin9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:27:00 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-8tExl0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:27:00 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-aCbJz2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:27:00 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-Gn0Isw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:27:01 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-aS40WA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:27:01 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-vgrQ2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:27:01 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-kEmlVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:27:01 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-t0E628-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:27:01 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-A59BQ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:27:01 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-qRjpHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:27:01 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-cdF3tW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:27:01 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-qwzWRU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:27:01 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-xSNy09-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:27:01 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-vWPrNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:27:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:27:02 INFO - Running setup.py install for manifestparser 06:27:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:27:02 INFO - Running setup.py install for mozcrash 06:27:02 INFO - Running setup.py install for mozdebug 06:27:02 INFO - Running setup.py install for mozdevice 06:27:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:27:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:27:02 INFO - Running setup.py install for mozfile 06:27:02 INFO - Running setup.py install for mozhttpd 06:27:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:27:02 INFO - Running setup.py install for mozinfo 06:27:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:27:03 INFO - Running setup.py install for mozInstall 06:27:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:27:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:27:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:27:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:27:03 INFO - Running setup.py install for mozleak 06:27:03 INFO - Running setup.py install for mozlog 06:27:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:27:03 INFO - Running setup.py install for moznetwork 06:27:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:27:03 INFO - Running setup.py install for mozprocess 06:27:03 INFO - Running setup.py install for mozprofile 06:27:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:27:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:27:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:27:03 INFO - Running setup.py install for mozrunner 06:27:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:27:04 INFO - Running setup.py install for mozscreenshot 06:27:04 INFO - Running setup.py install for moztest 06:27:04 INFO - Running setup.py install for mozversion 06:27:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:27:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:27:04 INFO - Cleaning up... 06:27:04 INFO - Return code: 0 06:27:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:27:04 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')]} 06:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:04 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')]} 06:27:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:04 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 0x1030cca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030d44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc849d181a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f70d30>, '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 0x102d94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f67b20>, '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.HPf9hVXmO8/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.DHC4bRKkjA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/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 06:27:04 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 06:27:04 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 06:27:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HPf9hVXmO8/Render', 06:27:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:27:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:27:04 INFO - 'HOME': '/Users/cltbld', 06:27:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:27:04 INFO - 'LOGNAME': 'cltbld', 06:27:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:04 INFO - 'MOZ_NO_REMOTE': '1', 06:27:04 INFO - 'NO_EM_RESTART': '1', 06:27:04 INFO - 'PAGER': '/bin/cat', 06:27:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:27:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:04 INFO - 'PWD': '/builds/slave/test', 06:27:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:27:04 INFO - 'SHELL': '/bin/bash', 06:27:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DHC4bRKkjA/Listeners', 06:27:04 INFO - 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/', 06:27:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:27:04 INFO - 'USER': 'cltbld', 06:27:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:27:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:27:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:04 INFO - 'XPC_FLAGS': '0x0', 06:27:04 INFO - 'XPC_SERVICE_NAME': '0', 06:27:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:27:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:27:04 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-QWANY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:27:04 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)) 06:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:27:04 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-OlBjGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:27:05 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)) 06:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:27:05 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-f1bvB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:27:05 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)) 06:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:27:05 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-840E0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:27:05 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)) 06:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:27:05 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-5SlWRp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:27:05 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)) 06:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:27:05 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-PrHz0x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:27:05 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)) 06:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:27:05 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-XzKzCX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:27:05 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)) 06:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:27:05 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-Yniego-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:27:05 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)) 06:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:27:05 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-jb9cJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:27:05 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)) 06:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:27:05 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-peZKBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:27:05 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)) 06:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:27:05 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-GXD6y6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:27:06 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)) 06:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:27:06 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-1n_xaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:27:06 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)) 06:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:27:06 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-sYNY_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:27:06 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)) 06:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:27:06 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-q2510c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:27:06 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)) 06:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:27:06 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-CC8lh2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:27:06 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)) 06:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:27:06 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-i2HupM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:27:06 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)) 06:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:27:06 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-vy9Yhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:27:06 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)) 06:27:06 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)) 06:27:06 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)) 06:27:06 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)) 06:27:06 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)) 06:27:06 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)) 06:27:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:27: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 06:27: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 06:27: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 06:27: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 06:27: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 06:27: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 06:27:08 INFO - Downloading blessings-1.6.tar.gz 06:27:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:27:09 INFO - Installing collected packages: blessings 06:27:09 INFO - Running setup.py install for blessings 06:27:09 INFO - Successfully installed blessings 06:27:09 INFO - Cleaning up... 06:27:09 INFO - Return code: 0 06:27:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:27:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:27:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:27:09 INFO - Reading from file tmpfile_stdout 06:27:09 INFO - Current package versions: 06:27:09 INFO - blessings == 1.6 06:27:09 INFO - blobuploader == 1.2.4 06:27:09 INFO - docopt == 0.6.1 06:27:09 INFO - manifestparser == 1.1 06:27:09 INFO - mozInstall == 1.12 06:27:09 INFO - mozcrash == 0.16 06:27:09 INFO - mozdebug == 0.1 06:27:09 INFO - mozdevice == 0.48 06:27:09 INFO - mozfile == 1.2 06:27:09 INFO - mozhttpd == 0.7 06:27:09 INFO - mozinfo == 0.9 06:27:09 INFO - mozleak == 0.1 06:27:09 INFO - mozlog == 3.1 06:27:09 INFO - moznetwork == 0.27 06:27:09 INFO - mozprocess == 0.22 06:27:09 INFO - mozprofile == 0.28 06:27:09 INFO - mozrunner == 6.11 06:27:09 INFO - mozscreenshot == 0.1 06:27:09 INFO - mozsystemmonitor == 0.0 06:27:09 INFO - moztest == 0.7 06:27:09 INFO - mozversion == 1.4 06:27:09 INFO - psutil == 3.1.1 06:27:09 INFO - requests == 1.2.3 06:27:09 INFO - wsgiref == 0.1.2 06:27:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:27: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')]} 06:27:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27: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')]} 06:27:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:09 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 0x1030cca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030d44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc849d181a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f70d30>, '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 0x102d94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f67b20>, '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.HPf9hVXmO8/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.DHC4bRKkjA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/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 06:27:09 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 06:27:09 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 06:27:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HPf9hVXmO8/Render', 06:27:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:27:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:27:09 INFO - 'HOME': '/Users/cltbld', 06:27:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:27:09 INFO - 'LOGNAME': 'cltbld', 06:27:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:09 INFO - 'MOZ_NO_REMOTE': '1', 06:27:09 INFO - 'NO_EM_RESTART': '1', 06:27:09 INFO - 'PAGER': '/bin/cat', 06:27:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:27:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:09 INFO - 'PWD': '/builds/slave/test', 06:27:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:27:09 INFO - 'SHELL': '/bin/bash', 06:27:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DHC4bRKkjA/Listeners', 06:27:09 INFO - 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/', 06:27:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:27:09 INFO - 'USER': 'cltbld', 06:27:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:27:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:27:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:09 INFO - 'XPC_FLAGS': '0x0', 06:27:09 INFO - 'XPC_SERVICE_NAME': '0', 06:27:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:27:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:09 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)) 06:27:09 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)) 06:27:09 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)) 06:27:09 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)) 06:27:09 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)) 06:27:09 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)) 06:27:09 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)) 06:27:09 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)) 06:27:09 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)) 06:27:09 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)) 06:27:09 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)) 06:27:09 INFO - Cleaning up... 06:27:09 INFO - Return code: 0 06:27:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:27: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')]} 06:27:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27: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')]} 06:27:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1030cca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030d44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc849d181a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f70d30>, '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 0x102d94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f67b20>, '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.HPf9hVXmO8/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.DHC4bRKkjA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/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 06:27: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', 'jsonschema'] in /builds/slave/test/build 06:27: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 jsonschema 06:27:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HPf9hVXmO8/Render', 06:27:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:27:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:27:09 INFO - 'HOME': '/Users/cltbld', 06:27:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:27:09 INFO - 'LOGNAME': 'cltbld', 06:27:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:09 INFO - 'MOZ_NO_REMOTE': '1', 06:27:09 INFO - 'NO_EM_RESTART': '1', 06:27:09 INFO - 'PAGER': '/bin/cat', 06:27:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:27:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:09 INFO - 'PWD': '/builds/slave/test', 06:27:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:27:09 INFO - 'SHELL': '/bin/bash', 06:27:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DHC4bRKkjA/Listeners', 06:27:09 INFO - 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/', 06:27:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:27:09 INFO - 'USER': 'cltbld', 06:27:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:27:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:27:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:09 INFO - 'XPC_FLAGS': '0x0', 06:27:09 INFO - 'XPC_SERVICE_NAME': '0', 06:27:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:27:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:10 INFO - Downloading/unpacking jsonschema 06:27:10 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 06:27:10 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 06:27:10 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 06:27:10 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 06:27:10 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 06:27:10 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 06:27:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:27:12 INFO - Downloading/unpacking functools32 (from jsonschema) 06:27: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 06:27: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 06:27: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 06:27: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 06:27: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 06:27: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 06:27:12 INFO - Downloading functools32-3.2.3-2.tar.gz 06:27:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:27:12 INFO - warning: no files found matching '*.txt' 06:27:12 INFO - no previously-included directories found matching 'build' 06:27:12 INFO - no previously-included directories found matching 'dist' 06:27:12 INFO - no previously-included directories found matching '.git*' 06:27:13 INFO - Installing collected packages: jsonschema, functools32 06:27:13 INFO - Running setup.py install for functools32 06:27:13 INFO - warning: no files found matching '*.txt' 06:27:13 INFO - no previously-included directories found matching 'build' 06:27:13 INFO - no previously-included directories found matching 'dist' 06:27:13 INFO - no previously-included directories found matching '.git*' 06:27:13 INFO - Successfully installed jsonschema functools32 06:27:13 INFO - Cleaning up... 06:27:13 INFO - Return code: 0 06:27:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:27: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')]} 06:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27: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')]} 06:27:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:13 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 0x1030cca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030d44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc849d181a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f70d30>, '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 0x102d94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f67b20>, '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.HPf9hVXmO8/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.DHC4bRKkjA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/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 06:27:13 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 06:27:13 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 06:27:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HPf9hVXmO8/Render', 06:27:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:27:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:27:13 INFO - 'HOME': '/Users/cltbld', 06:27:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:27:13 INFO - 'LOGNAME': 'cltbld', 06:27:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:13 INFO - 'MOZ_NO_REMOTE': '1', 06:27:13 INFO - 'NO_EM_RESTART': '1', 06:27:13 INFO - 'PAGER': '/bin/cat', 06:27:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:27:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:13 INFO - 'PWD': '/builds/slave/test', 06:27:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:27:13 INFO - 'SHELL': '/bin/bash', 06:27:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DHC4bRKkjA/Listeners', 06:27:13 INFO - 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/', 06:27:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:27:13 INFO - 'USER': 'cltbld', 06:27:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:27:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:27:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:13 INFO - 'XPC_FLAGS': '0x0', 06:27:13 INFO - 'XPC_SERVICE_NAME': '0', 06:27:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:27:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:13 INFO - Downloading/unpacking flake8 06:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:27:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:27:15 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 06:27:15 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 06:27:15 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 06:27:15 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 06:27:15 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 06:27:15 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 06:27:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:27:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:27:16 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 06:27:16 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 06:27:16 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 06:27:16 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 06:27:16 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 06:27:16 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 06:27:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:27:16 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 06:27:16 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 06:27:16 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 06:27:16 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 06:27:16 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 06:27:16 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 06:27:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:27:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:27:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:27:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:27:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:27:17 INFO - no previously-included directories found matching 'docs/_build' 06:27:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:27:17 INFO - Running setup.py install for pep8 06:27:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:27:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:27:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:27:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:27:17 INFO - no previously-included directories found matching 'docs/_build' 06:27:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:27:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:27:17 INFO - Cleaning up... 06:27:17 INFO - Return code: 0 06:27:17 INFO - Running post-action listener: _resource_record_post_action 06:27:17 INFO - Running post-action listener: _start_resource_monitoring 06:27:17 INFO - Starting resource monitoring. 06:27:17 INFO - ##### 06:27:17 INFO - ##### Running install step. 06:27:17 INFO - ##### 06:27:17 INFO - Running pre-action listener: _resource_record_pre_action 06:27:17 INFO - Running main action method: install 06:27:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:27:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:27:17 INFO - Reading from file tmpfile_stdout 06:27:17 INFO - Detecting whether we're running mozinstall >=1.0... 06:27:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:27:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:27:17 INFO - Reading from file tmpfile_stdout 06:27:17 INFO - Output received: 06:27:17 INFO - Usage: mozinstall [options] installer 06:27:17 INFO - Options: 06:27:17 INFO - -h, --help show this help message and exit 06:27:17 INFO - -d DEST, --destination=DEST 06:27:17 INFO - Directory to install application into. [default: 06:27:17 INFO - "/builds/slave/test"] 06:27:17 INFO - --app=APP Application being installed. [default: firefox] 06:27:17 INFO - mkdir: /builds/slave/test/build/application 06:27:17 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'] 06:27:17 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 06:27:51 INFO - Reading from file tmpfile_stdout 06:27:51 INFO - Output received: 06:27:51 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 06:27:51 INFO - Running post-action listener: _resource_record_post_action 06:27:51 INFO - ##### 06:27:51 INFO - ##### Running run-tests step. 06:27:51 INFO - ##### 06:27:51 INFO - Running pre-action listener: _resource_record_pre_action 06:27:51 INFO - Running main action method: run_tests 06:27:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:27:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:27:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:27:51 INFO - 2016-02-22 06:27:51.398 screenresolution[1668:9539] starting screenresolution argv=screenresolution get 06:27:51 INFO - 2016-02-22 06:27:51.401 screenresolution[1668:9539] Display 0: 1600x1200x32@60 06:27:51 INFO - 2016-02-22 06:27:51.406 screenresolution[1669:9541] starting screenresolution argv=screenresolution list 06:27:51 INFO - Available Modes on Display 0 06:27:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:27:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:27:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:27:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:27:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:27:51 INFO - Intel Iris: 06:27:51 INFO - Chipset Model: Intel Iris 06:27:51 INFO - Type: GPU 06:27:51 INFO - Bus: Built-In 06:27:51 INFO - VRAM (Dynamic, Max): 1536 MB 06:27:51 INFO - Vendor: Intel (0x8086) 06:27:51 INFO - Device ID: 0x0a2e 06:27:51 INFO - Revision ID: 0x0009 06:27:51 INFO - Displays: 06:27:51 INFO - Display: 06:27:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:27:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:27:51 INFO - Display Serial Number: 1600x1200 60 06:27:51 INFO - Main Display: Yes 06:27:51 INFO - Mirror: Off 06:27:51 INFO - Online: Yes 06:27:51 INFO - Rotation: Supported 06:27:51 INFO - Return code: 0 06:27:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:27:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:27:51 INFO - Python 2.7.3 06:27:51 INFO - Return code: 0 06:27:51 INFO - grabbing minidump binary from tooltool 06:27:51 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')]} 06:27:51 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 0x102f70d30>, '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 0x102d94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f67b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:27:51 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 06:27:51 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 06:27:51 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:27:51 INFO - Return code: 0 06:27:51 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:27:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:27:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:27:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:27:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:27:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:27:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:27:53 INFO - Return code: 0 06:27:53 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0194', '--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 06:27:53 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/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0194 --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 06:27:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HPf9hVXmO8/Render', 06:27:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:27:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:27:53 INFO - 'HOME': '/Users/cltbld', 06:27:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:27:53 INFO - 'LOGNAME': 'cltbld', 06:27:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:27:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:27:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:53 INFO - 'MOZ_NO_REMOTE': '1', 06:27:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:27:53 INFO - 'NO_EM_RESTART': '1', 06:27:53 INFO - 'PAGER': '/bin/cat', 06:27:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:27:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:53 INFO - 'PWD': '/builds/slave/test', 06:27:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:27:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:27:53 INFO - 'SHELL': '/bin/bash', 06:27:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DHC4bRKkjA/Listeners', 06:27:53 INFO - 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/', 06:27:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:27:53 INFO - 'USER': 'cltbld', 06:27:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:27:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:27:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:53 INFO - 'XPC_FLAGS': '0x0', 06:27:53 INFO - 'XPC_SERVICE_NAME': '0', 06:27:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:27:53 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0194', '--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 06:27:53 INFO - mozversion application_buildid: 20160222030212 06:27:53 INFO - mozversion application_changeset: e1cf617a1f2813b6cd66f460313a61c223406c9b 06:27:53 INFO - mozversion application_display_name: Nightly 06:27:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:27:53 INFO - mozversion application_name: Firefox 06:27:53 INFO - mozversion application_remotingname: firefox 06:27:53 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:27:53 INFO - mozversion application_vendor: Mozilla 06:27:53 INFO - mozversion application_version: 47.0a1 06:27:53 INFO - mozversion platform_buildid: 20160222030212 06:27:53 INFO - mozversion platform_changeset: e1cf617a1f2813b6cd66f460313a61c223406c9b 06:27:53 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:27:53 INFO - mozversion platform_version: 47.0a1 06:27:53 INFO - using testdate: 1456151273 06:27:53 INFO - actual date: 1456151273 06:27:53 INFO - starting webserver on 'localhost:49279' 06:27:53 INFO - SUITE-START | Running 2 tests 06:27:53 INFO - TEST-START | dromaeo_css 06:27:53 INFO - operating with platform_type : mac_ 06:27:53 INFO - Initialising browser for dromaeo_css test... 06:27:53 INFO - TEST-INFO | started process 1687 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/tmpDLxl2v/profile http://localhost:49279/getInfo.html) 06:27:55 INFO - PROCESS | 1687 | __metrics Screen width/height:1600/1200 06:27:55 INFO - PROCESS | 1687 | colorDepth:24 06:27:55 INFO - PROCESS | 1687 | Browser inner width/height: 1024/689 06:27:55 INFO - PROCESS | 1687 | __metrics 06:27:56 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" 06:27:56 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] 06:27:56 INFO - TEST-INFO | 1687: exit 0 06:27:56 INFO - Browser initialized. 06:27:56 INFO - Running cycle 1/1 for dromaeo_css test... 06:27:56 INFO - TEST-INFO | started process 1691 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/tmpDLxl2v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:28:08 INFO - PROCESS | 1691 | RSS: Main: 244555776 06:28:08 INFO - PROCESS | 1691 | 06:29:00 INFO - PROCESS | 1691 | 1456151340181 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] 06:31:10 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49279/tests/dromaeo/cssquery-ext.html) 06:31:12 INFO - PROCESS | 1691 | RSS: Main: 331014144 06:31:12 INFO - PROCESS | 1691 | 06:34:14 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-ext.html (next: http://localhost:49279/tests/dromaeo/cssquery-jquery.html) 06:34:15 INFO - PROCESS | 1691 | RSS: Main: 381931520 06:34:15 INFO - PROCESS | 1691 | 06:37:17 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49279/tests/dromaeo/cssquery-mootools.html) 06:37:17 INFO - PROCESS | 1691 | RSS: Main: 378056704 06:37:17 INFO - PROCESS | 1691 | 06:40:20 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49279/tests/dromaeo/cssquery-prototype.html) 06:40:20 INFO - PROCESS | 1691 | RSS: Main: 336302080 06:40:20 INFO - PROCESS | 1691 | 06:43:23 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49279/tests/dromaeo/cssquery-yui.html) 06:43:24 INFO - PROCESS | 1691 | RSS: Main: 339025920 06:43:24 INFO - PROCESS | 1691 | 06:46:27 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-yui.html (next: http://localhost:49279/tests/dromaeo/cssquery-dojo.html) 06:46:27 INFO - PROCESS | 1691 | RSS: Main: 385425408 06:46:27 INFO - PROCESS | 1691 | 06:46:27 INFO - PROCESS | 1691 | __start_tp_report 06:46:27 INFO - PROCESS | 1691 | _x_x_mozilla_page_load 06:46:27 INFO - PROCESS | 1691 | _x_x_mozilla_page_load_details 06:46:27 INFO - PROCESS | 1691 | |i|pagename|runs| 06:46:27 INFO - PROCESS | 1691 | |0;dojo.html;3451.982740086299;3469.7224222062227;3471.32309199706;3475.9304813903736;3515.52540407045;5644.125160600103;5712.314522257335;5738.684372359518;5784.6239994400385;5802.970985145073;4941.962187940528;5680.233168522248;5718.685472299022;5775.999999999989;5801.564882633809;5197.454267301936;5277.182036784305;5326.147816349385;5342.1452567589;5368.8389348319615;5313.628046036779;5315.521603055724;5324.201369794523;5327.387350454689;5329.626926115174;5207.713575753332;5227.869303267411;5350.250964864922;5403.243545903557;5405.540529055035;5183.118869792144;5225.790968361261;5252.921206181911;5280.498352656491;5319.946800531984;5215.660982036194;5239.947600524022;5256.395514515803;5265.86835329116;5267.394249661262;5612.298462692163;5642.097264437712;5643.633163844337;5662.150677398423;5740.7703691852275;6079.39206079393;6104.7016930465;6152.415520525543;6225.346338634468;6232.844178895519;6181.443670069671;6226.439620434183;6244.313125556185;6253.530985176085;6262.561620686553;5828.184054232411;5828.708564571754;5858.941410585925;5863.384344643836;5866.413358664142;6178.845528861724;6243.8126856194385;6340.778072767431;6342.207224096988;6349.396807303298;6117.449429551361;6157;6158.353372895871;6166.075088736636;6173.259208894871;6063.363346848606;6192.907106393408;6235.438810506986;6237.220347456568;6275;6121.727351053096;6162.7843025494785;6199.380061993765;6215.378462153839;6229.844253893689;6182.876342473125;6186.969065154645;6203.100550420164;6207.472364848948;6242.812715618538;4124.360724087771;4885.096257192431;4902.926456103161;4917.827876024322;4957.975210123998;4398.494173170063;4438.201123797683;4452.0873220989615;4454.532274111237;4489.842855500042;4765.428148622187;5753.827385178452;5766.567507436959;5774.769009239667;5783.306003279549;5171.741412929414;6169.660668663177;6195.380461953859;6199.659018754011;6221.440070393686;5421.59038649946;5610.691411972381;5813.157092221604;5824.708764561755;5900.822975310747;5400.756965936543;5401.918971215435;5406.270153529302;5407.756650950717;5414.729263536886;6212.565120441525;6245.937540624535;6321.3678632137335;6336.556441049174;6343.682815859189;6273.278572964167;6285.874282514233;6292.559520833681;6295.716692748929;6296.370362963667;5641.746121424464;5976.402359763989;6313.084602732486;6330.493560515056;6351.555391122577;4964.875878102932;6146.862830376394;6188.164597779242;6239.344868788893;6255.280642725963;6253.812385628438;6263.530235232284;6286.339934307015;6289.308176100534;6303.243610766737;5996.850078748066;6098.75604975796;6121.785737499166;6123.9693801532485;6130.938690613215;6047.848803779764;6062.545309101747;6104.06507294887;6110.69446527663;6143.201383820075;5764.250647415809;5929.851753706192;5950.16697662319;5961.672108034099;5963;5902.291724993029;6072.240969878765;6130.938690613037;6143.174139895698;6143.600665956698;5966.910496342645;5978.163057171912;5979.730912109053;5981.730822112929;5998.4601385875485 06:46:27 INFO - PROCESS | 1691 | |1;ext.html;462.4219725343321;477.81365267545664;493.34138924535745;559.8746519495813;582.9358770535243;29803.55294670579;30412.239694007607;30526.694733052664;30564.624591893364;30586.23534411638;30602.387952241;40060.399094013614;40526.18947621046;40647.983800405;40733.79633101838;9466.479343636114;9658.227341812673;9685.273604479693;9688.854667179998;9703.12671859536;9499.335046546745;9650.469224192702;9653.372530785477;9668.75828104296;9699.127078562928;9608.519574021306;9683.176929960962;9699.030096990315;9709.805803883954;9714.222862171046;9578.61685532578;9632.181264592518;9692.321537492413;9699.563519641633;9705.61177552897;8245.216704413071;9577.712668619952;9711.90288097117;9717.271204659608;9720.659776907774;40007.39988900169;40549.79725101356;40589.39115913264;40658.593414066076;40721;3220.22714548509;3343.0973637118086;3429.1255729788745;3622.800745958971;3808.0860593457646;28397.29502110464;29079.709202908125;29178.854105729548;29626.70373296261;29801.25496862574;2557.526857531344;2586.456844062749;2819.746222839954;2883.6972117927526;2915.8687859046395;424570;424718;428937;429312;429770;45764.08471830545;46154.46146462379;65107.34892651013;65516.67241663857;65634.67182664057;45237.54762452399;45443.86390340268;45479.772601136785;45528.3170752439;45541.31688024682;15492.380304787908;15698.058116513046;15702.685946281239;15709.685806283811;15735.977161484467;12055.457504412323;12140.271583704829;12306.81539776904;12353.258804471761;12410.689732756753;14549.418023279162;14562.053466524641;14579.635509112144;14590.688685699379;14670.559883203521;5395.325584301962;6217.378262173746;6261.968690156611;6263.154474145932;6270.372962703693;884.478157886837;950.5959967013991;970.6699722094522;1100.9210973246104;1153.224034986112;29740.55389169164;29890;30832.075037748902;31036.379272414426;31452.05643830689;873.0178549132227;960.644561512231;1044.8484969679505;1074.3231763988638;1104.812181929074;14275;14391.64020899465;14489.695927366376;14664;14678.85321146775;666908;670837;672818;673763;675067;57862.4213757857;59867.70066149641;59874;59898.40101599015;60100.39899600948;1298.0978220136915;1323.5963031275553;1412.173878281217;1416.0795482936173;1442.9567112986626;29026.27434314159;31201;31269.061928141284;31294.530582040832;31983.840080799448;53816.461835381146;53931.73034134804;54734.72632636971;54740.45259547513;54742.45257547373;519935;546864;547375.2631236819;548837;550353;40966.590334096276;41680.1663966725;42612.57387426086;42683.57316426796;42776.14447711091;43341.783291083346;44176.33735493906;44656.553434466536;44979.77510112429;45326;36142;36858.078548036516;37702.66419361699;37931.43102853404;38848.805755971036;37216.44175337426;37589.624103758615;38453.461861525226;38765.806170968965;38819;30469.54295685611;35757.64242357543;36564;36759.81620091989;36903;24282.75717242805;30147;31749;32400.86596969095;32571.837140814143;23133.768662313836;24845;25011.499770004863;25072.37319067038;25395.74604254008 06:46:27 INFO - PROCESS | 1691 | |2;jquery.html;363.09951320724605;368.193655893593;369.58606360875825;370.3574298591943;374.7770076804304;15446.382144714198;16074.357025718986;17337.22604383299;19616.509587260327;20294.6955795663;15506.922465387686;19700.802991970075;20318.796812031876;20550.38348849537;20633.793662063374;5643.830685079454;5684.801031963882;5794.68129252891;5838.883222335572;5917.970410147965;3162.5098109792903;4108.096218831853;4321.827126914935;4897.926531102036;5854.385289544601;3649.959761467982;4289.313709806432;5086.593072554187;6347.206599175103;6366.076918846765;5196.428392876781;6260.937390626081;6325.146105275798;6327.651979141122;6328.11406403104;5554.833354999357;5580.888382232332;5585.692786896719;5587.9941610510095;5588.6646801192055;11151;12698.936505317415;12805.20727098207;13189.472421103144;25222.621660675104;1855.3320804510365;2023.1806118522022;2229.230915334207;2272.659101134843;2323.697919270484;7822.726204582812;9865.260105492116;10041.397516149054;13052.934735326262;13351.130841682172;1738.7478815571799;1792.82071792821;1816.1191821966336;1817.0823734014239;1821.435355039942;79039.50287623053;88255.11744882597;109052.4547377266;109835.45082274538;110980;8595.78510537229;11143.16426268017;11195.048420884154;11219.485369475016;11332.886671133349;12105.152639315163;12513.936315413292;12870.970322374187;13628.591142265748;13633.795493067611;6474.741010359627;6627;7950.880736788953;8409.53747543891;8479.830403391898;7365;8141.674333026613;8545.487270763773;8573.4427262229;8646.481211127226;4370.8033138508845;4407.4050003249795;4407.537208593051;4409.404730361424;4447.644188464915;1807.367421402525;1870.3360307090786;1890.2722451856134;1892.9526761831064;1908.1031914999928;405.4769347541697;875.6803766625136;899.2985471332371;978.1978777402604;1009.9040591143829;9535.761605959906;11536.365499897585;11726.296422214524;11744.58893938708;11853.170278080452;441.078146673454;447.7045150200852;450.4954451014819;454.2096751652102;468.82887745972477;5078.4413714491375;5639.3232812062;5853.707314634251;6288.654124023131;6296.212973378328;531888;606796;625520;627078;666501;92516.53741731249;119424.40287798505;119930;125754;127436;439.6175327465126;447.30220855464927;448.5581702023504;448.8518788799688;449.3910750932505;11064.889351106385;11401.942990284995;11655.892690194418;11685.824712629488;11703.356315402734;51534.22698659448;53199.73400132974;53552.732236340125;53879.461205387444;54991;71583.64208178926;73048.63475682588;73093.634531827;73193.26806731864;73564;7881.13307536182;8132.634031468717;8206.425550211428;8237.79405514867;8367.246947774485;11122.277051991594;13475.46098156102;13635.250061246727;13774.966877484429;13785.793213101611;11687.240329378903;11738.58914937973;11801.347641627153;11907.46416411281;11963.162578619762;11497.195196336175;11542.307461552333;11678.766424671629;11834.76330473403;11839.82240266414;11801.881981180079;11971.521139154336;11988.340641264815;12011.75976480448;12034.157608967638;7995.200479951958;8116.83766324682;8162.142974987541;8175;8218;9277.768055798659;11558.826617600911;11616.94191529037;11642.41787910618;11670.474828632901 06:46:27 INFO - PROCESS | 1691 | |3;mootools.html;1395.2814300635168;1515.8559936806;1553.495114087921;1779.2082523277138;1930.1893204853952;6739.35976082272;8517;8688.73933781986;8703.65185392585;8705.434146780455;8424.578771061453;8654.134586541342;8659.653613855455;8664.653413863454;8670.306375489961;2157.9892100539473;2225.877576733279;2226.597243736444;2444.27893771337;2469.962950555743;2432.4526981429212;2500.2874180858457;2501.062101711858;2504.4239824840297;2505.7368976257503;2403.098837935774;2426.320630223531;2455.582550966331;2466.3464181991785;2468.90124395024;2149.6882951972034;2208.514126892081;2210.425289424761;2457.496213276274;2470.036685692581;2194.4513871532117;2393.7606239375923;2454.2882564056404;2459.6802415685847;2459.987700061506;8548.444351117158;8608.139186081404;8623.956880215621;8635.222829945335;8636.309095272363;5239.423663397023;5378.058839703036;5381.919271210935;5403.675779453245;5406.54044406226;3618.6019537850816;3642.3079614873354;3678.742488025839;3725.068732816796;3735.8879233623034;936.2509992006368;1085.4952447112053;1087.7117563845586;1098.231238133302;1106.4523061084733;11828.349440780754;11908.464119114575;11918.22531535456;11921.10591705617;11929.045676345959;4763.95236047642;4835.468098509161;4936.950630493721;4952.4057113146655;4978.925316120189;10140.492975351202;10140.898591014144;10142.797144057078;10148.746281343025;10162.4918754062;4998.650094493423;5077.492250774893;5501.449855014546;5502.5597952163735;5504.119340905436;4404.163208990281;4537.047220083819;4771.856844294607;4940.2342636891335;4990.700557966534;3935.960640393617;3936.1143742657673;3955.7626542407547;3988.0428697112484;4015.77913214776;1315.0991570774052;1318.7164759576738;1321.1346567997978;1327;1330.5542643214437;1148.17905197784;1159.310210424796;1213.3811756004502;1234.7839128152536;1363.12078709232;8111.3916456266015;8129.4715843469985;8160.265576098061;8192.83614327722;8196.385271104691;493.28227429091305;508.3213909430951;511.59583928696657;514.069534143202;514.1182871375609;6155.96922015396;6198.752049918043;6231.626102433778;6234.625922444668;6236.594621349598;10349.965003499741;10682.252242343116;10728.356298622108;10813.567457301777;10843.78312433747;10445.164386849034;10532.526036328383;10674.733131671615;10685.145188384911;10706.625268115578;8266.462679925786;8341.915550978456;8355.749327520183;8358.414910956297;8366.832663346699;7804.921950780419;7860.724874629361;7863.252990965849;7881.763547093597;7924.6037698116015;9461.479618621042;9466.242700584075;9571.042895710374;9626.181774548962;9689.660861870083;8407.70573029941;9524.85712714296;9657.46883921391;9838.36050656705;9870.703878883645;6807.421369183675;6862.656867156522;7223.747168849065;7296.671649775879;7339.669714862737;8142.3486121111355;8251.463654862415;8253.669853206045;8267.214614611603;8290;7224.277572242734;7339.229380914927;7342.9632851835395;7475.88786168197;7490.213527579744;7149.657320872274;7239.746608868664;7292.781216563511;7355.190928997913;7364.96317518409;7645.617719114133;7664.578448185403;7701.152873183833;7725.034370703662;7735.265149810759;6770.830729231809;6952.44380449573;7023.438124950094;7034.085568876013;7035.1909530404655;6289.7484100635465;6682.3317668232785;6966.373026427443;7030.402415794715;7031.332023457763 06:46:27 INFO - PROCESS | 1691 | |4;prototype.html;315.5456143153858;324.5407748036528;326.5575145677607;328.04048159134527;331.5606820962226;5222.268882356473;6466.321036291192;6540.084388185658;6545.509086818496;6566.3105373935705;6157.568970172089;6317.905231421532;6394.520410969173;6410.839729006777;6493.935060649392;4843.975780121094;4844.951550484503;4850.563449289563;4860.902781944359;4895.853124406273;4590.472095708986;4868.123737727207;4869.050535145648;4870.586000189988;4871.951280487186;3944.909198124984;4558.49856515783;4655.7672116394215;4676.3920690310215;4679.227927391977;4782.282657601353;4784.067106914154;4784.976075119602;4789.952100479003;4800.87997800056;3356.7818091824197;3534.929301413957;3960.029792700807;4106.1992911382295;4109.0549173690215;6229.87540249197;6295.2760432550385;6296.464800491918;6329.398707122816;6340.619562826245;5064.873378165538;5218.13900706383;5636.605437619368;5655.794240246307;5659.660420374791;6567.244766851778;6795.082663840368;6806.6256355900405;6807.829804254884;6956.304369563054;4602.516735742733;4609.562091601292;4611.377464042345;4611.884702882421;4612.238980568202;7253.347198752085;7362.521436106689;7368.926310736932;7369.77890663281;7371.963140184264;4740.478547359788;4753.9762301188275;4759.881002974953;4760.262159365304;4765.332853400458;4806.687565308243;4819.759012049453;4827.179379505493;4834.009028149221;4836.758162091881;5407.513323800798;5609.80365687199;5618.578606604521;5642.125470552071;5660.745266463019;6802.795916122524;6960.756373526902;7007.299270072952;7037.366637002592;7044.189918159374;1419.3683810704138;1694.2714632708055;1695.4405046334928;1696.5334533003522;1697.109017765658;1031.9432431216205;1090.8581884354983;1107.5846557540922;1115.2583531951161;1127.1321082766224;6436;6538.444232240217;6551.901721474182;6570.080188773575;6577;7203.819904502325;7209.0628218331285;7215;7215.989761433403;7219.314165154302;5248.711320877312;6517.771877984248;6529.673516324165;6533.314002029719;6535.5425120241125;3690.1697118148204;3733.178700685845;3793.899769066995;3797.050737315671;3802.6197380262306;7578.924210757822;7599.962000189964;7608.391328693691;7610.847783044308;7637.5035622684345;7506.474546781673;7534.434917381218;7555.848883022309;7556.282153195438;7558.281963213486;7582.279683430175;7606.885896711665;7615.466917315845;7616.885746713804;7618.009658744328;6067.756109997528;7036.190838053484;7137.10786151731;7302.306280903305;7332.78001659951;6410.743570257137;6616.966915165393;6650.87645659694;7140.107486564179;7207.423406127602;6743.1908171019795;7619.390448763975;7634.923650763421;7638.121616014229;7647.502912310682;3639.4358874374516;4444.82220711168;4567.748773817472;4614.284785858197;4616.422947131608;6918.584884906922;7251.56490610565;7263.709451621876;7267.418606511361;7273.3453989141235;7009.12385951756;7015.36861682451;7040.260772619006;7045.295470452914;7049.471289653194;5635.605507614591;5972.372900845522;6736.854734695015;6994.090768200102;7020.824479388056;5530.474604912527;6815.727370905108;6839.247682754993;6848.315168483112;6853.00631408453;6680.231773346128;6746.797596072126;7016.052832867497;7045.542039767399;7045.964770176116;5760.020796464527;6416.679166041586;6638.070670106285;6744.426723728538;6773.832373640388 06:46:27 INFO - PROCESS | 1691 | |5;yui.html;683.4873844616537;694.7012784502664;715.6636380900976;721.6319676964746;756.8259300360917;14661.70676586469;14861.702765944674;14870.03344782591;14873.553793386202;14918.17950012749;13122.737545249112;13629.931850340734;13643.795343069862;13670.179789212654;13684.315784210774;691.8374182067223;842.7471758472434;876.7238319929202;876.7676565710092;877.7805548612847;863.1411745313422;871.9694810681627;880.106691707917;880.1682410122437;880.7974165941837;740.9110906691204;752.9096508418997;935.0789472369711;936.8173206224789;940.0035961880394;752.8268498245407;907.2605826251616;927.4574373991223;931.0968360690119;931.7950050988771;684.5995092870677;685.1606781692436;685.694865784726;686.3308274432438;690.0890824112174;14451.638709032253;14586.905982051388;14591.635209119751;14592.416303347853;14624.707505849823;10480.63317783874;12559.874401256053;12571.559995400117;12696.428660710199;13074.477020919247;9126.863097053549;10173.79652406955;10205.64280250195;10268.28122031458;10538.367697938149;3571.196480791801;3572.464130380438;3588.6052534221217;3600.135967367839;3631.4915911772373;81713.59143204246;81976;81985;82060;82490.17509824884;9308.069193080637;9324.160825525736;9475;9605.519724013911;10181.440020798778;21547.67678484824;21656;21668.24161154352;21689.34931952044;21732.674009889863;7285.125784905846;7371.11546614399;7516.436267279976;7534.510256833289;7684.731034413769;3543.787372757643;3574.588922273972;3703.629637036329;3711.31340701971;3965.325894597925;3376.274101068233;3476.3047390521997;3478.669526394988;3486.89539313821;3548.1307079765625;546.9288992430959;644.859998807656;650.8763334966342;651.5406638319973;661.7022339947043;554.8307766131288;559.2115117684046;574.5059249045818;578.8552861784553;604.9727762250709;7943.443958922935;8515.446495977742;9075.092490751003;9248.16766491019;9253.537323133816;565.9886802263932;599.6881621556767;634.552640388525;637.101686621861;651.7686221391433;3403.5575375201065;3728.7017038636845;3863.3818589025623;4040.676745860324;4070.00284930194;91404.54297728602;95659;97740.51129744305;97839;97934.51032744933;82617.17382826215;82781.17218827855;83017;83153;84167.73748393779;69870;69878.3012169882;70838.2916170842;71142;73091.26908730951;7975.72084977023;8036.799080023046;8234.752957411287;8276.213759692819;8348.123447038217;42759.50341738024;45242.773786130856;47129.293060603435;47171.58485245448;48777.75611121922;54909.90180196294;59523;61746.530138795744;70034.64982675054;70593;9958.701238962843;9985.850212246676;10212.183025357805;10231.181505479395;10558.155347572023;10617.628383006559;10623.681289561326;10626;10631.468426578795;10658.467076645982;10322.741931451774;10370.22223333268;10370.637027703995;10387.584496620051;10417.16662667;10242.283040187116;10372.58509659605;10424;10430.956904309509;10431.165506759593;8406.201410865959;10180;10208.387496750218;10300.845487317547;10415.68752937413;8753.037165911617;8970.461772293684;9089.681861134828;9120.407173533698;9171.235986449212;8747.825043499222;8979.506127162807;9021.052789457013;9135.817283654156;9228.170413613216 06:46:27 INFO - PROCESS | 1691 | __end_tp_report 06:46:27 INFO - PROCESS | 1691 | __start_cc_report 06:46:27 INFO - PROCESS | 1691 | _x_x_mozilla_cycle_collect,1104 06:46:27 INFO - PROCESS | 1691 | __end_cc_report 06:46:27 INFO - PROCESS | 1691 | __startTimestamp1456152387480__endTimestamp 06:46:27 INFO - PROCESS | 1691 | 06:46:27 INFO - PROCESS | 1691 | ------- Summary: start ------- 06:46:27 INFO - PROCESS | 1691 | Number of tests: 6 06:46:27 INFO - PROCESS | 1691 | 06:46:27 INFO - PROCESS | 1691 | [#0] dojo.html Cycles:165 Average:5732.38 Median:5961.67 stddev:630.60 (10.6%) stddev-sans-first:606.63 06:46:27 INFO - PROCESS | 1691 | Values: 3452.0 3469.7 3471.3 3475.9 3515.5 5644.1 5712.3 5738.7 5784.6 5803.0 4942.0 5680.2 5718.7 5776.0 5801.6 5197.5 5277.2 5326.1 5342.1 5368.8 5313.6 5315.5 5324.2 5327.4 5329.6 5207.7 5227.9 5350.3 5403.2 5405.5 5183.1 5225.8 5252.9 5280.5 5319.9 5215.7 5239.9 5256.4 5265.9 5267.4 5612.3 5642.1 5643.6 5662.2 5740.8 6079.4 6104.7 6152.4 6225.3 6232.8 6181.4 6226.4 6244.3 6253.5 6262.6 5828.2 5828.7 5858.9 5863.4 5866.4 6178.8 6243.8 6340.8 6342.2 6349.4 6117.4 6157.0 6158.4 6166.1 6173.3 6063.4 6192.9 6235.4 6237.2 6275.0 6121.7 6162.8 6199.4 6215.4 6229.8 6182.9 6187.0 6203.1 6207.5 6242.8 4124.4 4885.1 4902.9 4917.8 4958.0 4398.5 4438.2 4452.1 4454.5 4489.8 4765.4 5753.8 5766.6 5774.8 5783.3 5171.7 6169.7 6195.4 6199.7 6221.4 5421.6 5610.7 5813.2 5824.7 5900.8 5400.8 5401.9 5406.3 5407.8 5414.7 6212.6 6245.9 6321.4 6336.6 6343.7 6273.3 6285.9 6292.6 6295.7 6296.4 5641.7 5976.4 6313.1 6330.5 6351.6 4964.9 6146.9 6188.2 6239.3 6255.3 6253.8 6263.5 6286.3 6289.3 6303.2 5996.9 6098.8 6121.8 6124.0 6130.9 6047.8 6062.5 6104.1 6110.7 6143.2 5764.3 5929.9 5950.2 5961.7 5963.0 5902.3 6072.2 6130.9 6143.2 6143.6 5966.9 5978.2 5979.7 5981.7 5998.5 06:46:27 INFO - PROCESS | 1691 | 06:46:27 INFO - PROCESS | 1691 | [#1] ext.html Cycles:180 Average:67581.88 Median:40618.69 stddev:148915.91 (366.6%) stddev-sans-first:149248.39 06:46:27 INFO - PROCESS | 1691 | Values: 462.4 477.8 493.3 559.9 582.9 29803.6 30412.2 30526.7 30564.6 30586.2 30602.4 40060.4 40526.2 40648.0 40733.8 9466.5 9658.2 9685.3 9688.9 9703.1 9499.3 9650.5 9653.4 9668.8 9699.1 9608.5 9683.2 9699.0 9709.8 9714.2 9578.6 9632.2 9692.3 9699.6 9705.6 8245.2 9577.7 9711.9 9717.3 9720.7 40007.4 40549.8 40589.4 40658.6 40721.0 3220.2 3343.1 3429.1 3622.8 3808.1 28397.3 29079.7 29178.9 29626.7 29801.3 2557.5 2586.5 2819.7 2883.7 2915.9 424570.0 424718.0 428937.0 429312.0 429770.0 45764.1 46154.5 65107.3 65516.7 65634.7 45237.5 45443.9 45479.8 45528.3 45541.3 15492.4 15698.1 15702.7 15709.7 15736.0 12055.5 12140.3 12306.8 12353.3 12410.7 14549.4 14562.1 14579.6 14590.7 14670.6 5395.3 6217.4 6262.0 6263.2 6270.4 884.5 950.6 970.7 1100.9 1153.2 29740.6 29890.0 30832.1 31036.4 31452.1 873.0 960.6 1044.8 1074.3 1104.8 14275.0 14391.6 14489.7 14664.0 14678.9 666908.0 670837.0 672818.0 673763.0 675067.0 57862.4 59867.7 59874.0 59898.4 60100.4 1298.1 1323.6 1412.2 1416.1 1443.0 29026.3 31201.0 31269.1 31294.5 31983.8 53816.5 53931.7 54734.7 54740.5 54742.5 519935.0 546864.0 547375.3 548837.0 550353.0 40966.6 41680.2 42612.6 42683.6 42776.1 43341.8 44176.3 44656.6 44979.8 45326.0 36142.0 36858.1 37702.7 37931.4 38848.8 37216.4 37589.6 38453.5 38765.8 38819.0 30469.5 35757.6 36564.0 36759.8 36903.0 24282.8 30147.0 31749.0 32400.9 32571.8 23133.8 24845.0 25011.5 25072.4 25395.7 06:46:27 INFO - PROCESS | 1691 | 06:46:27 INFO - PROCESS | 1691 | [#2] jquery.html Cycles:180 Average:33356.16 Median:2256.79 stddev:101772.65 (4509.6%) stddev-sans-first:102028.00 06:46:27 INFO - PROCESS | 1691 | Values: 363.1 368.2 369.6 370.4 374.8 15446.4 16074.4 17337.2 19616.5 20294.7 15506.9 19700.8 20318.8 20550.4 20633.8 5643.8 5684.8 5794.7 5838.9 5918.0 3162.5 4108.1 4321.8 4897.9 5854.4 3650.0 4289.3 5086.6 6347.2 6366.1 5196.4 6260.9 6325.1 6327.7 6328.1 5554.8 5580.9 5585.7 5588.0 5588.7 11151.0 12698.9 12805.2 13189.5 25222.6 1855.3 2023.2 2229.2 2272.7 2323.7 7822.7 9865.3 10041.4 13052.9 13351.1 1738.7 1792.8 1816.1 1817.1 1821.4 79039.5 88255.1 109052.5 109835.5 110980.0 8595.8 11143.2 11195.0 11219.5 11332.9 12105.2 12513.9 12871.0 13628.6 13633.8 6474.7 6627.0 7950.9 8409.5 8479.8 7365.0 8141.7 8545.5 8573.4 8646.5 4370.8 4407.4 4407.5 4409.4 4447.6 1807.4 1870.3 1890.3 1893.0 1908.1 405.5 875.7 899.3 978.2 1009.9 9535.8 11536.4 11726.3 11744.6 11853.2 441.1 447.7 450.5 454.2 468.8 5078.4 5639.3 5853.7 6288.7 6296.2 531888.0 606796.0 625520.0 627078.0 666501.0 92516.5 119424.4 119930.0 125754.0 127436.0 439.6 447.3 448.6 448.9 449.4 11064.9 11401.9 11655.9 11685.8 11703.4 51534.2 53199.7 53552.7 53879.5 54991.0 71583.6 73048.6 73093.6 73193.3 73564.0 7881.1 8132.6 8206.4 8237.8 8367.2 11122.3 13475.5 13635.3 13775.0 13785.8 11687.2 11738.6 11801.3 11907.5 11963.2 11497.2 11542.3 11678.8 11834.8 11839.8 11801.9 11971.5 11988.3 12011.8 12034.2 7995.2 8116.8 8162.1 8175.0 8218.0 9277.8 11558.8 11616.9 11642.4 11670.5 06:46:27 INFO - PROCESS | 1691 | 06:46:27 INFO - PROCESS | 1691 | [#3] mootools.html Cycles:180 Average:5986.73 Median:2876.77 stddev:3191.75 (110.9%) stddev-sans-first:3182.04 06:46:27 INFO - PROCESS | 1691 | Values: 1395.3 1515.9 1553.5 1779.2 1930.2 6739.4 8517.0 8688.7 8703.7 8705.4 8424.6 8654.1 8659.7 8664.7 8670.3 2158.0 2225.9 2226.6 2444.3 2470.0 2432.5 2500.3 2501.1 2504.4 2505.7 2403.1 2426.3 2455.6 2466.3 2468.9 2149.7 2208.5 2210.4 2457.5 2470.0 2194.5 2393.8 2454.3 2459.7 2460.0 8548.4 8608.1 8624.0 8635.2 8636.3 5239.4 5378.1 5381.9 5403.7 5406.5 3618.6 3642.3 3678.7 3725.1 3735.9 936.3 1085.5 1087.7 1098.2 1106.5 11828.3 11908.5 11918.2 11921.1 11929.0 4764.0 4835.5 4937.0 4952.4 4978.9 10140.5 10140.9 10142.8 10148.7 10162.5 4998.7 5077.5 5501.4 5502.6 5504.1 4404.2 4537.0 4771.9 4940.2 4990.7 3936.0 3936.1 3955.8 3988.0 4015.8 1315.1 1318.7 1321.1 1327.0 1330.6 1148.2 1159.3 1213.4 1234.8 1363.1 8111.4 8129.5 8160.3 8192.8 8196.4 493.3 508.3 511.6 514.1 514.1 6156.0 6198.8 6231.6 6234.6 6236.6 10350.0 10682.3 10728.4 10813.6 10843.8 10445.2 10532.5 10674.7 10685.1 10706.6 8266.5 8341.9 8355.7 8358.4 8366.8 7804.9 7860.7 7863.3 7881.8 7924.6 9461.5 9466.2 9571.0 9626.2 9689.7 8407.7 9524.9 9657.5 9838.4 9870.7 6807.4 6862.7 7223.7 7296.7 7339.7 8142.3 8251.5 8253.7 8267.2 8290.0 7224.3 7339.2 7343.0 7475.9 7490.2 7149.7 7239.7 7292.8 7355.2 7365.0 7645.6 7664.6 7701.2 7725.0 7735.3 6770.8 6952.4 7023.4 7034.1 7035.2 6289.7 6682.3 6966.4 7030.4 7031.3 06:46:27 INFO - PROCESS | 1691 | 06:46:27 INFO - PROCESS | 1691 | [#4] prototype.html Cycles:180 Average:5663.66 Median:6410.79 stddev:1818.87 (28.4%) stddev-sans-first:1779.12 06:46:27 INFO - PROCESS | 1691 | Values: 315.5 324.5 326.6 328.0 331.6 5222.3 6466.3 6540.1 6545.5 6566.3 6157.6 6317.9 6394.5 6410.8 6493.9 4844.0 4845.0 4850.6 4860.9 4895.9 4590.5 4868.1 4869.1 4870.6 4872.0 3944.9 4558.5 4655.8 4676.4 4679.2 4782.3 4784.1 4785.0 4790.0 4800.9 3356.8 3534.9 3960.0 4106.2 4109.1 6229.9 6295.3 6296.5 6329.4 6340.6 5064.9 5218.1 5636.6 5655.8 5659.7 6567.2 6795.1 6806.6 6807.8 6956.3 4602.5 4609.6 4611.4 4611.9 4612.2 7253.3 7362.5 7368.9 7369.8 7372.0 4740.5 4754.0 4759.9 4760.3 4765.3 4806.7 4819.8 4827.2 4834.0 4836.8 5407.5 5609.8 5618.6 5642.1 5660.7 6802.8 6960.8 7007.3 7037.4 7044.2 1419.4 1694.3 1695.4 1696.5 1697.1 1031.9 1090.9 1107.6 1115.3 1127.1 6436.0 6538.4 6551.9 6570.1 6577.0 7203.8 7209.1 7215.0 7216.0 7219.3 5248.7 6517.8 6529.7 6533.3 6535.5 3690.2 3733.2 3793.9 3797.1 3802.6 7578.9 7600.0 7608.4 7610.8 7637.5 7506.5 7534.4 7555.8 7556.3 7558.3 7582.3 7606.9 7615.5 7616.9 7618.0 6067.8 7036.2 7137.1 7302.3 7332.8 6410.7 6617.0 6650.9 7140.1 7207.4 6743.2 7619.4 7634.9 7638.1 7647.5 3639.4 4444.8 4567.7 4614.3 4616.4 6918.6 7251.6 7263.7 7267.4 7273.3 7009.1 7015.4 7040.3 7045.3 7049.5 5635.6 5972.4 6736.9 6994.1 7020.8 5530.5 6815.7 6839.2 6848.3 6853.0 6680.2 6746.8 7016.1 7045.5 7046.0 5760.0 6416.7 6638.1 6744.4 6773.8 06:46:27 INFO - PROCESS | 1691 | 06:46:27 INFO - PROCESS | 1691 | [#5] yui.html Cycles:180 Average:18156.49 Median:647.87 stddev:26231.70 (4048.9%) stddev-sans-first:26272.48 06:46:27 INFO - PROCESS | 1691 | Values: 683.5 694.7 715.7 721.6 756.8 14661.7 14861.7 14870.0 14873.6 14918.2 13122.7 13629.9 13643.8 13670.2 13684.3 691.8 842.7 876.7 876.8 877.8 863.1 872.0 880.1 880.2 880.8 740.9 752.9 935.1 936.8 940.0 752.8 907.3 927.5 931.1 931.8 684.6 685.2 685.7 686.3 690.1 14451.6 14586.9 14591.6 14592.4 14624.7 10480.6 12559.9 12571.6 12696.4 13074.5 9126.9 10173.8 10205.6 10268.3 10538.4 3571.2 3572.5 3588.6 3600.1 3631.5 81713.6 81976.0 81985.0 82060.0 82490.2 9308.1 9324.2 9475.0 9605.5 10181.4 21547.7 21656.0 21668.2 21689.3 21732.7 7285.1 7371.1 7516.4 7534.5 7684.7 3543.8 3574.6 3703.6 3711.3 3965.3 3376.3 3476.3 3478.7 3486.9 3548.1 546.9 644.9 650.9 651.5 661.7 554.8 559.2 574.5 578.9 605.0 7943.4 8515.4 9075.1 9248.2 9253.5 566.0 599.7 634.6 637.1 651.8 3403.6 3728.7 3863.4 4040.7 4070.0 91404.5 95659.0 97740.5 97839.0 97934.5 82617.2 82781.2 83017.0 83153.0 84167.7 69870.0 69878.3 70838.3 71142.0 73091.3 7975.7 8036.8 8234.8 8276.2 8348.1 42759.5 45242.8 47129.3 47171.6 48777.8 54909.9 59523.0 61746.5 70034.6 70593.0 9958.7 9985.9 10212.2 10231.2 10558.2 10617.6 10623.7 10626.0 10631.5 10658.5 10322.7 10370.2 10370.6 10387.6 10417.2 10242.3 10372.6 10424.0 10431.0 10431.2 8406.2 10180.0 10208.4 10300.8 10415.7 8753.0 8970.5 9089.7 9120.4 9171.2 8747.8 8979.5 9021.1 9135.8 9228.2 06:46:27 INFO - PROCESS | 1691 | -------- Summary: end -------- 06:46:27 INFO - PROCESS | 1691 | 06:46:27 INFO - TEST-INFO | 1691: exit 0 06:46:27 INFO - TEST-OK | dromaeo_css | took 1114402ms 06:46:27 INFO - TEST-START | kraken 06:46:27 INFO - operating with platform_type : mac_ 06:46:27 INFO - Initialising browser for kraken test... 06:46:27 INFO - TEST-INFO | started process 1698 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/tmph6npPD/profile http://localhost:49279/getInfo.html) 06:46:30 INFO - PROCESS | 1698 | __metrics Screen width/height:1600/1200 06:46:30 INFO - PROCESS | 1698 | colorDepth:24 06:46:30 INFO - PROCESS | 1698 | Browser inner width/height: 1024/689 06:46:30 INFO - PROCESS | 1698 | __metrics 06:46:30 INFO - PROCESS | 1698 | 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" 06:46:30 INFO - PROCESS | 1698 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:46:30 INFO - TEST-INFO | 1698: exit 0 06:46:30 INFO - Browser initialized. 06:46:30 INFO - Running cycle 1/1 for kraken test... 06:46:30 INFO - TEST-INFO | started process 1701 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/tmph6npPD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:46:42 INFO - PROCESS | 1701 | RSS: Main: 244621312 06:46:42 INFO - PROCESS | 1701 | 06:46:45 INFO - PROCESS | 1701 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection) 06:46:45 INFO - PROCESS | 1701 | RSS: Main: 290439168 06:46:45 INFO - PROCESS | 1701 | 06:46:48 INFO - PROCESS | 1701 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-dft) 06:46:49 INFO - PROCESS | 1701 | RSS: Main: 302317568 06:46:49 INFO - PROCESS | 1701 | 06:46:52 INFO - PROCESS | 1701 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-fft) 06:46:52 INFO - PROCESS | 1701 | RSS: Main: 285179904 06:46:52 INFO - PROCESS | 1701 | 06:46:54 INFO - PROCESS | 1701 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator) 06:46:55 INFO - PROCESS | 1701 | RSS: Main: 287137792 06:46:55 INFO - PROCESS | 1701 | 06:46:57 INFO - PROCESS | 1701 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:46:58 INFO - PROCESS | 1701 | RSS: Main: 288239616 06:46:58 INFO - PROCESS | 1701 | 06:47:00 INFO - PROCESS | 1701 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom) 06:47:01 INFO - PROCESS | 1701 | RSS: Main: 289771520 06:47:01 INFO - PROCESS | 1701 | 06:47:04 INFO - PROCESS | 1701 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate) 06:47:04 INFO - PROCESS | 1701 | RSS: Main: 288636928 06:47:04 INFO - PROCESS | 1701 | 06:47:07 INFO - PROCESS | 1701 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial) 06:47:08 INFO - PROCESS | 1701 | RSS: Main: 290549760 06:47:08 INFO - PROCESS | 1701 | 06:47:09 INFO - PROCESS | 1701 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:47:10 INFO - PROCESS | 1701 | RSS: Main: 325836800 06:47:10 INFO - PROCESS | 1701 | 06:47:12 INFO - PROCESS | 1701 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:47:12 INFO - PROCESS | 1701 | RSS: Main: 323567616 06:47:12 INFO - PROCESS | 1701 | 06:47:14 INFO - PROCESS | 1701 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:47:15 INFO - PROCESS | 1701 | RSS: Main: 332509184 06:47:15 INFO - PROCESS | 1701 | 06:47:18 INFO - PROCESS | 1701 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:47:18 INFO - PROCESS | 1701 | RSS: Main: 333889536 06:47:18 INFO - PROCESS | 1701 | 06:47:21 INFO - PROCESS | 1701 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:47:21 INFO - PROCESS | 1701 | RSS: Main: 333414400 06:47:21 INFO - PROCESS | 1701 | 06:47:23 INFO - PROCESS | 1701 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49279/tests/kraken/driver.html?testName=ai-astar) 06:47:23 INFO - PROCESS | 1701 | RSS: Main: 394129408 06:47:23 INFO - PROCESS | 1701 | 06:47:23 INFO - PROCESS | 1701 | __start_tp_report 06:47:23 INFO - PROCESS | 1701 | _x_x_mozilla_page_load 06:47:23 INFO - PROCESS | 1701 | _x_x_mozilla_page_load_details 06:47:23 INFO - PROCESS | 1701 | |i|pagename|runs| 06:47:23 INFO - PROCESS | 1701 | |0;ai-astar;152;159;116;109;109;110;115;110;110;107 06:47:23 INFO - PROCESS | 1701 | |1;audio-beat-detection;157;121;145;158;118;144;121;131;189;150 06:47:23 INFO - PROCESS | 1701 | |2;audio-dft;186;183;187;188;183;181;186;185;180;184 06:47:23 INFO - PROCESS | 1701 | |3;audio-fft;76;75;90;77;56;57;58;79;78;56 06:47:23 INFO - PROCESS | 1701 | |4;audio-oscillator;93;92;129;79;79;80;112;77;80;113 06:47:23 INFO - PROCESS | 1701 | |5;imaging-gaussian-blur;84;89;83;90;85;91;83;91;83;89 06:47:23 INFO - PROCESS | 1701 | |6;imaging-darkroom;106;150;126;94;93;93;94;93;93;93 06:47:23 INFO - PROCESS | 1701 | |7;imaging-desaturate;85;86;85;85;87;88;86;87;85;88 06:47:23 INFO - PROCESS | 1701 | |8;json-parse-financial;56;55;54;53;52;52;53;63;52;53 06:47:23 INFO - PROCESS | 1701 | |9;json-stringify-tinderbox;63;62;74;75;70;67;65;66;67;67 06:47:23 INFO - PROCESS | 1701 | |10;stanford-crypto-aes;82;80;78;85;94;108;108;110;83;83 06:47:23 INFO - PROCESS | 1701 | |11;stanford-crypto-ccm;130;125;129;130;114;127;132;114;110;128 06:47:23 INFO - PROCESS | 1701 | |12;stanford-crypto-pbkdf2;136;123;141;140;137;128;138;138;136;140 06:47:23 INFO - PROCESS | 1701 | |13;stanford-crypto-sha256-iterative;66;67;66;67;67;67;65;67;68;66 06:47:23 INFO - PROCESS | 1701 | __end_tp_report 06:47:23 INFO - PROCESS | 1701 | __start_cc_report 06:47:23 INFO - PROCESS | 1701 | _x_x_mozilla_cycle_collect,1163 06:47:23 INFO - PROCESS | 1701 | __end_cc_report 06:47:23 INFO - PROCESS | 1701 | __startTimestamp1456152443654__endTimestamp 06:47:23 INFO - PROCESS | 1701 | 06:47:23 INFO - PROCESS | 1701 | ------- Summary: start ------- 06:47:23 INFO - PROCESS | 1701 | Number of tests: 14 06:47:23 INFO - PROCESS | 1701 | 06:47:23 INFO - PROCESS | 1701 | [#0] ai-astar Cycles:10 Average:119.70 Median:112.50 stddev:19.14 (17.0%) stddev-sans-first:16.34 06:47:23 INFO - PROCESS | 1701 | Values: 152.0 159.0 116.0 109.0 109.0 110.0 115.0 110.0 110.0 107.0 06:47:23 INFO - PROCESS | 1701 | 06:47:23 INFO - PROCESS | 1701 | [#1] audio-beat-detection Cycles:10 Average:143.40 Median:147.50 stddev:21.93 (14.9%) stddev-sans-first:22.70 06:47:23 INFO - PROCESS | 1701 | Values: 157.0 121.0 145.0 158.0 118.0 144.0 121.0 131.0 189.0 150.0 06:47:23 INFO - PROCESS | 1701 | 06:47:23 INFO - PROCESS | 1701 | [#2] audio-dft Cycles:10 Average:184.30 Median:185.50 stddev:2.58 (1.4%) stddev-sans-first:2.67 06:47:23 INFO - PROCESS | 1701 | Values: 186.0 183.0 187.0 188.0 183.0 181.0 186.0 185.0 180.0 184.0 06:47:23 INFO - PROCESS | 1701 | 06:47:23 INFO - PROCESS | 1701 | [#3] audio-fft Cycles:10 Average:70.20 Median:76.50 stddev:12.29 (16.1%) stddev-sans-first:12.86 06:47:23 INFO - PROCESS | 1701 | Values: 76.0 75.0 90.0 77.0 56.0 57.0 58.0 79.0 78.0 56.0 06:47:23 INFO - PROCESS | 1701 | 06:47:23 INFO - PROCESS | 1701 | [#4] audio-oscillator Cycles:10 Average:93.40 Median:79.50 stddev:18.39 (23.1%) stddev-sans-first:19.50 06:47:23 INFO - PROCESS | 1701 | Values: 93.0 92.0 129.0 79.0 79.0 80.0 112.0 77.0 80.0 113.0 06:47:23 INFO - PROCESS | 1701 | 06:47:23 INFO - PROCESS | 1701 | [#5] imaging-gaussian-blur Cycles:10 Average:86.80 Median:89.00 stddev:3.49 (3.9%) stddev-sans-first:3.55 06:47:23 INFO - PROCESS | 1701 | Values: 84.0 89.0 83.0 90.0 85.0 91.0 83.0 91.0 83.0 89.0 06:47:23 INFO - PROCESS | 1701 | 06:47:23 INFO - PROCESS | 1701 | [#6] imaging-darkroom Cycles:10 Average:103.50 Median:93.00 stddev:19.46 (20.9%) stddev-sans-first:20.61 06:47:23 INFO - PROCESS | 1701 | Values: 106.0 150.0 126.0 94.0 93.0 93.0 94.0 93.0 93.0 93.0 06:47:23 INFO - PROCESS | 1701 | 06:47:23 INFO - PROCESS | 1701 | [#7] imaging-desaturate Cycles:10 Average:86.20 Median:86.50 stddev:1.23 (1.4%) stddev-sans-first:1.22 06:47:23 INFO - PROCESS | 1701 | Values: 85.0 86.0 85.0 85.0 87.0 88.0 86.0 87.0 85.0 88.0 06:47:23 INFO - PROCESS | 1701 | 06:47:23 INFO - PROCESS | 1701 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:53.50 stddev:3.33 (6.2%) stddev-sans-first:3.48 06:47:23 INFO - PROCESS | 1701 | Values: 56.0 55.0 54.0 53.0 52.0 52.0 53.0 63.0 52.0 53.0 06:47:23 INFO - PROCESS | 1701 | 06:47:23 INFO - PROCESS | 1701 | [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:67.00 stddev:4.27 (6.4%) stddev-sans-first:4.20 06:47:23 INFO - PROCESS | 1701 | Values: 63.0 62.0 74.0 75.0 70.0 67.0 65.0 66.0 67.0 67.0 06:47:23 INFO - PROCESS | 1701 | 06:47:23 INFO - PROCESS | 1701 | [#10] stanford-crypto-aes Cycles:10 Average:91.10 Median:82.50 stddev:12.84 (15.6%) stddev-sans-first:13.19 06:47:23 INFO - PROCESS | 1701 | Values: 82.0 80.0 78.0 85.0 94.0 108.0 108.0 110.0 83.0 83.0 06:47:23 INFO - PROCESS | 1701 | 06:47:23 INFO - PROCESS | 1701 | [#11] stanford-crypto-ccm Cycles:10 Average:123.90 Median:128.50 stddev:8.05 (6.3%) stddev-sans-first:8.23 06:47:23 INFO - PROCESS | 1701 | Values: 130.0 125.0 129.0 130.0 114.0 127.0 132.0 114.0 110.0 128.0 06:47:23 INFO - PROCESS | 1701 | 06:47:23 INFO - PROCESS | 1701 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.70 Median:138.00 stddev:5.76 (4.2%) stddev-sans-first:6.10 06:47:23 INFO - PROCESS | 1701 | Values: 136.0 123.0 141.0 140.0 137.0 128.0 138.0 138.0 136.0 140.0 06:47:23 INFO - PROCESS | 1701 | 06:47:23 INFO - PROCESS | 1701 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:0.84 (1.3%) stddev-sans-first:0.87 06:47:23 INFO - PROCESS | 1701 | Values: 66.0 67.0 66.0 67.0 67.0 67.0 65.0 67.0 68.0 66.0 06:47:23 INFO - PROCESS | 1701 | -------- Summary: end -------- 06:47:23 INFO - PROCESS | 1701 | 06:47:24 INFO - TEST-INFO | 1701: exit 0 06:47:24 INFO - TEST-OK | kraken | took 56437ms 06:47:24 INFO - SUITE-END | took 1170s 06:47:24 INFO - Completed test suite (00:19:31) 06:47:24 INFO - Working with test: dromaeo_css 06:47:24 INFO - Generating results file: dromaeo_css 06:47:24 INFO - Working with test: kraken 06:47:24 INFO - Generating results file: kraken 06:47:24 INFO - javascript benchmark 06:47:24 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:47:25 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,59]] 06:47:25 INFO - process_Request line: dromaeo_css 7278.84 graph.html#tests=[[72,1,59]] 06:47:25 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:47:25 INFO - process_Request line: kraken 1426.70 graph.html#tests=[[232,1,59]] 06:47:25 INFO - RETURN: dromaeo_css: 7278.84 06:47:25 INFO - RETURN: kraken: 1426.70 06:47:25 INFO - javascript benchmark 06:47:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3451.982740086299, 3469.7224222062227, 3471.32309199706, 3475.9304813903736, 3515.52540407045, 5644.125160600103, 5712.314522257335, 5738.684372359518, 5784.6239994400385, 5802.970985145073, 4941.962187940528, 5680.233168522248, 5718.685472299022, 5775.999999999989, 5801.564882633809, 5197.454267301936, 5277.182036784305, 5326.147816349385, 5342.1452567589, 5368.8389348319615, 5313.628046036779, 5315.521603055724, 5324.201369794523, 5327.387350454689, 5329.626926115174, 5207.713575753332, 5227.869303267411, 5350.250964864922, 5403.243545903557, 5405.540529055035, 5183.118869792144, 5225.790968361261, 5252.921206181911, 5280.498352656491, 5319.946800531984, 5215.660982036194, 5239.947600524022, 5256.395514515803, 5265.86835329116, 5267.394249661262, 5612.298462692163, 5642.097264437712, 5643.633163844337, 5662.150677398423, 5740.7703691852275, 6079.39206079393, 6104.7016930465, 6152.415520525543, 6225.346338634468, 6232.844178895519, 6181.443670069671, 6226.439620434183, 6244.313125556185, 6253.530985176085, 6262.561620686553, 5828.184054232411, 5828.708564571754, 5858.941410585925, 5863.384344643836, 5866.413358664142, 6178.845528861724, 6243.8126856194385, 6340.778072767431, 6342.207224096988, 6349.396807303298, 6117.449429551361, 6157.0, 6158.353372895871, 6166.075088736636, 6173.259208894871, 6063.363346848606, 6192.907106393408, 6235.438810506986, 6237.220347456568, 6275.0, 6121.727351053096, 6162.7843025494785, 6199.380061993765, 6215.378462153839, 6229.844253893689, 6182.876342473125, 6186.969065154645, 6203.100550420164, 6207.472364848948, 6242.812715618538, 4124.360724087771, 4885.096257192431, 4902.926456103161, 4917.827876024322, 4957.975210123998, 4398.494173170063, 4438.201123797683, 4452.0873220989615, 4454.532274111237, 4489.842855500042, 4765.428148622187, 5753.827385178452, 5766.567507436959, 5774.769009239667, 5783.306003279549, 5171.741412929414, 6169.660668663177, 6195.380461953859, 6199.659018754011, 6221.440070393686, 5421.59038649946, 5610.691411972381, 5813.157092221604, 5824.708764561755, 5900.822975310747, 5400.756965936543, 5401.918971215435, 5406.270153529302, 5407.756650950717, 5414.729263536886, 6212.565120441525, 6245.937540624535, 6321.3678632137335, 6336.556441049174, 6343.682815859189, 6273.278572964167, 6285.874282514233, 6292.559520833681, 6295.716692748929, 6296.370362963667, 5641.746121424464, 5976.402359763989, 6313.084602732486, 6330.493560515056, 6351.555391122577, 4964.875878102932, 6146.862830376394, 6188.164597779242, 6239.344868788893, 6255.280642725963, 6253.812385628438, 6263.530235232284, 6286.339934307015, 6289.308176100534, 6303.243610766737, 5996.850078748066, 6098.75604975796, 6121.785737499166, 6123.9693801532485, 6130.938690613215, 6047.848803779764, 6062.545309101747, 6104.06507294887, 6110.69446527663, 6143.201383820075, 5764.250647415809, 5929.851753706192, 5950.16697662319, 5961.672108034099, 5963.0, 5902.291724993029, 6072.240969878765, 6130.938690613037, 6143.174139895698, 6143.600665956698, 5966.910496342645, 5978.163057171912, 5979.730912109053, 5981.730822112929, 5998.4601385875485], "unit": "score", "name": "dojo.html", "value": 5694.658477192405}, {"lowerIsBetter": false, "replicates": [462.4219725343321, 477.81365267545664, 493.34138924535745, 559.8746519495813, 582.9358770535243, 29803.55294670579, 30412.239694007607, 30526.694733052664, 30564.624591893364, 30586.23534411638, 30602.387952241, 40060.399094013614, 40526.18947621046, 40647.983800405, 40733.79633101838, 9466.479343636114, 9658.227341812673, 9685.273604479693, 9688.854667179998, 9703.12671859536, 9499.335046546745, 9650.469224192702, 9653.372530785477, 9668.75828104296, 9699.127078562928, 9608.519574021306, 9683.176929960962, 9699.030096990315, 9709.805803883954, 9714.222862171046, 9578.61685532578, 9632.181264592518, 9692.321537492413, 9699.563519641633, 9705.61177552897, 8245.216704413071, 9577.712668619952, 9711.90288097117, 9717.271204659608, 9720.659776907774, 40007.39988900169, 40549.79725101356, 40589.39115913264, 40658.593414066076, 40721.0, 3220.22714548509, 3343.0973637118086, 3429.1255729788745, 3622.800745958971, 3808.0860593457646, 28397.29502110464, 29079.709202908125, 29178.854105729548, 29626.70373296261, 29801.25496862574, 2557.526857531344, 2586.456844062749, 2819.746222839954, 2883.6972117927526, 2915.8687859046395, 424570.0, 424718.0, 428937.0, 429312.0, 429770.0, 45764.08471830545, 46154.46146462379, 65107.34892651013, 65516.67241663857, 65634.67182664057, 45237.54762452399, 45443.86390340268, 45479.772601136785, 45528.3170752439, 45541.31688024682, 15492.380304787908, 15698.058116513046, 15702.685946281239, 15709.685806283811, 15735.977161484467, 12055.457504412323, 12140.271583704829, 12306.81539776904, 12353.258804471761, 12410.689732756753, 14549.418023279162, 14562.053466524641, 14579.635509112144, 14590.688685699379, 14670.559883203521, 5395.325584301962, 6217.378262173746, 6261.968690156611, 6263.154474145932, 6270.372962703693, 884.478157886837, 950.5959967013991, 970.6699722094522, 1100.9210973246104, 1153.224034986112, 29740.55389169164, 29890.0, 30832.075037748902, 31036.379272414426, 31452.05643830689, 873.0178549132227, 960.644561512231, 1044.8484969679505, 1074.3231763988638, 1104.812181929074, 14275.0, 14391.64020899465, 14489.695927366376, 14664.0, 14678.85321146775, 666908.0, 670837.0, 672818.0, 673763.0, 675067.0, 57862.4213757857, 59867.70066149641, 59874.0, 59898.40101599015, 60100.39899600948, 1298.0978220136915, 1323.5963031275553, 1412.173878281217, 1416.0795482936173, 1442.9567112986626, 29026.27434314159, 31201.0, 31269.061928141284, 31294.530582040832, 31983.840080799448, 53816.461835381146, 53931.73034134804, 54734.72632636971, 54740.45259547513, 54742.45257547373, 519935.0, 546864.0, 547375.2631236819, 548837.0, 550353.0, 40966.590334096276, 41680.1663966725, 42612.57387426086, 42683.57316426796, 42776.14447711091, 43341.783291083346, 44176.33735493906, 44656.553434466536, 44979.77510112429, 45326.0, 36142.0, 36858.078548036516, 37702.66419361699, 37931.43102853404, 38848.805755971036, 37216.44175337426, 37589.624103758615, 38453.461861525226, 38765.806170968965, 38819.0, 30469.54295685611, 35757.64242357543, 36564.0, 36759.81620091989, 36903.0, 24282.75717242805, 30147.0, 31749.0, 32400.86596969095, 32571.837140814143, 23133.768662313836, 24845.0, 25011.499770004863, 25072.37319067038, 25395.74604254008], "unit": "score", "name": "ext.html", "value": 19248.617450603237}, {"lowerIsBetter": false, "replicates": [363.09951320724605, 368.193655893593, 369.58606360875825, 370.3574298591943, 374.7770076804304, 15446.382144714198, 16074.357025718986, 17337.22604383299, 19616.509587260327, 20294.6955795663, 15506.922465387686, 19700.802991970075, 20318.796812031876, 20550.38348849537, 20633.793662063374, 5643.830685079454, 5684.801031963882, 5794.68129252891, 5838.883222335572, 5917.970410147965, 3162.5098109792903, 4108.096218831853, 4321.827126914935, 4897.926531102036, 5854.385289544601, 3649.959761467982, 4289.313709806432, 5086.593072554187, 6347.206599175103, 6366.076918846765, 5196.428392876781, 6260.937390626081, 6325.146105275798, 6327.651979141122, 6328.11406403104, 5554.833354999357, 5580.888382232332, 5585.692786896719, 5587.9941610510095, 5588.6646801192055, 11151.0, 12698.936505317415, 12805.20727098207, 13189.472421103144, 25222.621660675104, 1855.3320804510365, 2023.1806118522022, 2229.230915334207, 2272.659101134843, 2323.697919270484, 7822.726204582812, 9865.260105492116, 10041.397516149054, 13052.934735326262, 13351.130841682172, 1738.7478815571799, 1792.82071792821, 1816.1191821966336, 1817.0823734014239, 1821.435355039942, 79039.50287623053, 88255.11744882597, 109052.4547377266, 109835.45082274538, 110980.0, 8595.78510537229, 11143.16426268017, 11195.048420884154, 11219.485369475016, 11332.886671133349, 12105.152639315163, 12513.936315413292, 12870.970322374187, 13628.591142265748, 13633.795493067611, 6474.741010359627, 6627.0, 7950.880736788953, 8409.53747543891, 8479.830403391898, 7365.0, 8141.674333026613, 8545.487270763773, 8573.4427262229, 8646.481211127226, 4370.8033138508845, 4407.4050003249795, 4407.537208593051, 4409.404730361424, 4447.644188464915, 1807.367421402525, 1870.3360307090786, 1890.2722451856134, 1892.9526761831064, 1908.1031914999928, 405.4769347541697, 875.6803766625136, 899.2985471332371, 978.1978777402604, 1009.9040591143829, 9535.761605959906, 11536.365499897585, 11726.296422214524, 11744.58893938708, 11853.170278080452, 441.078146673454, 447.7045150200852, 450.4954451014819, 454.2096751652102, 468.82887745972477, 5078.4413714491375, 5639.3232812062, 5853.707314634251, 6288.654124023131, 6296.212973378328, 531888.0, 606796.0, 625520.0, 627078.0, 666501.0, 92516.53741731249, 119424.40287798505, 119930.0, 125754.0, 127436.0, 439.6175327465126, 447.30220855464927, 448.5581702023504, 448.8518788799688, 449.3910750932505, 11064.889351106385, 11401.942990284995, 11655.892690194418, 11685.824712629488, 11703.356315402734, 51534.22698659448, 53199.73400132974, 53552.732236340125, 53879.461205387444, 54991.0, 71583.64208178926, 73048.63475682588, 73093.634531827, 73193.26806731864, 73564.0, 7881.13307536182, 8132.634031468717, 8206.425550211428, 8237.79405514867, 8367.246947774485, 11122.277051991594, 13475.46098156102, 13635.250061246727, 13774.966877484429, 13785.793213101611, 11687.240329378903, 11738.58914937973, 11801.347641627153, 11907.46416411281, 11963.162578619762, 11497.195196336175, 11542.307461552333, 11678.766424671629, 11834.76330473403, 11839.82240266414, 11801.881981180079, 11971.521139154336, 11988.340641264815, 12011.75976480448, 12034.157608967638, 7995.200479951958, 8116.83766324682, 8162.142974987541, 8175.0, 8218.0, 9277.768055798659, 11558.826617600911, 11616.94191529037, 11642.41787910618, 11670.474828632901], "unit": "score", "name": "jquery.html", "value": 8343.034826029607}, {"lowerIsBetter": false, "replicates": [1395.2814300635168, 1515.8559936806, 1553.495114087921, 1779.2082523277138, 1930.1893204853952, 6739.35976082272, 8517.0, 8688.73933781986, 8703.65185392585, 8705.434146780455, 8424.578771061453, 8654.134586541342, 8659.653613855455, 8664.653413863454, 8670.306375489961, 2157.9892100539473, 2225.877576733279, 2226.597243736444, 2444.27893771337, 2469.962950555743, 2432.4526981429212, 2500.2874180858457, 2501.062101711858, 2504.4239824840297, 2505.7368976257503, 2403.098837935774, 2426.320630223531, 2455.582550966331, 2466.3464181991785, 2468.90124395024, 2149.6882951972034, 2208.514126892081, 2210.425289424761, 2457.496213276274, 2470.036685692581, 2194.4513871532117, 2393.7606239375923, 2454.2882564056404, 2459.6802415685847, 2459.987700061506, 8548.444351117158, 8608.139186081404, 8623.956880215621, 8635.222829945335, 8636.309095272363, 5239.423663397023, 5378.058839703036, 5381.919271210935, 5403.675779453245, 5406.54044406226, 3618.6019537850816, 3642.3079614873354, 3678.742488025839, 3725.068732816796, 3735.8879233623034, 936.2509992006368, 1085.4952447112053, 1087.7117563845586, 1098.231238133302, 1106.4523061084733, 11828.349440780754, 11908.464119114575, 11918.22531535456, 11921.10591705617, 11929.045676345959, 4763.95236047642, 4835.468098509161, 4936.950630493721, 4952.4057113146655, 4978.925316120189, 10140.492975351202, 10140.898591014144, 10142.797144057078, 10148.746281343025, 10162.4918754062, 4998.650094493423, 5077.492250774893, 5501.449855014546, 5502.5597952163735, 5504.119340905436, 4404.163208990281, 4537.047220083819, 4771.856844294607, 4940.2342636891335, 4990.700557966534, 3935.960640393617, 3936.1143742657673, 3955.7626542407547, 3988.0428697112484, 4015.77913214776, 1315.0991570774052, 1318.7164759576738, 1321.1346567997978, 1327.0, 1330.5542643214437, 1148.17905197784, 1159.310210424796, 1213.3811756004502, 1234.7839128152536, 1363.12078709232, 8111.3916456266015, 8129.4715843469985, 8160.265576098061, 8192.83614327722, 8196.385271104691, 493.28227429091305, 508.3213909430951, 511.59583928696657, 514.069534143202, 514.1182871375609, 6155.96922015396, 6198.752049918043, 6231.626102433778, 6234.625922444668, 6236.594621349598, 10349.965003499741, 10682.252242343116, 10728.356298622108, 10813.567457301777, 10843.78312433747, 10445.164386849034, 10532.526036328383, 10674.733131671615, 10685.145188384911, 10706.625268115578, 8266.462679925786, 8341.915550978456, 8355.749327520183, 8358.414910956297, 8366.832663346699, 7804.921950780419, 7860.724874629361, 7863.252990965849, 7881.763547093597, 7924.6037698116015, 9461.479618621042, 9466.242700584075, 9571.042895710374, 9626.181774548962, 9689.660861870083, 8407.70573029941, 9524.85712714296, 9657.46883921391, 9838.36050656705, 9870.703878883645, 6807.421369183675, 6862.656867156522, 7223.747168849065, 7296.671649775879, 7339.669714862737, 8142.3486121111355, 8251.463654862415, 8253.669853206045, 8267.214614611603, 8290.0, 7224.277572242734, 7339.229380914927, 7342.9632851835395, 7475.88786168197, 7490.213527579744, 7149.657320872274, 7239.746608868664, 7292.781216563511, 7355.190928997913, 7364.96317518409, 7645.617719114133, 7664.578448185403, 7701.152873183833, 7725.034370703662, 7735.265149810759, 6770.830729231809, 6952.44380449573, 7023.438124950094, 7034.085568876013, 7035.1909530404655, 6289.7484100635465, 6682.3317668232785, 6966.373026427443, 7030.402415794715, 7031.332023457763], "unit": "score", "name": "mootools.html", "value": 4788.939861269337}, {"lowerIsBetter": false, "replicates": [315.5456143153858, 324.5407748036528, 326.5575145677607, 328.04048159134527, 331.5606820962226, 5222.268882356473, 6466.321036291192, 6540.084388185658, 6545.509086818496, 6566.3105373935705, 6157.568970172089, 6317.905231421532, 6394.520410969173, 6410.839729006777, 6493.935060649392, 4843.975780121094, 4844.951550484503, 4850.563449289563, 4860.902781944359, 4895.853124406273, 4590.472095708986, 4868.123737727207, 4869.050535145648, 4870.586000189988, 4871.951280487186, 3944.909198124984, 4558.49856515783, 4655.7672116394215, 4676.3920690310215, 4679.227927391977, 4782.282657601353, 4784.067106914154, 4784.976075119602, 4789.952100479003, 4800.87997800056, 3356.7818091824197, 3534.929301413957, 3960.029792700807, 4106.1992911382295, 4109.0549173690215, 6229.87540249197, 6295.2760432550385, 6296.464800491918, 6329.398707122816, 6340.619562826245, 5064.873378165538, 5218.13900706383, 5636.605437619368, 5655.794240246307, 5659.660420374791, 6567.244766851778, 6795.082663840368, 6806.6256355900405, 6807.829804254884, 6956.304369563054, 4602.516735742733, 4609.562091601292, 4611.377464042345, 4611.884702882421, 4612.238980568202, 7253.347198752085, 7362.521436106689, 7368.926310736932, 7369.77890663281, 7371.963140184264, 4740.478547359788, 4753.9762301188275, 4759.881002974953, 4760.262159365304, 4765.332853400458, 4806.687565308243, 4819.759012049453, 4827.179379505493, 4834.009028149221, 4836.758162091881, 5407.513323800798, 5609.80365687199, 5618.578606604521, 5642.125470552071, 5660.745266463019, 6802.795916122524, 6960.756373526902, 7007.299270072952, 7037.366637002592, 7044.189918159374, 1419.3683810704138, 1694.2714632708055, 1695.4405046334928, 1696.5334533003522, 1697.109017765658, 1031.9432431216205, 1090.8581884354983, 1107.5846557540922, 1115.2583531951161, 1127.1321082766224, 6436.0, 6538.444232240217, 6551.901721474182, 6570.080188773575, 6577.0, 7203.819904502325, 7209.0628218331285, 7215.0, 7215.989761433403, 7219.314165154302, 5248.711320877312, 6517.771877984248, 6529.673516324165, 6533.314002029719, 6535.5425120241125, 3690.1697118148204, 3733.178700685845, 3793.899769066995, 3797.050737315671, 3802.6197380262306, 7578.924210757822, 7599.962000189964, 7608.391328693691, 7610.847783044308, 7637.5035622684345, 7506.474546781673, 7534.434917381218, 7555.848883022309, 7556.282153195438, 7558.281963213486, 7582.279683430175, 7606.885896711665, 7615.466917315845, 7616.885746713804, 7618.009658744328, 6067.756109997528, 7036.190838053484, 7137.10786151731, 7302.306280903305, 7332.78001659951, 6410.743570257137, 6616.966915165393, 6650.87645659694, 7140.107486564179, 7207.423406127602, 6743.1908171019795, 7619.390448763975, 7634.923650763421, 7638.121616014229, 7647.502912310682, 3639.4358874374516, 4444.82220711168, 4567.748773817472, 4614.284785858197, 4616.422947131608, 6918.584884906922, 7251.56490610565, 7263.709451621876, 7267.418606511361, 7273.3453989141235, 7009.12385951756, 7015.36861682451, 7040.260772619006, 7045.295470452914, 7049.471289653194, 5635.605507614591, 5972.372900845522, 6736.854734695015, 6994.090768200102, 7020.824479388056, 5530.474604912527, 6815.727370905108, 6839.247682754993, 6848.315168483112, 6853.00631408453, 6680.231773346128, 6746.797596072126, 7016.052832867497, 7045.542039767399, 7045.964770176116, 5760.020796464527, 6416.679166041586, 6638.070670106285, 6744.426723728538, 6773.832373640388], "unit": "score", "name": "prototype.html", "value": 5063.311257488638}, {"lowerIsBetter": false, "replicates": [683.4873844616537, 694.7012784502664, 715.6636380900976, 721.6319676964746, 756.8259300360917, 14661.70676586469, 14861.702765944674, 14870.03344782591, 14873.553793386202, 14918.17950012749, 13122.737545249112, 13629.931850340734, 13643.795343069862, 13670.179789212654, 13684.315784210774, 691.8374182067223, 842.7471758472434, 876.7238319929202, 876.7676565710092, 877.7805548612847, 863.1411745313422, 871.9694810681627, 880.106691707917, 880.1682410122437, 880.7974165941837, 740.9110906691204, 752.9096508418997, 935.0789472369711, 936.8173206224789, 940.0035961880394, 752.8268498245407, 907.2605826251616, 927.4574373991223, 931.0968360690119, 931.7950050988771, 684.5995092870677, 685.1606781692436, 685.694865784726, 686.3308274432438, 690.0890824112174, 14451.638709032253, 14586.905982051388, 14591.635209119751, 14592.416303347853, 14624.707505849823, 10480.63317783874, 12559.874401256053, 12571.559995400117, 12696.428660710199, 13074.477020919247, 9126.863097053549, 10173.79652406955, 10205.64280250195, 10268.28122031458, 10538.367697938149, 3571.196480791801, 3572.464130380438, 3588.6052534221217, 3600.135967367839, 3631.4915911772373, 81713.59143204246, 81976.0, 81985.0, 82060.0, 82490.17509824884, 9308.069193080637, 9324.160825525736, 9475.0, 9605.519724013911, 10181.440020798778, 21547.67678484824, 21656.0, 21668.24161154352, 21689.34931952044, 21732.674009889863, 7285.125784905846, 7371.11546614399, 7516.436267279976, 7534.510256833289, 7684.731034413769, 3543.787372757643, 3574.588922273972, 3703.629637036329, 3711.31340701971, 3965.325894597925, 3376.274101068233, 3476.3047390521997, 3478.669526394988, 3486.89539313821, 3548.1307079765625, 546.9288992430959, 644.859998807656, 650.8763334966342, 651.5406638319973, 661.7022339947043, 554.8307766131288, 559.2115117684046, 574.5059249045818, 578.8552861784553, 604.9727762250709, 7943.443958922935, 8515.446495977742, 9075.092490751003, 9248.16766491019, 9253.537323133816, 565.9886802263932, 599.6881621556767, 634.552640388525, 637.101686621861, 651.7686221391433, 3403.5575375201065, 3728.7017038636845, 3863.3818589025623, 4040.676745860324, 4070.00284930194, 91404.54297728602, 95659.0, 97740.51129744305, 97839.0, 97934.51032744933, 82617.17382826215, 82781.17218827855, 83017.0, 83153.0, 84167.73748393779, 69870.0, 69878.3012169882, 70838.2916170842, 71142.0, 73091.26908730951, 7975.72084977023, 8036.799080023046, 8234.752957411287, 8276.213759692819, 8348.123447038217, 42759.50341738024, 45242.773786130856, 47129.293060603435, 47171.58485245448, 48777.75611121922, 54909.90180196294, 59523.0, 61746.530138795744, 70034.64982675054, 70593.0, 9958.701238962843, 9985.850212246676, 10212.183025357805, 10231.181505479395, 10558.155347572023, 10617.628383006559, 10623.681289561326, 10626.0, 10631.468426578795, 10658.467076645982, 10322.741931451774, 10370.22223333268, 10370.637027703995, 10387.584496620051, 10417.16662667, 10242.283040187116, 10372.58509659605, 10424.0, 10430.956904309509, 10431.165506759593, 8406.201410865959, 10180.0, 10208.387496750218, 10300.845487317547, 10415.68752937413, 8753.037165911617, 8970.461772293684, 9089.681861134828, 9120.407173533698, 9171.235986449212, 8747.825043499222, 8979.506127162807, 9021.052789457013, 9135.817283654156, 9228.170413613216], "unit": "score", "name": "yui.html", "value": 6706.184370828808}], "name": "dromaeo_css", "value": 7278.845143980201}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [152.0, 159.0, 116.0, 109.0, 109.0, 110.0, 115.0, 110.0, 110.0, 107.0], "unit": "score", "name": "ai-astar", "value": 119.7}, {"lowerIsBetter": true, "replicates": [157.0, 121.0, 145.0, 158.0, 118.0, 144.0, 121.0, 131.0, 189.0, 150.0], "unit": "score", "name": "audio-beat-detection", "value": 143.4}, {"lowerIsBetter": true, "replicates": [186.0, 183.0, 187.0, 188.0, 183.0, 181.0, 186.0, 185.0, 180.0, 184.0], "unit": "score", "name": "audio-dft", "value": 184.3}, {"lowerIsBetter": true, "replicates": [76.0, 75.0, 90.0, 77.0, 56.0, 57.0, 58.0, 79.0, 78.0, 56.0], "unit": "score", "name": "audio-fft", "value": 70.2}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 129.0, 79.0, 79.0, 80.0, 112.0, 77.0, 80.0, 113.0], "unit": "score", "name": "audio-oscillator", "value": 93.4}, {"lowerIsBetter": true, "replicates": [84.0, 89.0, 83.0, 90.0, 85.0, 91.0, 83.0, 91.0, 83.0, 89.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 86.8}, {"lowerIsBetter": true, "replicates": [106.0, 150.0, 126.0, 94.0, 93.0, 93.0, 94.0, 93.0, 93.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 103.5}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 85.0, 85.0, 87.0, 88.0, 86.0, 87.0, 85.0, 88.0], "unit": "score", "name": "imaging-desaturate", "value": 86.2}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 54.0, 53.0, 52.0, 52.0, 53.0, 63.0, 52.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 54.3}, {"lowerIsBetter": true, "replicates": [63.0, 62.0, 74.0, 75.0, 70.0, 67.0, 65.0, 66.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.6}, {"lowerIsBetter": true, "replicates": [82.0, 80.0, 78.0, 85.0, 94.0, 108.0, 108.0, 110.0, 83.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 91.1}, {"lowerIsBetter": true, "replicates": [130.0, 125.0, 129.0, 130.0, 114.0, 127.0, 132.0, 114.0, 110.0, 128.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.9}, {"lowerIsBetter": true, "replicates": [136.0, 123.0, 141.0, 140.0, 137.0, 128.0, 138.0, 138.0, 136.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 135.7}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 66.0, 67.0, 67.0, 67.0, 65.0, 67.0, 68.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.6}], "name": "kraken", "value": 1426.7}]} 06:47:25 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,59]]", "result": "1426.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,59]]", "result": "7278.84"}}} 06:47:25 INFO - Return code: 0 06:47:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:47:25 INFO - # TBPL SUCCESS # 06:47:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:47:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:47:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:47:25 INFO - 2016-02-22 06:47:25.542 screenresolution[1705:11665] starting screenresolution argv=screenresolution get 06:47:25 INFO - 2016-02-22 06:47:25.545 screenresolution[1705:11665] Display 0: 1600x1200x32@60 06:47:25 INFO - 2016-02-22 06:47:25.551 screenresolution[1706:11668] starting screenresolution argv=screenresolution list 06:47:25 INFO - Available Modes on Display 0 06:47:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:47:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:47:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:47:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:47:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:47:25 INFO - Intel Iris: 06:47:25 INFO - Chipset Model: Intel Iris 06:47:25 INFO - Type: GPU 06:47:25 INFO - Bus: Built-In 06:47:25 INFO - VRAM (Dynamic, Max): 1536 MB 06:47:25 INFO - Vendor: Intel (0x8086) 06:47:25 INFO - Device ID: 0x0a2e 06:47:25 INFO - Revision ID: 0x0009 06:47:25 INFO - Displays: 06:47:25 INFO - Display: 06:47:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:47:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:47:25 INFO - Display Serial Number: 1600x1200 60 06:47:25 INFO - Main Display: Yes 06:47:25 INFO - Mirror: Off 06:47:25 INFO - Online: Yes 06:47:25 INFO - Rotation: Supported 06:47:25 INFO - Return code: 0 06:47:25 INFO - Running post-action listener: _resource_record_post_action 06:47:25 INFO - Running post-run listener: _resource_record_post_run 06:47:26 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 33273344; Write bytes: 710107136; Read time: 351; Write time: 2103 06:47:26 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 386830848; Write bytes: 382215680; Read time: 28408; Write time: 874 06:47:26 INFO - run-tests - Wall time: 1174s; CPU: 52.0%; Read bytes: 32351744; Write bytes: 302492160; Read time: 338; Write time: 1172 06:47:26 INFO - Running post-run listener: _upload_blobber_files 06:47:26 INFO - Blob upload gear active. 06:47:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:47:26 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 06:47:26 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'] 06:47:26 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 06:47:27 INFO - (blobuploader) - INFO - Open directory for files ... 06:47:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:47:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:47:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:47:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:47:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:47:28 INFO - (blobuploader) - INFO - Done attempting. 06:47:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:47:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:47:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:47:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:47:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:47:29 INFO - (blobuploader) - INFO - Done attempting. 06:47:29 INFO - (blobuploader) - INFO - Iteration through files over. 06:47:29 INFO - Return code: 0 06:47:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:47:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:47:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/424180bf8024a08407e0edbfa2084cabd31a63196599d992945ce2e2f3570625be7f01ec71baaa92fd44b8798889f32336904daec861a42982fc3cf17d09bdab", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ccc888cfb9dd3ab7b731bf5ace5e4595c460d6fa132c3145dda1668326e3fdfc4ce9f5b2301f80c863060acdedcec56077d965818a7e0e96a60d0f5b70ae2f91"} 06:47:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:47:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:47:29 INFO - Contents: 06:47:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/424180bf8024a08407e0edbfa2084cabd31a63196599d992945ce2e2f3570625be7f01ec71baaa92fd44b8798889f32336904daec861a42982fc3cf17d09bdab", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ccc888cfb9dd3ab7b731bf5ace5e4595c460d6fa132c3145dda1668326e3fdfc4ce9f5b2301f80c863060acdedcec56077d965818a7e0e96a60d0f5b70ae2f91"} 06:47:29 INFO - Running post-run listener: copy_logs_to_upload_dir 06:47:29 INFO - Copying logs to upload dir... 06:47:29 INFO - mkdir: /builds/slave/test/build/upload/logs 06:47:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.543957 ========= master_lag: 4.74 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-02-22 06:47:34.217479) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 3 secs) (at 2016-02-22 06:47:34.221991) ========= 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.HPf9hVXmO8/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.DHC4bRKkjA/Listeners TMPDIR=/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/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/424180bf8024a08407e0edbfa2084cabd31a63196599d992945ce2e2f3570625be7f01ec71baaa92fd44b8798889f32336904daec861a42982fc3cf17d09bdab", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ccc888cfb9dd3ab7b731bf5ace5e4595c460d6fa132c3145dda1668326e3fdfc4ce9f5b2301f80c863060acdedcec56077d965818a7e0e96a60d0f5b70ae2f91"} build_url:https://queue.taskcluster.net/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011156 build_url: 'https://queue.taskcluster.net/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/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/424180bf8024a08407e0edbfa2084cabd31a63196599d992945ce2e2f3570625be7f01ec71baaa92fd44b8798889f32336904daec861a42982fc3cf17d09bdab", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ccc888cfb9dd3ab7b731bf5ace5e4595c460d6fa132c3145dda1668326e3fdfc4ce9f5b2301f80c863060acdedcec56077d965818a7e0e96a60d0f5b70ae2f91"}' ========= master_lag: 3.53 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 3 secs) (at 2016-02-22 06:47:37.765116) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 06:47:37.765422) ========= 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.HPf9hVXmO8/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.DHC4bRKkjA/Listeners TMPDIR=/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/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.005313 ========= master_lag: 0.99 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 06:47:38.757189) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-22 06:47:38.757481) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-22 06:47:38.764298) ========= ========= Total master_lag: 9.90 =========