builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0078 starttime: 1459818116.91 results: success (0) buildid: 20160404155841 builduid: 3095fd53a4c54f1f979ffd5ed691cdfd revision: a57a4c6df00d0ffaa35b2abc1e388c691c9eb514 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-04 18:01:56.910095) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-04 18:01:56.910541) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-04 18:01:56.910872) ========= 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.3hJ26QjEQ7/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.72gN0tdMii/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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.005626 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-04 18:01:56.938429) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-04 18:01:56.938735) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-04 18:01:56.960767) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 18:01:56.961154) ========= 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.3hJ26QjEQ7/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.72gN0tdMii/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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.005783 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 18:01:57.016762) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-04 18:01:57.020118) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-04 18:01:57.020581) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 18:01:57.023956) ========= 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.3hJ26QjEQ7/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.72gN0tdMii/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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-04-04 18:01:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.0M=0.001s 2016-04-04 18:01:57 (18.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.204319 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 18:01:57.245258) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 18:01:57.245566) ========= 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.3hJ26QjEQ7/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.72gN0tdMii/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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.026129 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 18:01:57.294826) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-04 18:01:57.295181) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a57a4c6df00d0ffaa35b2abc1e388c691c9eb514 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a57a4c6df00d0ffaa35b2abc1e388c691c9eb514 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3hJ26QjEQ7/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.72gN0tdMii/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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-04-04 18:01:57,373 truncating revision to first 12 chars 2016-04-04 18:01:57,373 Setting DEBUG logging. 2016-04-04 18:01:57,373 attempt 1/10 2016-04-04 18:01:57,373 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a57a4c6df00d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-04 18:01:58,458 unpacking tar archive at: mozilla-aurora-a57a4c6df00d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.336299 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-04 18:01:58.647861) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-04 18:01:58.648218) ========= echo a57a4c6df00d0ffaa35b2abc1e388c691c9eb514 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'a57a4c6df00d0ffaa35b2abc1e388c691c9eb514'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3hJ26QjEQ7/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.72gN0tdMii/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 a57a4c6df00d0ffaa35b2abc1e388c691c9eb514 program finished with exit code 0 elapsedTime=0.005173 script_repo_revision: 'a57a4c6df00d0ffaa35b2abc1e388c691c9eb514' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-04 18:01:58.697858) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-04 18:01:58.698179) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-04 18:01:58.712328) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-04-04 18:01:58.712730) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3hJ26QjEQ7/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.72gN0tdMii/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 18:01:58 INFO - MultiFileLogger online at 20160404 18:01:58 in /builds/slave/test 18:01:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 18:01:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:01:58 INFO - {'append_to_log': False, 18:01:58 INFO - 'base_work_dir': '/builds/slave/test', 18:01:58 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 18:01:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:01:58 INFO - 'branch': 'Mozilla-Aurora', 18:01:58 INFO - 'buildbot_json_path': 'buildprops.json', 18:01:58 INFO - 'config_files': ('talos/mac_config.py',), 18:01:58 INFO - 'default_actions': ('clobber', 18:01:58 INFO - 'read-buildbot-config', 18:01:58 INFO - 'download-and-extract', 18:01:58 INFO - 'populate-webroot', 18:01:58 INFO - 'create-virtualenv', 18:01:58 INFO - 'install', 18:01:58 INFO - 'run-tests'), 18:01:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:01:58 INFO - 'download_minidump_stackwalk': True, 18:01:58 INFO - 'download_symbols': 'ondemand', 18:01:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:01:58 INFO - 'tooltool.py': '/tools/tooltool.py', 18:01:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:01:58 INFO - '/tools/misc-python/virtualenv.py')}, 18:01:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:01:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:01:58 INFO - 'installer_path': 'installer.exe', 18:01:58 INFO - 'log_level': 'info', 18:01:58 INFO - 'log_name': 'talos', 18:01:58 INFO - 'log_to_console': True, 18:01:58 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:01:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:01:58 INFO - 'opt_config_files': (), 18:01:58 INFO - 'pip_index': False, 18:01:58 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:01:58 INFO - 'cmd': ('bash', 18:01:58 INFO - '-c', 18:01:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:01:58 INFO - 'enabled': True, 18:01:58 INFO - 'halt_on_failure': False, 18:01:58 INFO - 'name': 'check_screen_resolution'},), 18:01:58 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:01:58 INFO - 'cmd': ('bash', 18:01:58 INFO - '-c', 18:01:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:01:58 INFO - 'enabled': True, 18:01:58 INFO - 'halt_on_failure': False, 18:01:58 INFO - 'name': 'check_screen_resolution'},), 18:01:58 INFO - 'run_cmd_checks_enabled': True, 18:01:58 INFO - 'sps_profile': False, 18:01:58 INFO - 'sps_profile_interval': 0, 18:01:58 INFO - 'suite': 'dromaeojs', 18:01:58 INFO - 'system_bits': '32', 18:01:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:01:58 INFO - 'title': 't-yosemite-r7-0078', 18:01:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:01:58 INFO - 'use_talos_json': True, 18:01:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:01:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:01:58 INFO - 'work_dir': 'build'} 18:01:58 INFO - ##### 18:01:58 INFO - ##### Running clobber step. 18:01:58 INFO - ##### 18:01:58 INFO - Running pre-action listener: _resource_record_pre_action 18:01:58 INFO - Running main action method: clobber 18:01:58 INFO - rmtree: /builds/slave/test/build 18:01:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:02:00 INFO - Running post-action listener: _resource_record_post_action 18:02:00 INFO - ##### 18:02:00 INFO - ##### Running read-buildbot-config step. 18:02:00 INFO - ##### 18:02:00 INFO - Running pre-action listener: _resource_record_pre_action 18:02:00 INFO - Running main action method: read_buildbot_config 18:02:00 INFO - Using buildbot properties: 18:02:00 INFO - { 18:02:00 INFO - "project": "", 18:02:00 INFO - "product": "firefox", 18:02:00 INFO - "script_repo_revision": "production", 18:02:00 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 18:02:00 INFO - "repository": "", 18:02:00 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 18:02:00 INFO - "buildid": "20160404155841", 18:02:00 INFO - "pgo_build": "False", 18:02:00 INFO - "basedir": "/builds/slave/test", 18:02:00 INFO - "buildnumber": 260, 18:02:00 INFO - "slavename": "t-yosemite-r7-0078", 18:02:00 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 18:02:00 INFO - "platform": "yosemite_r7", 18:02:00 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 18:02:00 INFO - "branch": "mozilla-aurora", 18:02:00 INFO - "repo_path": "releases/mozilla-aurora", 18:02:00 INFO - "revision": "a57a4c6df00d0ffaa35b2abc1e388c691c9eb514", 18:02:00 INFO - "stage_platform": "macosx64", 18:02:00 INFO - "builduid": "3095fd53a4c54f1f979ffd5ed691cdfd", 18:02:00 INFO - "slavebuilddir": "test" 18:02:00 INFO - } 18:02:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/IkKXPF2XTIaV_zSbaYm1-g/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 18:02:00 INFO - Running post-action listener: _resource_record_post_action 18:02:00 INFO - ##### 18:02:00 INFO - ##### Running download-and-extract step. 18:02:00 INFO - ##### 18:02:00 INFO - Running pre-action listener: _resource_record_pre_action 18:02:00 INFO - Running main action method: download_and_extract 18:02:00 INFO - mkdir: /builds/slave/test/build/tests 18:02: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')]} 18:02:00 INFO - https://queue.taskcluster.net/v1/task/IkKXPF2XTIaV_zSbaYm1-g/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 18:02:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IkKXPF2XTIaV_zSbaYm1-g/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 18:02:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IkKXPF2XTIaV_zSbaYm1-g/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 18:02:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IkKXPF2XTIaV_zSbaYm1-g/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 18:02:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IkKXPF2XTIaV_zSbaYm1-g/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json'}, attempt #1 18:02:02 INFO - Downloaded 1277 bytes. 18:02:02 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 18:02:02 INFO - Using the following test package requirements: 18:02:02 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 18:02:02 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 18:02:02 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 18:02:02 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 18:02:02 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 18:02:02 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 18:02:02 INFO - u'jsshell-mac.zip'], 18:02:02 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 18:02:02 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 18:02:02 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 18:02:02 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 18:02:02 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 18:02:02 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 18:02:02 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 18:02:02 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 18:02:02 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 18:02:02 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 18:02:02 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 18:02:02 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 18:02:02 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 18:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:02:02 INFO - https://queue.taskcluster.net/v1/task/IkKXPF2XTIaV_zSbaYm1-g/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:02:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IkKXPF2XTIaV_zSbaYm1-g/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 18:02:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IkKXPF2XTIaV_zSbaYm1-g/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 18:02:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IkKXPF2XTIaV_zSbaYm1-g/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 18:02:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IkKXPF2XTIaV_zSbaYm1-g/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 18:02:03 INFO - Downloaded 17903431 bytes. 18:02:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:02:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 18:02:06 INFO - Return code: 0 18:02:06 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip', u'firefox-47.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 18:02:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:02:06 INFO - https://queue.taskcluster.net/v1/task/IkKXPF2XTIaV_zSbaYm1-g/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:02:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IkKXPF2XTIaV_zSbaYm1-g/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 18:02:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IkKXPF2XTIaV_zSbaYm1-g/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 18:02:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IkKXPF2XTIaV_zSbaYm1-g/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 18:02:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IkKXPF2XTIaV_zSbaYm1-g/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 18:02:08 INFO - Downloaded 17903431 bytes. 18:02:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:02:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 18:02:12 INFO - Return code: 0 18:02:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:02:12 INFO - https://queue.taskcluster.net/v1/task/IkKXPF2XTIaV_zSbaYm1-g/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 18:02:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IkKXPF2XTIaV_zSbaYm1-g/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 18:02:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IkKXPF2XTIaV_zSbaYm1-g/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 18:02:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IkKXPF2XTIaV_zSbaYm1-g/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip 18:02:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IkKXPF2XTIaV_zSbaYm1-g/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip'}, attempt #1 18:02:13 INFO - Downloaded 10845161 bytes. 18:02:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:02:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 18:02:13 INFO - Return code: 0 18:02: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')]} 18:02:13 INFO - https://queue.taskcluster.net/v1/task/IkKXPF2XTIaV_zSbaYm1-g/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 18:02:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IkKXPF2XTIaV_zSbaYm1-g/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 18:02:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IkKXPF2XTIaV_zSbaYm1-g/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 18:02:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IkKXPF2XTIaV_zSbaYm1-g/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 18:02:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IkKXPF2XTIaV_zSbaYm1-g/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg'}, attempt #1 18:02:16 INFO - Downloaded 115184081 bytes. 18:02:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IkKXPF2XTIaV_zSbaYm1-g/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 18:02:16 INFO - mkdir: /builds/slave/test/properties 18:02:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:02:16 INFO - Writing to file /builds/slave/test/properties/build_url 18:02:16 INFO - Contents: 18:02:16 INFO - build_url:https://queue.taskcluster.net/v1/task/IkKXPF2XTIaV_zSbaYm1-g/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 18:02:17 INFO - Running post-action listener: _resource_record_post_action 18:02:17 INFO - Running post-action listener: set_extra_try_arguments 18:02:17 INFO - ##### 18:02:17 INFO - ##### Running populate-webroot step. 18:02:17 INFO - ##### 18:02:17 INFO - Running pre-action listener: _resource_record_pre_action 18:02:17 INFO - Running main action method: populate_webroot 18:02:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:02:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:02:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:02:17 INFO - '--tppagecycles', 18:02:17 INFO - '7'], 18:02:17 INFO - 'tests': ['tsvgm']}}, 18:02:17 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:02:17 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:02:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:02:17 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 18:02:17 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:02:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:02:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:02:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:02:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:02:17 INFO - 'talos_options': ['--e10s'], 18:02:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:02:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:02:17 INFO - 'tests': ['damp', 'tps']}, 18:02:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:02:17 INFO - 'talos_options': ['--e10s'], 18:02:17 INFO - 'tests': ['damp', 'tps']}, 18:02:17 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:02:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:02:17 INFO - 'other': {'tests': ['a11yr', 18:02:17 INFO - 'ts_paint', 18:02:17 INFO - 'tpaint', 18:02:17 INFO - 'sessionrestore', 18:02:17 INFO - 'sessionrestore_no_auto_restore', 18:02:17 INFO - 'tabpaint']}, 18:02:17 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:02:17 INFO - 'tests': ['a11yr', 18:02:17 INFO - 'ts_paint', 18:02:17 INFO - 'tpaint', 18:02:17 INFO - 'sessionrestore', 18:02:17 INFO - 'sessionrestore_no_auto_restore', 18:02:17 INFO - 'tabpaint']}, 18:02:17 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:02:17 INFO - 'tests': ['a11yr', 18:02:17 INFO - 'ts_paint', 18:02:17 INFO - 'tpaint', 18:02:17 INFO - 'sessionrestore', 18:02:17 INFO - 'sessionrestore_no_auto_restore', 18:02:17 INFO - 'tabpaint']}, 18:02:17 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:02:17 INFO - 'tests': ['a11yr', 18:02:17 INFO - 'ts_paint', 18:02:17 INFO - 'tpaint', 18:02:17 INFO - 'sessionrestore', 18:02:17 INFO - 'sessionrestore_no_auto_restore', 18:02:17 INFO - 'tabpaint']}, 18:02:17 INFO - 'other_l64': {'tests': ['a11yr', 18:02:17 INFO - 'ts_paint', 18:02:17 INFO - 'tpaint', 18:02:17 INFO - 'sessionrestore', 18:02:17 INFO - 'sessionrestore_no_auto_restore', 18:02:17 INFO - 'tabpaint']}, 18:02:17 INFO - 'other_nol64': {'tests': ['a11yr', 18:02:17 INFO - 'ts_paint', 18:02:17 INFO - 'tpaint', 18:02:17 INFO - 'sessionrestore', 18:02:17 INFO - 'sessionrestore_no_auto_restore', 18:02:17 INFO - 'tabpaint']}, 18:02:17 INFO - 'svgr': {'tests': ['tsvgx', 18:02:17 INFO - 'tsvgr_opacity', 18:02:17 INFO - 'tart', 18:02:17 INFO - 'tscrollx', 18:02:17 INFO - 'cart']}, 18:02:17 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:02:17 INFO - 'tests': ['tsvgx', 18:02:17 INFO - 'tsvgr_opacity', 18:02:17 INFO - 'tart', 18:02:17 INFO - 'tscrollx', 18:02:17 INFO - 'cart']}, 18:02:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:02:17 INFO - 'tests': ['tp5o']}, 18:02:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:02:17 INFO - 'talos_options': ['--e10s'], 18:02:17 INFO - 'tests': ['tp5o']}, 18:02:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:02:17 INFO - 'talos_options': ['--xperf_path', 18:02:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:02:17 INFO - 'tests': ['tp5n']}, 18:02:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:02:17 INFO - 'talos_options': ['--e10s', 18:02:17 INFO - '--xperf_path', 18:02:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:02:17 INFO - 'tests': ['tp5n']}}, 18:02:17 INFO - 'talos.zip': {'path': '', 18:02:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:02:17 INFO - Running post-action listener: _resource_record_post_action 18:02:17 INFO - ##### 18:02:17 INFO - ##### Running create-virtualenv step. 18:02:17 INFO - ##### 18:02:17 INFO - Running pre-action listener: _resource_record_pre_action 18:02:17 INFO - Running main action method: create_virtualenv 18:02:17 INFO - Creating virtualenv /builds/slave/test/build/venv 18:02:17 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 18:02:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:02:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:02:17 INFO - Using real prefix '/tools/python27' 18:02:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:02:18 INFO - Installing distribute.............................................................................................................................................................................................done. 18:02:21 INFO - Installing pip.................done. 18:02:21 INFO - Return code: 0 18:02:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:02:21 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')]} 18:02:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:02:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:02:21 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')]} 18:02:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:02:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:02:21 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 0x1056e8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056ef4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f960156c590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10558cd30>, '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 0x1053f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105583b20>, '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.3hJ26QjEQ7/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.72gN0tdMii/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 18:02:21 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 18:02:21 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 18:02:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hJ26QjEQ7/Render', 18:02:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:02:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:02:21 INFO - 'HOME': '/Users/cltbld', 18:02:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:02:21 INFO - 'LOGNAME': 'cltbld', 18:02:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:02:21 INFO - 'MOZ_NO_REMOTE': '1', 18:02:21 INFO - 'NO_EM_RESTART': '1', 18:02:21 INFO - 'PAGER': '/bin/cat', 18:02:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:02:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:02:21 INFO - 'PWD': '/builds/slave/test', 18:02:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:02:21 INFO - 'SHELL': '/bin/bash', 18:02:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.72gN0tdMii/Listeners', 18:02:21 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 18:02:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:02:21 INFO - 'USER': 'cltbld', 18:02:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:02:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:02:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:02:21 INFO - 'XPC_FLAGS': '0x0', 18:02:21 INFO - 'XPC_SERVICE_NAME': '0', 18:02:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:02:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:02:21 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 18:02:21 INFO - Cleaning up... 18:02:21 INFO - Return code: 0 18:02:21 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:02:21 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')]} 18:02:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:02:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:02:21 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')]} 18:02:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:02:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:02:21 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 0x1056e8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056ef4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f960156c590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10558cd30>, '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 0x1053f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105583b20>, '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.3hJ26QjEQ7/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.72gN0tdMii/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 18:02:21 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 18:02:21 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 18:02:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hJ26QjEQ7/Render', 18:02:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:02:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:02:21 INFO - 'HOME': '/Users/cltbld', 18:02:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:02:21 INFO - 'LOGNAME': 'cltbld', 18:02:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:02:21 INFO - 'MOZ_NO_REMOTE': '1', 18:02:21 INFO - 'NO_EM_RESTART': '1', 18:02:21 INFO - 'PAGER': '/bin/cat', 18:02:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:02:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:02:21 INFO - 'PWD': '/builds/slave/test', 18:02:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:02:21 INFO - 'SHELL': '/bin/bash', 18:02:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.72gN0tdMii/Listeners', 18:02:21 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 18:02:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:02:21 INFO - 'USER': 'cltbld', 18:02:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:02:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:02:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:02:21 INFO - 'XPC_FLAGS': '0x0', 18:02:21 INFO - 'XPC_SERVICE_NAME': '0', 18:02:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:02:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:02:21 INFO - Downloading/unpacking psutil>=0.7.1 18:02:21 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 18:02:21 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 18:02:21 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 18:02:21 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 18:02:21 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 18:02:21 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 18:02:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:02:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:02:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:02:24 INFO - Installing collected packages: psutil 18:02:24 INFO - Running setup.py install for psutil 18:02:24 INFO - building 'psutil._psutil_osx' extension 18:02:24 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 18:02:24 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 18:02:25 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 18:02:25 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 18:02:25 INFO - building 'psutil._psutil_posix' extension 18:02:25 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 18:02:25 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:02:25 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:02:25 INFO - ^ 18:02:25 INFO - 1 warning generated. 18:02:25 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 18:02:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:02:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:02:25 INFO - Successfully installed psutil 18:02:25 INFO - Cleaning up... 18:02:25 INFO - Return code: 0 18:02:25 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:02:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:02:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:02:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:02:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:02:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:02:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:02:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1056e8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056ef4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f960156c590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10558cd30>, '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 0x1053f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105583b20>, '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.3hJ26QjEQ7/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.72gN0tdMii/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 18:02:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 18:02:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 18:02:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hJ26QjEQ7/Render', 18:02:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:02:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:02:25 INFO - 'HOME': '/Users/cltbld', 18:02:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:02:25 INFO - 'LOGNAME': 'cltbld', 18:02:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:02:25 INFO - 'MOZ_NO_REMOTE': '1', 18:02:25 INFO - 'NO_EM_RESTART': '1', 18:02:25 INFO - 'PAGER': '/bin/cat', 18:02:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:02:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:02:25 INFO - 'PWD': '/builds/slave/test', 18:02:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:02:25 INFO - 'SHELL': '/bin/bash', 18:02:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.72gN0tdMii/Listeners', 18:02:25 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 18:02:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:02:25 INFO - 'USER': 'cltbld', 18:02:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:02:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:02:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:02:25 INFO - 'XPC_FLAGS': '0x0', 18:02:25 INFO - 'XPC_SERVICE_NAME': '0', 18:02:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:02:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:02:25 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:02:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:02:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:02:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:02:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:02:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:02:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:02:28 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:02:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:02:28 INFO - Installing collected packages: mozsystemmonitor 18:02:28 INFO - Running setup.py install for mozsystemmonitor 18:02:28 INFO - Successfully installed mozsystemmonitor 18:02:28 INFO - Cleaning up... 18:02:28 INFO - Return code: 0 18:02:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:02: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')]} 18:02:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:02:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:02: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')]} 18:02:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:02:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:02:28 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 0x1056e8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056ef4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f960156c590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10558cd30>, '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 0x1053f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105583b20>, '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.3hJ26QjEQ7/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.72gN0tdMii/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 18:02:28 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 18:02:28 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 18:02:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hJ26QjEQ7/Render', 18:02:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:02:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:02:28 INFO - 'HOME': '/Users/cltbld', 18:02:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:02:28 INFO - 'LOGNAME': 'cltbld', 18:02:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:02:28 INFO - 'MOZ_NO_REMOTE': '1', 18:02:28 INFO - 'NO_EM_RESTART': '1', 18:02:28 INFO - 'PAGER': '/bin/cat', 18:02:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:02:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:02:28 INFO - 'PWD': '/builds/slave/test', 18:02:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:02:28 INFO - 'SHELL': '/bin/bash', 18:02:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.72gN0tdMii/Listeners', 18:02:28 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 18:02:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:02:28 INFO - 'USER': 'cltbld', 18:02:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:02:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:02:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:02:28 INFO - 'XPC_FLAGS': '0x0', 18:02:28 INFO - 'XPC_SERVICE_NAME': '0', 18:02:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:02:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:02:28 INFO - Downloading/unpacking blobuploader==1.2.4 18:02:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:02:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:02:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:02:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:02:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:02:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:02:31 INFO - Downloading blobuploader-1.2.4.tar.gz 18:02:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:02:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:02:31 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 18:02:31 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 18:02:31 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 18:02:31 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 18:02:31 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 18:02:31 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 18:02:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:02:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:02:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:02:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:02:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:02:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:02:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:02:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:02:32 INFO - Downloading docopt-0.6.1.tar.gz 18:02:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:02:32 INFO - Installing collected packages: blobuploader, requests, docopt 18:02:32 INFO - Running setup.py install for blobuploader 18:02:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:02:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:02:32 INFO - Running setup.py install for requests 18:02:33 INFO - Running setup.py install for docopt 18:02:33 INFO - Successfully installed blobuploader requests docopt 18:02:33 INFO - Cleaning up... 18:02:33 INFO - Return code: 0 18:02:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:02:33 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')]} 18:02:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:02:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:02:33 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')]} 18:02:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:02:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:02:33 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 0x1056e8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056ef4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f960156c590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10558cd30>, '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 0x1053f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105583b20>, '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.3hJ26QjEQ7/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.72gN0tdMii/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 18:02:33 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 18:02:33 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 18:02:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hJ26QjEQ7/Render', 18:02:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:02:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:02:33 INFO - 'HOME': '/Users/cltbld', 18:02:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:02:33 INFO - 'LOGNAME': 'cltbld', 18:02:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:02:33 INFO - 'MOZ_NO_REMOTE': '1', 18:02:33 INFO - 'NO_EM_RESTART': '1', 18:02:33 INFO - 'PAGER': '/bin/cat', 18:02:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:02:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:02:33 INFO - 'PWD': '/builds/slave/test', 18:02:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:02:33 INFO - 'SHELL': '/bin/bash', 18:02:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.72gN0tdMii/Listeners', 18:02:33 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 18:02:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:02:33 INFO - 'USER': 'cltbld', 18:02:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:02:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:02:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:02:33 INFO - 'XPC_FLAGS': '0x0', 18:02:33 INFO - 'XPC_SERVICE_NAME': '0', 18:02:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:02:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:02:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:02:33 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-BBb6rZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:02:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:02:33 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-UWu5Rv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:02:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:02:33 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-d3ie8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:02:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:02:33 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-V06cq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:02:34 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-BjP7nO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:02:34 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-s0wWiX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:02:34 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-ZF2xAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:02:34 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-mCmwSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:02:34 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-G8Dar7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:02:34 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-2UkArI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:02:34 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-i2CwVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:02:34 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-EIeIni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:02:34 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-3TLtSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:02:35 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-X0LlEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:02:35 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-nUuQZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:02:35 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-A4WagB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:02:35 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-HFvsCW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:02:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:02:35 INFO - Running setup.py install for manifestparser 18:02:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:02:35 INFO - Running setup.py install for mozcrash 18:02:35 INFO - Running setup.py install for mozdebug 18:02:35 INFO - Running setup.py install for mozdevice 18:02:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:02:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:02:36 INFO - Running setup.py install for mozfile 18:02:36 INFO - Running setup.py install for mozhttpd 18:02:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:02:36 INFO - Running setup.py install for mozinfo 18:02:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:02:36 INFO - Running setup.py install for mozInstall 18:02:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:02:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:02:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:02:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:02:36 INFO - Running setup.py install for mozleak 18:02:36 INFO - Running setup.py install for mozlog 18:02:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:02:36 INFO - Running setup.py install for moznetwork 18:02:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:02:37 INFO - Running setup.py install for mozprocess 18:02:37 INFO - Running setup.py install for mozprofile 18:02:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:02:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:02:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:02:37 INFO - Running setup.py install for mozrunner 18:02:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:02:37 INFO - Running setup.py install for mozscreenshot 18:02:37 INFO - Running setup.py install for moztest 18:02:37 INFO - Running setup.py install for mozversion 18:02:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:02:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:02:37 INFO - Cleaning up... 18:02:38 INFO - Return code: 0 18:02:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:02: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')]} 18:02:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:02:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:02: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')]} 18:02:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:02:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:02:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1056e8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056ef4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f960156c590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10558cd30>, '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 0x1053f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105583b20>, '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.3hJ26QjEQ7/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.72gN0tdMii/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 18:02:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:02:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:02:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hJ26QjEQ7/Render', 18:02:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:02:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:02:38 INFO - 'HOME': '/Users/cltbld', 18:02:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:02:38 INFO - 'LOGNAME': 'cltbld', 18:02:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:02:38 INFO - 'MOZ_NO_REMOTE': '1', 18:02:38 INFO - 'NO_EM_RESTART': '1', 18:02:38 INFO - 'PAGER': '/bin/cat', 18:02:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:02:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:02:38 INFO - 'PWD': '/builds/slave/test', 18:02:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:02:38 INFO - 'SHELL': '/bin/bash', 18:02:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.72gN0tdMii/Listeners', 18:02:38 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 18:02:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:02:38 INFO - 'USER': 'cltbld', 18:02:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:02:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:02:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:02:38 INFO - 'XPC_FLAGS': '0x0', 18:02:38 INFO - 'XPC_SERVICE_NAME': '0', 18:02:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:02:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:02:38 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-OkrIjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:02:38 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)) 18:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:02:38 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-DQwO0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:02:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 18:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:02:38 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-xGzqte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:02:38 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)) 18:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:02:38 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-vgZVIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:02:38 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)) 18:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:02:38 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-i67eAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:02:38 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)) 18:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:02:38 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-zipWy6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:02:38 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)) 18:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:02:38 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-1thmPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:02:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:02:39 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-xjVHkw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:02:39 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)) 18:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:02:39 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-LCJFsF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:02:39 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)) 18:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:02:39 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-Xf_3wk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:02:39 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)) 18:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:02:39 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-e_DaNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:02:39 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)) 18:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:02:39 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-OruhsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:02:39 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)) 18:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:02:39 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-sxd_Ef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:02:39 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)) 18:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:02:39 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-Bo3PX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:02:39 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)) 18:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:02:39 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-eda6ue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:02:39 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)) 18:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:02:39 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-s_PE3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:02:39 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)) 18:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:02:39 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-mJLFNc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:02:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:02:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:02:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:02:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:02:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:02:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:02:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:02:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:02:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:02:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:02:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:02:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:02:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:02:42 INFO - Downloading blessings-1.6.tar.gz 18:02:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:02:42 INFO - Installing collected packages: blessings 18:02:42 INFO - Running setup.py install for blessings 18:02:42 INFO - Successfully installed blessings 18:02:42 INFO - Cleaning up... 18:02:42 INFO - Return code: 0 18:02:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:02:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:02:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:02:43 INFO - Reading from file tmpfile_stdout 18:02:43 INFO - Current package versions: 18:02:43 INFO - blessings == 1.6 18:02:43 INFO - blobuploader == 1.2.4 18:02:43 INFO - docopt == 0.6.1 18:02:43 INFO - manifestparser == 1.1 18:02:43 INFO - mozInstall == 1.12 18:02:43 INFO - mozcrash == 0.17 18:02:43 INFO - mozdebug == 0.1 18:02:43 INFO - mozdevice == 0.48 18:02:43 INFO - mozfile == 1.2 18:02:43 INFO - mozhttpd == 0.7 18:02:43 INFO - mozinfo == 0.9 18:02:43 INFO - mozleak == 0.1 18:02:43 INFO - mozlog == 3.1 18:02:43 INFO - moznetwork == 0.27 18:02:43 INFO - mozprocess == 0.22 18:02:43 INFO - mozprofile == 0.28 18:02:43 INFO - mozrunner == 6.11 18:02:43 INFO - mozscreenshot == 0.1 18:02:43 INFO - mozsystemmonitor == 0.0 18:02:43 INFO - moztest == 0.7 18:02:43 INFO - mozversion == 1.4 18:02:43 INFO - psutil == 3.1.1 18:02:43 INFO - requests == 1.2.3 18:02:43 INFO - wsgiref == 0.1.2 18:02:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:02:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:02:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:02:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:02:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:02:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:02:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:02:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1056e8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056ef4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f960156c590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10558cd30>, '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 0x1053f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105583b20>, '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.3hJ26QjEQ7/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.72gN0tdMii/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 18:02:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:02:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:02:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hJ26QjEQ7/Render', 18:02:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:02:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:02:43 INFO - 'HOME': '/Users/cltbld', 18:02:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:02:43 INFO - 'LOGNAME': 'cltbld', 18:02:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:02:43 INFO - 'MOZ_NO_REMOTE': '1', 18:02:43 INFO - 'NO_EM_RESTART': '1', 18:02:43 INFO - 'PAGER': '/bin/cat', 18:02:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:02:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:02:43 INFO - 'PWD': '/builds/slave/test', 18:02:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:02:43 INFO - 'SHELL': '/bin/bash', 18:02:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.72gN0tdMii/Listeners', 18:02:43 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 18:02:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:02:43 INFO - 'USER': 'cltbld', 18:02:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:02:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:02:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:02:43 INFO - 'XPC_FLAGS': '0x0', 18:02:43 INFO - 'XPC_SERVICE_NAME': '0', 18:02:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:02:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:02:43 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)) 18:02:43 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)) 18:02:43 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)) 18:02:43 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)) 18:02:43 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)) 18:02:43 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)) 18:02:43 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)) 18:02:43 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)) 18:02:43 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)) 18:02:43 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)) 18:02:43 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)) 18:02:43 INFO - Cleaning up... 18:02:43 INFO - Return code: 0 18:02:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:02:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:02:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:02:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:02:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:02:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:02:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:02:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1056e8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056ef4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f960156c590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10558cd30>, '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 0x1053f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105583b20>, '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.3hJ26QjEQ7/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.72gN0tdMii/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 18:02:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:02:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:02:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hJ26QjEQ7/Render', 18:02:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:02:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:02:43 INFO - 'HOME': '/Users/cltbld', 18:02:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:02:43 INFO - 'LOGNAME': 'cltbld', 18:02:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:02:43 INFO - 'MOZ_NO_REMOTE': '1', 18:02:43 INFO - 'NO_EM_RESTART': '1', 18:02:43 INFO - 'PAGER': '/bin/cat', 18:02:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:02:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:02:43 INFO - 'PWD': '/builds/slave/test', 18:02:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:02:43 INFO - 'SHELL': '/bin/bash', 18:02:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.72gN0tdMii/Listeners', 18:02:43 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 18:02:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:02:43 INFO - 'USER': 'cltbld', 18:02:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:02:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:02:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:02:43 INFO - 'XPC_FLAGS': '0x0', 18:02:43 INFO - 'XPC_SERVICE_NAME': '0', 18:02:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:02:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:02:43 INFO - Downloading/unpacking jsonschema 18:02:43 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 18:02:43 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 18:02:43 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 18:02:43 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 18:02:43 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 18:02:43 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 18:02:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:02:46 INFO - Downloading/unpacking functools32 (from jsonschema) 18:02:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:02:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:02:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:02:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:02:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:02:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:02:46 INFO - Downloading functools32-3.2.3-2.tar.gz 18:02:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:02:46 INFO - warning: no files found matching '*.txt' 18:02:46 INFO - no previously-included directories found matching 'build' 18:02:46 INFO - no previously-included directories found matching 'dist' 18:02:46 INFO - no previously-included directories found matching '.git*' 18:02:46 INFO - Installing collected packages: jsonschema, functools32 18:02:46 INFO - Running setup.py install for functools32 18:02:46 INFO - warning: no files found matching '*.txt' 18:02:46 INFO - no previously-included directories found matching 'build' 18:02:46 INFO - no previously-included directories found matching 'dist' 18:02:46 INFO - no previously-included directories found matching '.git*' 18:02:46 INFO - Successfully installed jsonschema functools32 18:02:46 INFO - Cleaning up... 18:02:46 INFO - Return code: 0 18:02:46 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:02:46 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')]} 18:02:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:02:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:02:46 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')]} 18:02:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:02:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:02:46 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 0x1056e8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056ef4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f960156c590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10558cd30>, '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 0x1053f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105583b20>, '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.3hJ26QjEQ7/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.72gN0tdMii/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 18:02:46 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 18:02:46 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 18:02:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hJ26QjEQ7/Render', 18:02:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:02:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:02:46 INFO - 'HOME': '/Users/cltbld', 18:02:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:02:46 INFO - 'LOGNAME': 'cltbld', 18:02:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:02:46 INFO - 'MOZ_NO_REMOTE': '1', 18:02:46 INFO - 'NO_EM_RESTART': '1', 18:02:46 INFO - 'PAGER': '/bin/cat', 18:02:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:02:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:02:46 INFO - 'PWD': '/builds/slave/test', 18:02:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:02:46 INFO - 'SHELL': '/bin/bash', 18:02:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.72gN0tdMii/Listeners', 18:02:46 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 18:02:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:02:46 INFO - 'USER': 'cltbld', 18:02:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:02:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:02:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:02:46 INFO - 'XPC_FLAGS': '0x0', 18:02:46 INFO - 'XPC_SERVICE_NAME': '0', 18:02:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:02:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:02:47 INFO - Downloading/unpacking flake8 18:02: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 18:02: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 18:02: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 18:02: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 18:02: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 18:02: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 18:02:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:02:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:02:49 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 18:02:49 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 18:02:49 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 18:02:49 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 18:02:49 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 18:02:49 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 18:02:49 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:02:49 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:02:49 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 18:02:49 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 18:02:49 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 18:02:49 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 18:02:49 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 18:02:49 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 18:02:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:02:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:02:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:02:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:02:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:02:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:02:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:02:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:02:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:02:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:02:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:02:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:02:50 INFO - no previously-included directories found matching 'docs/_build' 18:02:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:02:50 INFO - Running setup.py install for pep8 18:02:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:02:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:02:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:02:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:02:50 INFO - no previously-included directories found matching 'docs/_build' 18:02:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:02:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:02:51 INFO - Cleaning up... 18:02:51 INFO - Return code: 0 18:02:51 INFO - Running post-action listener: _resource_record_post_action 18:02:51 INFO - Running post-action listener: _start_resource_monitoring 18:02:51 INFO - Starting resource monitoring. 18:02:51 INFO - ##### 18:02:51 INFO - ##### Running install step. 18:02:51 INFO - ##### 18:02:51 INFO - Running pre-action listener: _resource_record_pre_action 18:02:51 INFO - Running main action method: install 18:02:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:02:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:02:51 INFO - Reading from file tmpfile_stdout 18:02:51 INFO - Detecting whether we're running mozinstall >=1.0... 18:02:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:02:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:02:51 INFO - Reading from file tmpfile_stdout 18:02:51 INFO - Output received: 18:02:51 INFO - Usage: mozinstall [options] installer 18:02:51 INFO - Options: 18:02:51 INFO - -h, --help show this help message and exit 18:02:51 INFO - -d DEST, --destination=DEST 18:02:51 INFO - Directory to install application into. [default: 18:02:51 INFO - "/builds/slave/test"] 18:02:51 INFO - --app=APP Application being installed. [default: firefox] 18:02:51 INFO - mkdir: /builds/slave/test/build/application 18:02:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 18:02:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 18:03:23 INFO - Reading from file tmpfile_stdout 18:03:23 INFO - Output received: 18:03:23 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 18:03:23 INFO - Running post-action listener: _resource_record_post_action 18:03:23 INFO - ##### 18:03:23 INFO - ##### Running run-tests step. 18:03:23 INFO - ##### 18:03:23 INFO - Running pre-action listener: _resource_record_pre_action 18:03:23 INFO - Running main action method: run_tests 18:03:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:03:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:03:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:03:23 INFO - 2016-04-04 18:03:23.088 screenresolution[1640:7510] starting screenresolution argv=screenresolution get 18:03:23 INFO - 2016-04-04 18:03:23.091 screenresolution[1640:7510] Display 0: 1600x1200x32@60 18:03:23 INFO - 2016-04-04 18:03:23.097 screenresolution[1641:7513] starting screenresolution argv=screenresolution list 18:03:23 INFO - Available Modes on Display 0 18:03:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:03:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:03:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:03:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:03:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:03:23 INFO - Intel Iris: 18:03:23 INFO - Chipset Model: Intel Iris 18:03:23 INFO - Type: GPU 18:03:23 INFO - Bus: Built-In 18:03:23 INFO - VRAM (Dynamic, Max): 1536 MB 18:03:23 INFO - Vendor: Intel (0x8086) 18:03:23 INFO - Device ID: 0x0a2e 18:03:23 INFO - Revision ID: 0x0009 18:03:23 INFO - Displays: 18:03:23 INFO - Display: 18:03:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:03:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:03:23 INFO - Display Serial Number: 1600x1200 60 18:03:23 INFO - Main Display: Yes 18:03:23 INFO - Mirror: Off 18:03:23 INFO - Online: Yes 18:03:23 INFO - Rotation: Supported 18:03:23 INFO - Return code: 0 18:03:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:03:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:03:23 INFO - Python 2.7.3 18:03:23 INFO - Return code: 0 18:03:23 INFO - grabbing minidump binary from tooltool 18:03:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:03:23 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 0x10558cd30>, '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 0x1053f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105583b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:03:23 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 18:03:23 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 18:03:23 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:03:23 INFO - Return code: 0 18:03:23 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:03:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:03:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:03:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:03:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:03:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:03:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:03:24 INFO - Return code: 0 18:03:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IkKXPF2XTIaV_zSbaYm1-g/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0078', '--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 18:03:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IkKXPF2XTIaV_zSbaYm1-g/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0078 --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 18:03:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hJ26QjEQ7/Render', 18:03:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:03:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:03:24 INFO - 'HOME': '/Users/cltbld', 18:03:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:03:24 INFO - 'LOGNAME': 'cltbld', 18:03:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:03:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:03:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:03:24 INFO - 'MOZ_NO_REMOTE': '1', 18:03:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:03:24 INFO - 'NO_EM_RESTART': '1', 18:03:24 INFO - 'PAGER': '/bin/cat', 18:03:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:03:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:03:24 INFO - 'PWD': '/builds/slave/test', 18:03:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:03:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:03:24 INFO - 'SHELL': '/bin/bash', 18:03:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.72gN0tdMii/Listeners', 18:03:24 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 18:03:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:03:24 INFO - 'USER': 'cltbld', 18:03:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:03:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:03:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:03:24 INFO - 'XPC_FLAGS': '0x0', 18:03:24 INFO - 'XPC_SERVICE_NAME': '0', 18:03:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:03:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IkKXPF2XTIaV_zSbaYm1-g/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0078', '--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 18:03:24 INFO - mozversion application_buildid: 20160404155841 18:03:24 INFO - mozversion application_changeset: a57a4c6df00d0ffaa35b2abc1e388c691c9eb514 18:03:24 INFO - mozversion application_display_name: FirefoxDeveloperEdition 18:03:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:03:24 INFO - mozversion application_name: Firefox 18:03:24 INFO - mozversion application_remotingname: firefox-dev 18:03:24 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:03:24 INFO - mozversion application_vendor: Mozilla 18:03:24 INFO - mozversion application_version: 47.0a2 18:03:24 INFO - mozversion platform_buildid: 20160404155841 18:03:24 INFO - mozversion platform_changeset: a57a4c6df00d0ffaa35b2abc1e388c691c9eb514 18:03:24 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:03:24 INFO - mozversion platform_version: 47.0a2 18:03:24 INFO - using testdate: 1459818204 18:03:24 INFO - actual date: 1459818204 18:03:24 INFO - starting webserver on 'localhost:49271' 18:03:24 INFO - SUITE-START | Running 2 tests 18:03:24 INFO - TEST-START | dromaeo_css 18:03:24 INFO - operating with platform_type : mac_ 18:03:24 INFO - Initialising browser for dromaeo_css test... 18:03:24 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/tmpl0Uf_E/profile http://localhost:49271/getInfo.html) 18:03:27 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 18:03:27 INFO - PROCESS | 1659 | colorDepth:24 18:03:27 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 18:03:27 INFO - PROCESS | 1659 | __metrics 18:03:27 INFO - PROCESS | 1659 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:03:27 INFO - PROCESS | 1659 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:03:27 INFO - TEST-INFO | 1659: exit 0 18:03:27 INFO - Browser initialized. 18:03:27 INFO - Running cycle 1/1 for dromaeo_css test... 18:03:27 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/tmpl0Uf_E/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:03:39 INFO - PROCESS | 1661 | RSS: Main: 207892480 18:03:39 INFO - PROCESS | 1661 | 18:04:30 INFO - PROCESS | 1661 | 1459818270874 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] 18:06:40 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 18:06:41 INFO - PROCESS | 1661 | RSS: Main: 331739136 18:06:41 INFO - PROCESS | 1661 | 18:09:44 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 18:09:44 INFO - PROCESS | 1661 | RSS: Main: 345587712 18:09:44 INFO - PROCESS | 1661 | 18:12:46 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 18:12:47 INFO - PROCESS | 1661 | RSS: Main: 344096768 18:12:47 INFO - PROCESS | 1661 | 18:15:49 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 18:15:50 INFO - PROCESS | 1661 | RSS: Main: 304439296 18:15:50 INFO - PROCESS | 1661 | 18:18:53 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 18:18:53 INFO - PROCESS | 1661 | RSS: Main: 306880512 18:18:53 INFO - PROCESS | 1661 | 18:21:56 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 18:21:56 INFO - PROCESS | 1661 | RSS: Main: 353435648 18:21:56 INFO - PROCESS | 1661 | 18:21:56 INFO - PROCESS | 1661 | __start_tp_report 18:21:56 INFO - PROCESS | 1661 | _x_x_mozilla_page_load 18:21:56 INFO - PROCESS | 1661 | _x_x_mozilla_page_load_details 18:21:56 INFO - PROCESS | 1661 | |i|pagename|runs| 18:21:56 INFO - PROCESS | 1661 | |0;dojo.html;3417.9487307690383;3469.6009958854725;3501.492283618874;3513.8770143045;3556.4665300204965;4761.761911904404;5596.916046259309;5677.233573467581;5703.372629010805;5718.542516598673;4668.6731928765;5720.713964301779;5726.284214473191;5748.02283611786;5755.136729490579;4947.233178857283;5033;5150.27896094547;5157.123289040872;5196.012757576049;4975.0796102721115;5001.524855138756;5008.4240312364;5015.523525265094;5020.221865610836;5148.742562871841;5199.298094757197;5220.112580861262;5221.034108689885;5231.921521177185;4640.187967105743;5214.556762675177;5245.842624721265;5257.185136303879;5309.946900531003;5135.075686376451;5157.5616072633875;5171.870703232412;5177.611679124081;5178.352705911761;5633;5665.461781130827;5669.744861481243;5691.7723291068305;5709.115087161496;6109.283207920386;6147.524594097385;6204.565680402374;6270.184875966141;6280.246370435577;6240.344763799781;6289.937100629027;6314.958031924727;6316.74733010679;6325;5788.218590490314;5793.971030144864;5810.564207684441;5813.215215945877;5815.53475721937;5332.840014799563;6216.906746398808;6250.874982500324;6299.874002519924;6321.304656487782;5141.460146684544;6152.846178845564;6158.599691020069;6173.938260617426;6174.753009879554;6262.874742505124;6284.937150628527;6287.748490060438;6288.52836037299;6292.779752708633;6055.333913269536;6100.420460056288;6132.5321648516665;6246.125542424064;6261.96869015652;6224.408681175281;6248.843778905563;6254.781082662176;6269.122322874801;6288.811335659938;4906.828261010919;4934.5312195341385;4943.752812359367;4955.72743499111;5016.849494515171;4323;4351.216780979454;4398.098389830077;4474.865754027384;4504.391907092566;4791.233402655558;5723;5726.3700992890745;5731.398203188605;5746.166805813134;5210.322658054504;6288.8427789304715;6304.71628776697;6320.62076275425;6334.5249106317215;5574.916376254359;5657.8019769307875;5725.885482290331;5740.971295143498;5751.827445176651;5308.734563271821;5369.597280203922;5382.4886635769535;5387.434319396407;5394.271773310631;5422.810201642924;6250.718717657625;6320.083587879732;6334.619922804646;6385.840353991188;5269.631125821309;6249.906251406142;6294.622322660655;6325.905111423241;6354.491640668828;6307.96846015767;6341.175647166024;6360.459360954371;6361.681915904279;6362.109304697438;6006.609570377911;6116.39664026098;6225.470834979077;6227.221597300338;6258.561900666909;6213.409726076015;6220.34686357944;6291.276503202007;6297.4017468340435;6310.211223597051;6029.457348838626;6101.450869421773;6103.328633850362;6104.786332478342;6109.20580324555;5918.526517878646;6045.637261764308;6097.847553811191;6099.207103076572;6140.662263575547;5879.5002424792665;5883.794067207627;5891.116332550152;5901.822945311647;5911.645301281765;6050;6075.635461872125;6082.60463069899;6121.238404290834;6137.974468425319;5785.855353616025;5825.533957283492;5888;5918.822435326947;5996 18:21:56 INFO - PROCESS | 1661 | |1;ext.html;496.03273616447893;605.3825098399633;625.4183609243405;664.8431728791902;675.7599804359;26788;33281.33437331252;40819;41084.79457602708;41234.38148427776;36628.63371366286;44949.10101797962;45137.54862451374;45350.866228344305;45424;9624.133827955466;9860.359076659994;9869.654562090329;9894.455804930725;9898.307118501707;9580.137787599115;9718.56266468007;9733.610655573768;9738.318317717763;9739;9693.70918872435;9768.951155244215;9873.654422095193;9878.851817222747;9903.900960990406;9764.218862490983;9835.360701554377;9850.310478266525;9856.162226210708;9891.406515609087;9789.412635241908;9910.306278560503;9917.404955702608;9929.056739609725;9943.154831839302;42916.57083429157;43283.783581081894;43477.130457390675;43489.56510434887;43747;2893.6816950135467;2928.297208669925;3206.2625596112794;3422.058933793202;3843.2121415110114;27971.860140699166;29721.70278297211;29729.40541189164;30070.54894176589;30660.540091898638;2777.9444411111663;2795.0636536760207;2852.343960888986;2869.8421586812715;2910.3451723362286;494246;503420;507261;508140;508417;51579;75392;76052.71841844753;76115;76118.61940690261;54632;54834.72582637141;54927.450725492236;54929.72535137379;54933;17658.852174608608;17998.640027199384;18033.7294940576;18044.00757958325;18062.09689515519;14163.78754318686;14300.928495357457;14313.212773297568;14323.856761432253;14339.641508962359;16567.66864662724;16600.66798664044;16603.83396166047;16622.833771662128;16637.33450661984;6934.965325173342;7016.789496315118;7054.2945705430075;7063.929360706327;7074.504784665024;919.5034681272039;951.7002144324654;973.4354074636693;1022.0545994954638;1055.0451841083832;26434.6034809478;29794;30655.540166897514;31292;31635.84182079075;1037.5745944162857;1096.276457538037;1105.5025238642643;1235.43170141734;1240.8386909701862;13453.798193027113;15664;15858.365665373487;15883.444079457164;16027.278772455034;535482;539054;540601;541980;542784;44387.33418998653;60814.695926520966;63409.36590634035;63812.08563743095;63983.6800815993;1239.6776838022179;1425.5509514502899;1522.5508474999901;1533.8006059212455;1535.293764868151;29371.55942660819;31136;32511.34977300488;34155.65844341525;34292.657073429946;60458;60883.69558152181;61549.69225153846;61599.384006161155;61676;495817.5209123931;500595;502209;502275;504070;39354.01614959534;47546.52453475421;48181.86817856828;48676.75661621669;49471;45408;45560;45700.314495281935;46273.074538508365;46832.53167468282;36948.261034779694;37189.88430347094;37428.81285593555;37591.2481750358;38018;32700;38094.809525952194;39192.412113818886;39298.01754956149;40199.59800401959;38700.03249918774;38879;38957;39092;39837;33989.66010339964;34121;34864.65135348614;34919.777807776605;34962.65037349696;25903;25938.400638911164;25980.090696825522;26261.212163635122;26439.603405948543 18:21:56 INFO - PROCESS | 1661 | |2;jquery.html;356.7859284429342;381.80909545227377;382.2794033247328;386.5573917864044;390.0288282177379;16333.83666163341;16807.91596042018;20097.86891917377;20855.27006554769;21427.464313392175;16642.08468534233;19748.30880919168;20377.49056273594;20549.691754623655;20691.275805346817;5119.206522988943;5810.82567522975;5994.820155395345;6012.549058820584;6028.758849646031;6006.1591377207005;6054.576179667425;6065.181200537937;6077.544184186182;6091.482224010942;5823.708814559255;5888.470037696607;6006.669633170174;6010.158577799111;6011.57918945674;5984.3417224105315;6024.8493787655225;6026.3069746979;6028.849278768022;6032.396760323976;5013.874653133665;5093.898122037575;5168.095583272912;5176.8964620707375;5185.351831021122;19510.609787804166;24870.005199791987;25591.488170236677;25646.84589193472;25809.483810323876;2145.8283337332978;2278.2026290798253;2391.9162829301067;2566.6021766626204;2748.1068652687954;14574.198419086946;14578.271086445742;14675;14799.11205327673;14988.625284367869;1621.562178211888;1691.4840973503076;1714.9571260718458;1751.30823324786;1800.4958611588777;85406;100439;105812.47093764482;106513.93486065118;111308.4434577822;10305.227107966932;10494;10701.83947240792;10716.089132423675;10834.945825270823;12149.574764883364;12615;13336.266505342299;13362.665933351549;13368.197908125543;8502.234798868009;8738.69414570487;8746.300295976307;8849.4247873888;8866.246369058574;9137.862932056025;9147.359684821999;9147.359684822131;9181.219596334386;9223.53882305882;6043;6086.908696369558;6109.419605137505;6111.297200821873;6111.358307377662;1814.5121000779234;1822.7903791064198;1837.2283640870867;1838.9448316550524;1840.18111940188;846.3905987688854;965.8164948659733;979.5543027922421;1084.2843723142846;1133.9149563782748;18693.626127477648;19539;20242.797572024385;20374.388768336972;21020.369388918356;918.8024574716468;1024.144839059379;1055.904968552834;1057.3021805608416;1060.04066319979;9129.863052054225;9734.464604446683;11104.333739975627;11511.136664750176;11558.364289964133;640942;643752;651078.744606274;658106;659369;102814.48592756988;106179.469102654;106235.40646890303;108094.3785843213;109414;1081.4592703648175;1085.6688709943385;1105.4196546812987;1108.3294606762954;1112.3937454087543;18196.90901545484;18390.804597701106;18532.166052527937;18642.813571864106;18702.719459207852;47407;47666;50055.49944500509;50182;50474.24288635747;50018.749906251694;64945.35054649393;67714;68816.65591672009;69606;7802.804929876798;7968.163342848918;7985.5208687478935;8174;8360.12218717026;12844.293563854078;13105.803412949004;13255;13433.395497202844;13468.326583670972;11552.711182220512;11639.825402618799;11778.882211177779;11905.761884762429;11971.940140299243;11368;11372.260803047775;11440.370779607201;11753.647390578297;11913.940430297793;11813.527458901548;11844.585439509921;12020.398980051137;12029.338386388832;12076.637700868989;7719.652615632423;8133.67465301405;8185.222403871623;8303.377246706643;8480.491170529787;10319.380837149794;11610;11867.881321186678;11904.464299106734;11927.522899083939 18:21:56 INFO - PROCESS | 1661 | |3;mootools.html;1500.5723368839883;1638.2627817482132;1658.3449537432714;1987.2647120565393;2039.9796002039984;8206.302464290535;8866.822663546725;9026.458412495254;9029.864552031724;9040.502772347518;8690.73927782166;8905.732828015154;8936.55317234139;8937.374383793138;8942.016378198408;2119.1735223262863;2497.6877890263763;2536.175742883561;2538.0355464923305;2542.8220024598286;2493.2769496845895;2528.962065569018;2532.189699296226;2537.5178716043984;2547.936301592466;2238.82089432845;2480.045182604692;2508.7240403555593;2535.2521006303186;2546.719860815309;2121.459027947879;2490.5766019776684;2524.179641616473;2524.4320027993645;2535.7210706822234;2461.9261422157365;2499.3501689560844;2499.6250562415603;2499.762522560354;2541.009006487471;8647.481151130953;8890.06654301302;8980.19178273952;9052.954735226347;9060.411073280216;5464.9453505464835;5636.520895723868;5678.801241956512;5683.403242659544;5690.174924635905;3580.946285805715;3689.944650830213;3700.481932529421;3739.66343029126;3754.0239537720117;1043.6764602973103;1058.4972138234355;1063.8829728729834;1074.5379486820664;1101.5483651702764;11958.402079896057;12290.877091229062;12302.753944921142;12315.876841231562;12322.630321090382;4776.3644636109875;4810.062037902575;4822.541858523435;4834.129856625841;4898;9637.036296370306;9637.18083962857;9640.276979226446;9643.758906027266;9649.179819715402;5543.057680194376;5549.334079910436;5555.055640541118;5561.499465048165;5562.471565201299;4535.138323718483;4714;4914.754262286871;5097.388313402415;5149.922751158736;3836.1943991761486;3879.321118804198;3887.2031233597045;3915.1778126593736;3944.8422063117728;1207.8007128823822;1219.6584956212098;1228.4103630257525;1238.0838179746922;1239.900807935381;1014.2241185493103;1054.920880933933;1209.0992210802833;1328.2893651896188;1464.545990742873;8278.793030174173;8296.792580185424;8302.750917472486;8333.499990000619;8367.497950123012;624.5097598385246;639.6769631336145;642.399356601579;648.0570769530322;797.2904115337354;6067.939320606825;6324.367563243731;6326.272478665012;6329.936700633027;6330.430261276507;10736.248462607542;11108.389038602792;11119.110471162288;11236.438178091063;11325.508388154592;11152.275102118336;11156.107511399068;11243.156763242789;11286;11292;8377.204165604258;8613.78465538354;8656.307495400353;8705.825883482295;8717.825643486967;8097.878531822145;8134.75595732129;8135.064467586303;8141.552214628252;8190.549519776231;9650.613975440903;9850;9964.10323070898;10057;10077.647282345082;8642.524661143698;10054.396736195851;10205.489725513844;10306.793864122825;10316.793664126826;7126.966589844547;7130.465215108784;7168.784936451915;7201.2438693938475;7214.74748383804;8296.65133367339;8461.576921154041;8467.15328467173;8501.277391421798;8544;6241.43827055549;7473.850522989618;7572.8485430292185;7707.152213256425;7737.458377913492;7219.494635375683;7300.233475484997;7327.706891724484;7346.375558077623;7403.18564957865;7889.2110788920645;7974.5215287082965;7978.361731061617;7981.561014144278;7989;6917.792466226021;7112.57324560528;7189.964050179716;7194.928050719635;7196.280371962762;7222.169450513258;7327.523710958983;7332.23011583776;7359.77920662381;7370.852582948204 18:21:56 INFO - PROCESS | 1661 | |4;prototype.html;331.2497193855916;333.0856798089245;338.82381161795854;339.4687314353037;342.6419391735636;6606.3063378345305;6696.48881669374;6705.161854768154;6718.764843230488;6739.494537909652;6239.65681887496;6828.726850925969;6836.350546698068;6838.794836154923;6851.486138539617;4768.403949506312;4795.496472870351;4806.990531988269;4873.342098816667;4974.950250497494;4863.610911127119;4882.536159064884;4885.902281954376;4918.926216106744;4938.580220681247;4875.049365373736;4879.487653796354;4881.414230292352;4881.438634557018;4889.462159162489;3915.8042097895277;4615.907681846361;4729.47975722672;4829.806807727687;4859.781309841065;3403.302323023774;3621.2214373909474;4159.7920103994675;4166.604172603597;4168.374743788426;5323;6049.395060493959;6373.681315934231;6396.2964073951825;6403.103565500834;5805.477507024388;5812.564057695689;5815.767369305223;5829.154772557998;5837.678927658977;7066.681999309992;7067.328603782633;7081.575105493635;7082.397996170332;7086.185088714812;4505.301678239878;4737.715737055788;4762.1428142934255;4762.523747625244;4779.283107533863;7329.926700732978;7515.398768098594;7517.5113617615225;7533.849323013618;7544.019277493946;4836.056968891103;4839.661223714376;4850.320955066293;4859.34398856157;4864.173090574611;4901.877453063631;4916.287138364917;4925.285833554115;4927.260910863328;4928.162212423825;5847.970760146257;5851.922567488566;5864.413558644187;5873.148393482921;5874;5469.261649677323;6991;7015.579065255999;7016.228214896358;7019.29807019294;1312.7308901675133;1665.950021499357;1703.5059832648642;1703.9914800425918;1704.3608646757466;1036.8237399642078;1070.3096502755834;1091.683411810566;1094.1192340166083;1127.7349822791637;6509.511786616023;6697.6986035628515;6707.3628005339415;6707.731690732316;6725.226598941086;7417.8145546361775;7425.294597013275;7427.554346739213;7447.069116360455;7452.919326697598;5455.318085239345;5925.674087925206;6663.333666633298;6665.700043498055;6723.697433615499;3255.7232635225796;3799.3731034379016;3873.3608954522188;3917.8432862685745;3930.941035884407;7491.325780679765;7743;7785.571793551296;7800.765977020698;7815.25755053269;6564.376384243489;7659.846803063908;7674.9232507674205;7690.807729806687;7730.1110372306775;7751.379889608817;7758.262965018314;7771.028621422435;7784.260495252942;7798.220177982384;7144.3570078693165;7398.593077380796;7424.925750742424;7425.104209358246;7445.664945077377;6558.458432446616;6708.362705542965;7266.818329541804;7300.598467084362;7310.707571697072;6717.992301154671;7245.384142347749;7738.41961852852;7738.961305193438;7773.650185741768;3867.555231148454;4414.095110502275;4569.428821397325;4637.628989680885;4644.767761611974;7000.824979375557;7355.852882942204;7370.44721645868;7380.5940673263485;7386.0767404074495;6094.481969032682;6530.379613936669;7102.360787529147;7129.7861064168155;7131.786046418616;7098.787036388917;7110.715571377087;7132.679029443584;7133.5719856808755;7146.392556632536;5580.302462192226;6888.48336374784;6918;6923.688434020582;6946.409555187865;6840.760573379908;7112.57324560528;7116.857662846817;7118.750843720445;7157.427405807627;6659.53383263167;6790.694418751267;6797.93202067973;6924;7019 18:21:56 INFO - PROCESS | 1661 | |5;yui.html;702.7294491620726;746.1754760989105;758.3743411685361;783.7335305995964;789.1201310538751;15057.322420491077;15290.31193596288;15319.157446340447;15348.539543813675;15387.076775393483;13917.443302267922;14089.084209526374;14089.929550352233;14094.859051409483;14126.929365353184;795.4352409789057;796.2395911904117;949.5157469690473;949.7578117580008;975.9463229522373;925.8518637018078;938.6245501799301;938.9859152112724;940.7930255343813;992.5831150916596;849.5370023337265;1001.4642166440956;1005.602786899178;1005.783756492354;1052.4369462337652;1011.5801942194017;1029.9588016479331;1030.1192480429274;1031.3038698878302;1033.1115240892825;762.4624639629048;768.4812751392843;776.0648418655506;776.4758787818257;777.3237283563336;14666.973311868174;14722.631934201623;14760.852391476055;14766.483173088998;14773.556793296219;12606.117571769979;12677.17598356104;12877.806832897513;12999.350032498338;13284.667883302898;9773.462459564722;9878.308518403715;9885.703428897144;9958.850617240747;10150.984901509864;3961.21127948215;4075;4083.3262511685534;4087.346024636044;4162.250794856925;78329.08354582306;78553.03617409553;78628;78927;80030;9231.676891308905;9358.344915855962;9427;9479;9562.856557151648;21487.46281342979;21488.24791132303;22065;22385.992630331675;22425.32724018282;7589.089309282811;7618;7836.686532538749;7858.371330293677;7929.048514178336;4103.384492326175;4198.202341555156;4227.87316380509;4230.873073807791;4294.549072347421;3726.124360775216;3772.679322257584;3777.905552361213;3782.3759079752085;3782.8108594570713;541.8076582813045;653.7352372289231;692.8129405060706;702.1293595940996;716.5342527357155;538.8922215556826;584.9502792262621;600.648620556979;625.8060001399581;634.1280738983897;7298.379637730853;7803.648835802403;8003.599820008976;8201.917980820235;8541.829163416696;598.9670568118795;612.2744547710977;615.5875563372551;632.4055387935326;639.48840927258;3876.9418458723144;3897.3569361055106;3952;3977.9801100994887;3982.6216509431556;98599.50700246452;99926;100460.49309260368;101300;102288.48855755673;83576;83860.16139838645;84132;84261.31477370419;85129.57435212909;73114;74069.62965185248;74176.88734668984;74205.88691169636;75580.24419755732;8351.457155284887;8388.412811103164;8436.36219134805;8578.871316930376;8664.310459460345;47336.76331618457;48012.7599362001;49039;50658.74670626623;52903;52511.16210932599;67839;70266.48667566704;71666.64166679133;71832.64083679549;11195.944020279847;11300.265482743594;11434.37110958872;11572.537098515964;11960.10299227544;11818.290902545874;11837.704057398634;12055.51777928873;12426.62720118398;12453.315067671365;11325.546978121112;11587.188896777145;11772.941135294612;11994.160408771302;12004.2197257178;11105.66682999479;11488.425578721197;11495.712607184552;11500.942495287805;11505.079593632656;11053.668389948314;11434.256773309708;11496.022838058525;11642;11906.940465297617;9204.907950920406;9355.298352623444;9532.046795320413;9556.856647150438;9567.760805979906;9213.815723685622;9782.657606984007;9787.559559819967;9792.706218813448;9843 18:21:56 INFO - PROCESS | 1661 | __end_tp_report 18:21:56 INFO - PROCESS | 1661 | __start_cc_report 18:21:56 INFO - PROCESS | 1661 | _x_x_mozilla_cycle_collect,1045 18:21:56 INFO - PROCESS | 1661 | __end_cc_report 18:21:56 INFO - PROCESS | 1661 | __startTimestamp1459819316961__endTimestamp 18:21:56 INFO - PROCESS | 1661 | 18:21:56 INFO - PROCESS | 1661 | ------- Summary: start ------- 18:21:56 INFO - PROCESS | 1661 | Number of tests: 6 18:21:56 INFO - PROCESS | 1661 | 18:21:56 INFO - PROCESS | 1661 | [#0] dojo.html Cycles:165 Average:5694.85 Median:5879.50 stddev:655.01 (11.1%) stddev-sans-first:632.20 18:21:56 INFO - PROCESS | 1661 | Values: 3417.9 3469.6 3501.5 3513.9 3556.5 4761.8 5596.9 5677.2 5703.4 5718.5 4668.7 5720.7 5726.3 5748.0 5755.1 4947.2 5033.0 5150.3 5157.1 5196.0 4975.1 5001.5 5008.4 5015.5 5020.2 5148.7 5199.3 5220.1 5221.0 5231.9 4640.2 5214.6 5245.8 5257.2 5309.9 5135.1 5157.6 5171.9 5177.6 5178.4 5633.0 5665.5 5669.7 5691.8 5709.1 6109.3 6147.5 6204.6 6270.2 6280.2 6240.3 6289.9 6315.0 6316.7 6325.0 5788.2 5794.0 5810.6 5813.2 5815.5 5332.8 6216.9 6250.9 6299.9 6321.3 5141.5 6152.8 6158.6 6173.9 6174.8 6262.9 6284.9 6287.7 6288.5 6292.8 6055.3 6100.4 6132.5 6246.1 6262.0 6224.4 6248.8 6254.8 6269.1 6288.8 4906.8 4934.5 4943.8 4955.7 5016.8 4323.0 4351.2 4398.1 4474.9 4504.4 4791.2 5723.0 5726.4 5731.4 5746.2 5210.3 6288.8 6304.7 6320.6 6334.5 5574.9 5657.8 5725.9 5741.0 5751.8 5308.7 5369.6 5382.5 5387.4 5394.3 5422.8 6250.7 6320.1 6334.6 6385.8 5269.6 6249.9 6294.6 6325.9 6354.5 6308.0 6341.2 6360.5 6361.7 6362.1 6006.6 6116.4 6225.5 6227.2 6258.6 6213.4 6220.3 6291.3 6297.4 6310.2 6029.5 6101.5 6103.3 6104.8 6109.2 5918.5 6045.6 6097.8 6099.2 6140.7 5879.5 5883.8 5891.1 5901.8 5911.6 6050.0 6075.6 6082.6 6121.2 6138.0 5785.9 5825.5 5888.0 5918.8 5996.0 18:21:56 INFO - PROCESS | 1661 | 18:21:56 INFO - PROCESS | 1661 | [#1] ext.html Cycles:180 Average:66817.89 Median:43380.46 stddev:136987.99 (315.8%) stddev-sans-first:137281.77 18:21:56 INFO - PROCESS | 1661 | Values: 496.0 605.4 625.4 664.8 675.8 26788.0 33281.3 40819.0 41084.8 41234.4 36628.6 44949.1 45137.5 45350.9 45424.0 9624.1 9860.4 9869.7 9894.5 9898.3 9580.1 9718.6 9733.6 9738.3 9739.0 9693.7 9769.0 9873.7 9878.9 9903.9 9764.2 9835.4 9850.3 9856.2 9891.4 9789.4 9910.3 9917.4 9929.1 9943.2 42916.6 43283.8 43477.1 43489.6 43747.0 2893.7 2928.3 3206.3 3422.1 3843.2 27971.9 29721.7 29729.4 30070.5 30660.5 2777.9 2795.1 2852.3 2869.8 2910.3 494246.0 503420.0 507261.0 508140.0 508417.0 51579.0 75392.0 76052.7 76115.0 76118.6 54632.0 54834.7 54927.5 54929.7 54933.0 17658.9 17998.6 18033.7 18044.0 18062.1 14163.8 14300.9 14313.2 14323.9 14339.6 16567.7 16600.7 16603.8 16622.8 16637.3 6935.0 7016.8 7054.3 7063.9 7074.5 919.5 951.7 973.4 1022.1 1055.0 26434.6 29794.0 30655.5 31292.0 31635.8 1037.6 1096.3 1105.5 1235.4 1240.8 13453.8 15664.0 15858.4 15883.4 16027.3 535482.0 539054.0 540601.0 541980.0 542784.0 44387.3 60814.7 63409.4 63812.1 63983.7 1239.7 1425.6 1522.6 1533.8 1535.3 29371.6 31136.0 32511.3 34155.7 34292.7 60458.0 60883.7 61549.7 61599.4 61676.0 495817.5 500595.0 502209.0 502275.0 504070.0 39354.0 47546.5 48181.9 48676.8 49471.0 45408.0 45560.0 45700.3 46273.1 46832.5 36948.3 37189.9 37428.8 37591.2 38018.0 32700.0 38094.8 39192.4 39298.0 40199.6 38700.0 38879.0 38957.0 39092.0 39837.0 33989.7 34121.0 34864.7 34919.8 34962.7 25903.0 25938.4 25980.1 26261.2 26439.6 18:21:56 INFO - PROCESS | 1661 | 18:21:56 INFO - PROCESS | 1661 | [#2] jquery.html Cycles:180 Average:35042.41 Median:20773.27 stddev:107218.41 (516.1%) stddev-sans-first:107487.55 18:21:56 INFO - PROCESS | 1661 | Values: 356.8 381.8 382.3 386.6 390.0 16333.8 16807.9 20097.9 20855.3 21427.5 16642.1 19748.3 20377.5 20549.7 20691.3 5119.2 5810.8 5994.8 6012.5 6028.8 6006.2 6054.6 6065.2 6077.5 6091.5 5823.7 5888.5 6006.7 6010.2 6011.6 5984.3 6024.8 6026.3 6028.8 6032.4 5013.9 5093.9 5168.1 5176.9 5185.4 19510.6 24870.0 25591.5 25646.8 25809.5 2145.8 2278.2 2391.9 2566.6 2748.1 14574.2 14578.3 14675.0 14799.1 14988.6 1621.6 1691.5 1715.0 1751.3 1800.5 85406.0 100439.0 105812.5 106513.9 111308.4 10305.2 10494.0 10701.8 10716.1 10834.9 12149.6 12615.0 13336.3 13362.7 13368.2 8502.2 8738.7 8746.3 8849.4 8866.2 9137.9 9147.4 9147.4 9181.2 9223.5 6043.0 6086.9 6109.4 6111.3 6111.4 1814.5 1822.8 1837.2 1838.9 1840.2 846.4 965.8 979.6 1084.3 1133.9 18693.6 19539.0 20242.8 20374.4 21020.4 918.8 1024.1 1055.9 1057.3 1060.0 9129.9 9734.5 11104.3 11511.1 11558.4 640942.0 643752.0 651078.7 658106.0 659369.0 102814.5 106179.5 106235.4 108094.4 109414.0 1081.5 1085.7 1105.4 1108.3 1112.4 18196.9 18390.8 18532.2 18642.8 18702.7 47407.0 47666.0 50055.5 50182.0 50474.2 50018.7 64945.4 67714.0 68816.7 69606.0 7802.8 7968.2 7985.5 8174.0 8360.1 12844.3 13105.8 13255.0 13433.4 13468.3 11552.7 11639.8 11778.9 11905.8 11971.9 11368.0 11372.3 11440.4 11753.6 11913.9 11813.5 11844.6 12020.4 12029.3 12076.6 7719.7 8133.7 8185.2 8303.4 8480.5 10319.4 11610.0 11867.9 11904.5 11927.5 18:21:56 INFO - PROCESS | 1661 | 18:21:56 INFO - PROCESS | 1661 | [#3] mootools.html Cycles:180 Average:6153.39 Median:5561.99 stddev:3289.06 (59.1%) stddev-sans-first:3279.69 18:21:56 INFO - PROCESS | 1661 | Values: 1500.6 1638.3 1658.3 1987.3 2040.0 8206.3 8866.8 9026.5 9029.9 9040.5 8690.7 8905.7 8936.6 8937.4 8942.0 2119.2 2497.7 2536.2 2538.0 2542.8 2493.3 2529.0 2532.2 2537.5 2547.9 2238.8 2480.0 2508.7 2535.3 2546.7 2121.5 2490.6 2524.2 2524.4 2535.7 2461.9 2499.4 2499.6 2499.8 2541.0 8647.5 8890.1 8980.2 9053.0 9060.4 5464.9 5636.5 5678.8 5683.4 5690.2 3580.9 3689.9 3700.5 3739.7 3754.0 1043.7 1058.5 1063.9 1074.5 1101.5 11958.4 12290.9 12302.8 12315.9 12322.6 4776.4 4810.1 4822.5 4834.1 4898.0 9637.0 9637.2 9640.3 9643.8 9649.2 5543.1 5549.3 5555.1 5561.5 5562.5 4535.1 4714.0 4914.8 5097.4 5149.9 3836.2 3879.3 3887.2 3915.2 3944.8 1207.8 1219.7 1228.4 1238.1 1239.9 1014.2 1054.9 1209.1 1328.3 1464.5 8278.8 8296.8 8302.8 8333.5 8367.5 624.5 639.7 642.4 648.1 797.3 6067.9 6324.4 6326.3 6329.9 6330.4 10736.2 11108.4 11119.1 11236.4 11325.5 11152.3 11156.1 11243.2 11286.0 11292.0 8377.2 8613.8 8656.3 8705.8 8717.8 8097.9 8134.8 8135.1 8141.6 8190.5 9650.6 9850.0 9964.1 10057.0 10077.6 8642.5 10054.4 10205.5 10306.8 10316.8 7127.0 7130.5 7168.8 7201.2 7214.7 8296.7 8461.6 8467.2 8501.3 8544.0 6241.4 7473.9 7572.8 7707.2 7737.5 7219.5 7300.2 7327.7 7346.4 7403.2 7889.2 7974.5 7978.4 7981.6 7989.0 6917.8 7112.6 7190.0 7194.9 7196.3 7222.2 7327.5 7332.2 7359.8 7370.9 18:21:56 INFO - PROCESS | 1661 | 18:21:56 INFO - PROCESS | 1661 | [#4] prototype.html Cycles:180 Average:5785.06 Median:6632.92 stddev:1865.62 (28.1%) stddev-sans-first:1825.39 18:21:56 INFO - PROCESS | 1661 | Values: 331.2 333.1 338.8 339.5 342.6 6606.3 6696.5 6705.2 6718.8 6739.5 6239.7 6828.7 6836.4 6838.8 6851.5 4768.4 4795.5 4807.0 4873.3 4975.0 4863.6 4882.5 4885.9 4918.9 4938.6 4875.0 4879.5 4881.4 4881.4 4889.5 3915.8 4615.9 4729.5 4829.8 4859.8 3403.3 3621.2 4159.8 4166.6 4168.4 5323.0 6049.4 6373.7 6396.3 6403.1 5805.5 5812.6 5815.8 5829.2 5837.7 7066.7 7067.3 7081.6 7082.4 7086.2 4505.3 4737.7 4762.1 4762.5 4779.3 7329.9 7515.4 7517.5 7533.8 7544.0 4836.1 4839.7 4850.3 4859.3 4864.2 4901.9 4916.3 4925.3 4927.3 4928.2 5848.0 5851.9 5864.4 5873.1 5874.0 5469.3 6991.0 7015.6 7016.2 7019.3 1312.7 1666.0 1703.5 1704.0 1704.4 1036.8 1070.3 1091.7 1094.1 1127.7 6509.5 6697.7 6707.4 6707.7 6725.2 7417.8 7425.3 7427.6 7447.1 7452.9 5455.3 5925.7 6663.3 6665.7 6723.7 3255.7 3799.4 3873.4 3917.8 3930.9 7491.3 7743.0 7785.6 7800.8 7815.3 6564.4 7659.8 7674.9 7690.8 7730.1 7751.4 7758.3 7771.0 7784.3 7798.2 7144.4 7398.6 7424.9 7425.1 7445.7 6558.5 6708.4 7266.8 7300.6 7310.7 6718.0 7245.4 7738.4 7739.0 7773.7 3867.6 4414.1 4569.4 4637.6 4644.8 7000.8 7355.9 7370.4 7380.6 7386.1 6094.5 6530.4 7102.4 7129.8 7131.8 7098.8 7110.7 7132.7 7133.6 7146.4 5580.3 6888.5 6918.0 6923.7 6946.4 6840.8 7112.6 7116.9 7118.8 7157.4 6659.5 6790.7 6797.9 6924.0 7019.0 18:21:56 INFO - PROCESS | 1661 | 18:21:56 INFO - PROCESS | 1661 | [#5] yui.html Cycles:180 Average:18816.50 Median:563.38 stddev:26833.75 (4763.0%) stddev-sans-first:26874.56 18:21:56 INFO - PROCESS | 1661 | Values: 702.7 746.2 758.4 783.7 789.1 15057.3 15290.3 15319.2 15348.5 15387.1 13917.4 14089.1 14089.9 14094.9 14126.9 795.4 796.2 949.5 949.8 975.9 925.9 938.6 939.0 940.8 992.6 849.5 1001.5 1005.6 1005.8 1052.4 1011.6 1030.0 1030.1 1031.3 1033.1 762.5 768.5 776.1 776.5 777.3 14667.0 14722.6 14760.9 14766.5 14773.6 12606.1 12677.2 12877.8 12999.4 13284.7 9773.5 9878.3 9885.7 9958.9 10151.0 3961.2 4075.0 4083.3 4087.3 4162.3 78329.1 78553.0 78628.0 78927.0 80030.0 9231.7 9358.3 9427.0 9479.0 9562.9 21487.5 21488.2 22065.0 22386.0 22425.3 7589.1 7618.0 7836.7 7858.4 7929.0 4103.4 4198.2 4227.9 4230.9 4294.5 3726.1 3772.7 3777.9 3782.4 3782.8 541.8 653.7 692.8 702.1 716.5 538.9 585.0 600.6 625.8 634.1 7298.4 7803.6 8003.6 8201.9 8541.8 599.0 612.3 615.6 632.4 639.5 3876.9 3897.4 3952.0 3978.0 3982.6 98599.5 99926.0 100460.5 101300.0 102288.5 83576.0 83860.2 84132.0 84261.3 85129.6 73114.0 74069.6 74176.9 74205.9 75580.2 8351.5 8388.4 8436.4 8578.9 8664.3 47336.8 48012.8 49039.0 50658.7 52903.0 52511.2 67839.0 70266.5 71666.6 71832.6 11195.9 11300.3 11434.4 11572.5 11960.1 11818.3 11837.7 12055.5 12426.6 12453.3 11325.5 11587.2 11772.9 11994.2 12004.2 11105.7 11488.4 11495.7 11500.9 11505.1 11053.7 11434.3 11496.0 11642.0 11906.9 9204.9 9355.3 9532.0 9556.9 9567.8 9213.8 9782.7 9787.6 9792.7 9843.0 18:21:56 INFO - PROCESS | 1661 | -------- Summary: end -------- 18:21:56 INFO - PROCESS | 1661 | 18:21:57 INFO - TEST-INFO | 1661: exit 0 18:21:57 INFO - TEST-OK | dromaeo_css | took 1112663ms 18:21:57 INFO - TEST-START | kraken 18:21:57 INFO - operating with platform_type : mac_ 18:21:57 INFO - Initialising browser for kraken test... 18:21:57 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/tmpPAjbAs/profile http://localhost:49271/getInfo.html) 18:21:59 INFO - PROCESS | 1667 | __metrics Screen width/height:1600/1200 18:21:59 INFO - PROCESS | 1667 | colorDepth:24 18:21:59 INFO - PROCESS | 1667 | Browser inner width/height: 1024/689 18:21:59 INFO - PROCESS | 1667 | __metrics 18:21:59 INFO - PROCESS | 1667 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:21:59 INFO - PROCESS | 1667 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:22:00 INFO - TEST-INFO | 1667: exit 0 18:22:00 INFO - Browser initialized. 18:22:00 INFO - Running cycle 1/1 for kraken test... 18:22:00 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/tmpPAjbAs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:22:12 INFO - PROCESS | 1669 | RSS: Main: 207298560 18:22:12 INFO - PROCESS | 1669 | 18:22:14 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 18:22:15 INFO - PROCESS | 1669 | RSS: Main: 262864896 18:22:15 INFO - PROCESS | 1669 | 18:22:18 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 18:22:18 INFO - PROCESS | 1669 | RSS: Main: 273166336 18:22:18 INFO - PROCESS | 1669 | 18:22:21 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 18:22:22 INFO - PROCESS | 1669 | RSS: Main: 262819840 18:22:22 INFO - PROCESS | 1669 | 18:22:24 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 18:22:24 INFO - PROCESS | 1669 | RSS: Main: 264019968 18:22:24 INFO - PROCESS | 1669 | 18:22:26 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:22:27 INFO - PROCESS | 1669 | RSS: Main: 265191424 18:22:27 INFO - PROCESS | 1669 | 18:22:30 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 18:22:30 INFO - PROCESS | 1669 | RSS: Main: 265285632 18:22:30 INFO - PROCESS | 1669 | 18:22:33 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 18:22:34 INFO - PROCESS | 1669 | RSS: Main: 265211904 18:22:34 INFO - PROCESS | 1669 | 18:22:36 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 18:22:37 INFO - PROCESS | 1669 | RSS: Main: 265510912 18:22:37 INFO - PROCESS | 1669 | 18:22:38 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:22:39 INFO - PROCESS | 1669 | RSS: Main: 297930752 18:22:39 INFO - PROCESS | 1669 | 18:22:41 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:22:41 INFO - PROCESS | 1669 | RSS: Main: 298799104 18:22:41 INFO - PROCESS | 1669 | 18:22:44 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:22:44 INFO - PROCESS | 1669 | RSS: Main: 303362048 18:22:44 INFO - PROCESS | 1669 | 18:22:47 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:22:47 INFO - PROCESS | 1669 | RSS: Main: 305700864 18:22:47 INFO - PROCESS | 1669 | 18:22:50 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:22:50 INFO - PROCESS | 1669 | RSS: Main: 305684480 18:22:50 INFO - PROCESS | 1669 | 18:22:52 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 18:22:52 INFO - PROCESS | 1669 | RSS: Main: 368103424 18:22:52 INFO - PROCESS | 1669 | 18:22:52 INFO - PROCESS | 1669 | __start_tp_report 18:22:52 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 18:22:52 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 18:22:52 INFO - PROCESS | 1669 | |i|pagename|runs| 18:22:52 INFO - PROCESS | 1669 | |0;ai-astar;111;111;111;110;112;112;119;112;110;110 18:22:52 INFO - PROCESS | 1669 | |1;audio-beat-detection;154;119;155;159;151;137;101;180;176;149 18:22:52 INFO - PROCESS | 1669 | |2;audio-dft;185;185;185;185;184;187;184;185;184;184 18:22:52 INFO - PROCESS | 1669 | |3;audio-fft;73;80;74;116;56;57;57;58;114;55 18:22:52 INFO - PROCESS | 1669 | |4;audio-oscillator;92;95;129;80;78;88;118;78;79;116 18:22:52 INFO - PROCESS | 1669 | |5;imaging-gaussian-blur;86;82;86;85;89;83;86;83;86;83 18:22:52 INFO - PROCESS | 1669 | |6;imaging-darkroom;92;92;93;93;93;92;93;94;93;91 18:22:52 INFO - PROCESS | 1669 | |7;imaging-desaturate;86;87;85;87;85;84;83;86;84;96 18:22:52 INFO - PROCESS | 1669 | |8;json-parse-financial;56;57;58;57;61;59;59;70;54;51 18:22:52 INFO - PROCESS | 1669 | |9;json-stringify-tinderbox;62;65;66;74;69;65;65;64;67;72 18:22:52 INFO - PROCESS | 1669 | |10;stanford-crypto-aes;80;82;82;82;82;89;88;86;82;85 18:22:52 INFO - PROCESS | 1669 | |11;stanford-crypto-ccm;119;118;121;131;137;122;117;120;131;121 18:22:52 INFO - PROCESS | 1669 | |12;stanford-crypto-pbkdf2;134;123;132;135;139;123;134;134;132;134 18:22:52 INFO - PROCESS | 1669 | |13;stanford-crypto-sha256-iterative;70;66;67;67;66;66;72;55;61;79 18:22:52 INFO - PROCESS | 1669 | __end_tp_report 18:22:52 INFO - PROCESS | 1669 | __start_cc_report 18:22:52 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,1182 18:22:52 INFO - PROCESS | 1669 | __end_cc_report 18:22:52 INFO - PROCESS | 1669 | __startTimestamp1459819372802__endTimestamp 18:22:52 INFO - PROCESS | 1669 | 18:22:52 INFO - PROCESS | 1669 | ------- Summary: start ------- 18:22:52 INFO - PROCESS | 1669 | Number of tests: 14 18:22:52 INFO - PROCESS | 1669 | 18:22:52 INFO - PROCESS | 1669 | [#0] ai-astar Cycles:10 Average:111.80 Median:111.50 stddev:2.66 (2.4%) stddev-sans-first:2.80 18:22:52 INFO - PROCESS | 1669 | Values: 111.0 111.0 111.0 110.0 112.0 112.0 119.0 112.0 110.0 110.0 18:22:52 INFO - PROCESS | 1669 | 18:22:52 INFO - PROCESS | 1669 | [#1] audio-beat-detection Cycles:10 Average:148.10 Median:154.50 stddev:24.03 (15.6%) stddev-sans-first:25.39 18:22:52 INFO - PROCESS | 1669 | Values: 154.0 119.0 155.0 159.0 151.0 137.0 101.0 180.0 176.0 149.0 18:22:52 INFO - PROCESS | 1669 | 18:22:52 INFO - PROCESS | 1669 | [#2] audio-dft Cycles:10 Average:184.80 Median:185.00 stddev:0.92 (0.5%) stddev-sans-first:0.97 18:22:52 INFO - PROCESS | 1669 | Values: 185.0 185.0 185.0 185.0 184.0 187.0 184.0 185.0 184.0 184.0 18:22:52 INFO - PROCESS | 1669 | 18:22:52 INFO - PROCESS | 1669 | [#3] audio-fft Cycles:10 Average:74.00 Median:57.50 stddev:23.38 (40.7%) stddev-sans-first:24.80 18:22:52 INFO - PROCESS | 1669 | Values: 73.0 80.0 74.0 116.0 56.0 57.0 57.0 58.0 114.0 55.0 18:22:52 INFO - PROCESS | 1669 | 18:22:52 INFO - PROCESS | 1669 | [#4] audio-oscillator Cycles:10 Average:95.30 Median:79.50 stddev:18.98 (23.9%) stddev-sans-first:20.09 18:22:52 INFO - PROCESS | 1669 | Values: 92.0 95.0 129.0 80.0 78.0 88.0 118.0 78.0 79.0 116.0 18:22:52 INFO - PROCESS | 1669 | 18:22:52 INFO - PROCESS | 1669 | [#5] imaging-gaussian-blur Cycles:10 Average:84.90 Median:86.00 stddev:2.13 (2.5%) stddev-sans-first:2.22 18:22:52 INFO - PROCESS | 1669 | Values: 86.0 82.0 86.0 85.0 89.0 83.0 86.0 83.0 86.0 83.0 18:22:52 INFO - PROCESS | 1669 | 18:22:52 INFO - PROCESS | 1669 | [#6] imaging-darkroom Cycles:10 Average:92.60 Median:93.00 stddev:0.84 (0.9%) stddev-sans-first:0.87 18:22:52 INFO - PROCESS | 1669 | Values: 92.0 92.0 93.0 93.0 93.0 92.0 93.0 94.0 93.0 91.0 18:22:52 INFO - PROCESS | 1669 | 18:22:52 INFO - PROCESS | 1669 | [#7] imaging-desaturate Cycles:10 Average:86.30 Median:86.00 stddev:3.65 (4.2%) stddev-sans-first:3.87 18:22:52 INFO - PROCESS | 1669 | Values: 86.0 87.0 85.0 87.0 85.0 84.0 83.0 86.0 84.0 96.0 18:22:52 INFO - PROCESS | 1669 | 18:22:52 INFO - PROCESS | 1669 | [#8] json-parse-financial Cycles:10 Average:58.20 Median:58.50 stddev:5.01 (8.6%) stddev-sans-first:5.25 18:22:52 INFO - PROCESS | 1669 | Values: 56.0 57.0 58.0 57.0 61.0 59.0 59.0 70.0 54.0 51.0 18:22:52 INFO - PROCESS | 1669 | 18:22:52 INFO - PROCESS | 1669 | [#9] json-stringify-tinderbox Cycles:10 Average:66.90 Median:66.50 stddev:3.73 (5.6%) stddev-sans-first:3.50 18:22:52 INFO - PROCESS | 1669 | Values: 62.0 65.0 66.0 74.0 69.0 65.0 65.0 64.0 67.0 72.0 18:22:52 INFO - PROCESS | 1669 | 18:22:52 INFO - PROCESS | 1669 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:83.50 stddev:3.01 (3.6%) stddev-sans-first:2.86 18:22:52 INFO - PROCESS | 1669 | Values: 80.0 82.0 82.0 82.0 82.0 89.0 88.0 86.0 82.0 85.0 18:22:52 INFO - PROCESS | 1669 | 18:22:52 INFO - PROCESS | 1669 | [#11] stanford-crypto-ccm Cycles:10 Average:123.70 Median:121.50 stddev:6.78 (5.6%) stddev-sans-first:6.98 18:22:52 INFO - PROCESS | 1669 | Values: 119.0 118.0 121.0 131.0 137.0 122.0 117.0 120.0 131.0 121.0 18:22:52 INFO - PROCESS | 1669 | 18:22:52 INFO - PROCESS | 1669 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:132.00 Median:134.00 stddev:5.12 (3.8%) stddev-sans-first:5.38 18:22:52 INFO - PROCESS | 1669 | Values: 134.0 123.0 132.0 135.0 139.0 123.0 134.0 134.0 132.0 134.0 18:22:52 INFO - PROCESS | 1669 | 18:22:52 INFO - PROCESS | 1669 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:6.33 (9.5%) stddev-sans-first:6.62 18:22:52 INFO - PROCESS | 1669 | Values: 70.0 66.0 67.0 67.0 66.0 66.0 72.0 55.0 61.0 79.0 18:22:52 INFO - PROCESS | 1669 | -------- Summary: end -------- 18:22:52 INFO - PROCESS | 1669 | 18:22:53 INFO - TEST-INFO | 1669: exit 0 18:22:53 INFO - TEST-OK | kraken | took 56162ms 18:22:53 INFO - SUITE-END | took 1168s 18:22:53 INFO - Completed test suite (00:19:29) 18:22:53 INFO - javascript benchmark 18:22:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3417.9487307690383, 3469.6009958854725, 3501.492283618874, 3513.8770143045, 3556.4665300204965, 4761.761911904404, 5596.916046259309, 5677.233573467581, 5703.372629010805, 5718.542516598673, 4668.6731928765, 5720.713964301779, 5726.284214473191, 5748.02283611786, 5755.136729490579, 4947.233178857283, 5033.0, 5150.27896094547, 5157.123289040872, 5196.012757576049, 4975.0796102721115, 5001.524855138756, 5008.4240312364, 5015.523525265094, 5020.221865610836, 5148.742562871841, 5199.298094757197, 5220.112580861262, 5221.034108689885, 5231.921521177185, 4640.187967105743, 5214.556762675177, 5245.842624721265, 5257.185136303879, 5309.946900531003, 5135.075686376451, 5157.5616072633875, 5171.870703232412, 5177.611679124081, 5178.352705911761, 5633.0, 5665.461781130827, 5669.744861481243, 5691.7723291068305, 5709.115087161496, 6109.283207920386, 6147.524594097385, 6204.565680402374, 6270.184875966141, 6280.246370435577, 6240.344763799781, 6289.937100629027, 6314.958031924727, 6316.74733010679, 6325.0, 5788.218590490314, 5793.971030144864, 5810.564207684441, 5813.215215945877, 5815.53475721937, 5332.840014799563, 6216.906746398808, 6250.874982500324, 6299.874002519924, 6321.304656487782, 5141.460146684544, 6152.846178845564, 6158.599691020069, 6173.938260617426, 6174.753009879554, 6262.874742505124, 6284.937150628527, 6287.748490060438, 6288.52836037299, 6292.779752708633, 6055.333913269536, 6100.420460056288, 6132.5321648516665, 6246.125542424064, 6261.96869015652, 6224.408681175281, 6248.843778905563, 6254.781082662176, 6269.122322874801, 6288.811335659938, 4906.828261010919, 4934.5312195341385, 4943.752812359367, 4955.72743499111, 5016.849494515171, 4323.0, 4351.216780979454, 4398.098389830077, 4474.865754027384, 4504.391907092566, 4791.233402655558, 5723.0, 5726.3700992890745, 5731.398203188605, 5746.166805813134, 5210.322658054504, 6288.8427789304715, 6304.71628776697, 6320.62076275425, 6334.5249106317215, 5574.916376254359, 5657.8019769307875, 5725.885482290331, 5740.971295143498, 5751.827445176651, 5308.734563271821, 5369.597280203922, 5382.4886635769535, 5387.434319396407, 5394.271773310631, 5422.810201642924, 6250.718717657625, 6320.083587879732, 6334.619922804646, 6385.840353991188, 5269.631125821309, 6249.906251406142, 6294.622322660655, 6325.905111423241, 6354.491640668828, 6307.96846015767, 6341.175647166024, 6360.459360954371, 6361.681915904279, 6362.109304697438, 6006.609570377911, 6116.39664026098, 6225.470834979077, 6227.221597300338, 6258.561900666909, 6213.409726076015, 6220.34686357944, 6291.276503202007, 6297.4017468340435, 6310.211223597051, 6029.457348838626, 6101.450869421773, 6103.328633850362, 6104.786332478342, 6109.20580324555, 5918.526517878646, 6045.637261764308, 6097.847553811191, 6099.207103076572, 6140.662263575547, 5879.5002424792665, 5883.794067207627, 5891.116332550152, 5901.822945311647, 5911.645301281765, 6050.0, 6075.635461872125, 6082.60463069899, 6121.238404290834, 6137.974468425319, 5785.855353616025, 5825.533957283492, 5888.0, 5918.822435326947, 5996.0], "unit": "score", "name": "dojo.html", "value": 5655.778427436718}, {"lowerIsBetter": false, "replicates": [496.03273616447893, 605.3825098399633, 625.4183609243405, 664.8431728791902, 675.7599804359, 26788.0, 33281.33437331252, 40819.0, 41084.79457602708, 41234.38148427776, 36628.63371366286, 44949.10101797962, 45137.54862451374, 45350.866228344305, 45424.0, 9624.133827955466, 9860.359076659994, 9869.654562090329, 9894.455804930725, 9898.307118501707, 9580.137787599115, 9718.56266468007, 9733.610655573768, 9738.318317717763, 9739.0, 9693.70918872435, 9768.951155244215, 9873.654422095193, 9878.851817222747, 9903.900960990406, 9764.218862490983, 9835.360701554377, 9850.310478266525, 9856.162226210708, 9891.406515609087, 9789.412635241908, 9910.306278560503, 9917.404955702608, 9929.056739609725, 9943.154831839302, 42916.57083429157, 43283.783581081894, 43477.130457390675, 43489.56510434887, 43747.0, 2893.6816950135467, 2928.297208669925, 3206.2625596112794, 3422.058933793202, 3843.2121415110114, 27971.860140699166, 29721.70278297211, 29729.40541189164, 30070.54894176589, 30660.540091898638, 2777.9444411111663, 2795.0636536760207, 2852.343960888986, 2869.8421586812715, 2910.3451723362286, 494246.0, 503420.0, 507261.0, 508140.0, 508417.0, 51579.0, 75392.0, 76052.71841844753, 76115.0, 76118.61940690261, 54632.0, 54834.72582637141, 54927.450725492236, 54929.72535137379, 54933.0, 17658.852174608608, 17998.640027199384, 18033.7294940576, 18044.00757958325, 18062.09689515519, 14163.78754318686, 14300.928495357457, 14313.212773297568, 14323.856761432253, 14339.641508962359, 16567.66864662724, 16600.66798664044, 16603.83396166047, 16622.833771662128, 16637.33450661984, 6934.965325173342, 7016.789496315118, 7054.2945705430075, 7063.929360706327, 7074.504784665024, 919.5034681272039, 951.7002144324654, 973.4354074636693, 1022.0545994954638, 1055.0451841083832, 26434.6034809478, 29794.0, 30655.540166897514, 31292.0, 31635.84182079075, 1037.5745944162857, 1096.276457538037, 1105.5025238642643, 1235.43170141734, 1240.8386909701862, 13453.798193027113, 15664.0, 15858.365665373487, 15883.444079457164, 16027.278772455034, 535482.0, 539054.0, 540601.0, 541980.0, 542784.0, 44387.33418998653, 60814.695926520966, 63409.36590634035, 63812.08563743095, 63983.6800815993, 1239.6776838022179, 1425.5509514502899, 1522.5508474999901, 1533.8006059212455, 1535.293764868151, 29371.55942660819, 31136.0, 32511.34977300488, 34155.65844341525, 34292.657073429946, 60458.0, 60883.69558152181, 61549.69225153846, 61599.384006161155, 61676.0, 495817.5209123931, 500595.0, 502209.0, 502275.0, 504070.0, 39354.01614959534, 47546.52453475421, 48181.86817856828, 48676.75661621669, 49471.0, 45408.0, 45560.0, 45700.314495281935, 46273.074538508365, 46832.53167468282, 36948.261034779694, 37189.88430347094, 37428.81285593555, 37591.2481750358, 38018.0, 32700.0, 38094.809525952194, 39192.412113818886, 39298.01754956149, 40199.59800401959, 38700.03249918774, 38879.0, 38957.0, 39092.0, 39837.0, 33989.66010339964, 34121.0, 34864.65135348614, 34919.777807776605, 34962.65037349696, 25903.0, 25938.400638911164, 25980.090696825522, 26261.212163635122, 26439.603405948543], "unit": "score", "name": "ext.html", "value": 20477.68302868418}, {"lowerIsBetter": false, "replicates": [356.7859284429342, 381.80909545227377, 382.2794033247328, 386.5573917864044, 390.0288282177379, 16333.83666163341, 16807.91596042018, 20097.86891917377, 20855.27006554769, 21427.464313392175, 16642.08468534233, 19748.30880919168, 20377.49056273594, 20549.691754623655, 20691.275805346817, 5119.206522988943, 5810.82567522975, 5994.820155395345, 6012.549058820584, 6028.758849646031, 6006.1591377207005, 6054.576179667425, 6065.181200537937, 6077.544184186182, 6091.482224010942, 5823.708814559255, 5888.470037696607, 6006.669633170174, 6010.158577799111, 6011.57918945674, 5984.3417224105315, 6024.8493787655225, 6026.3069746979, 6028.849278768022, 6032.396760323976, 5013.874653133665, 5093.898122037575, 5168.095583272912, 5176.8964620707375, 5185.351831021122, 19510.609787804166, 24870.005199791987, 25591.488170236677, 25646.84589193472, 25809.483810323876, 2145.8283337332978, 2278.2026290798253, 2391.9162829301067, 2566.6021766626204, 2748.1068652687954, 14574.198419086946, 14578.271086445742, 14675.0, 14799.11205327673, 14988.625284367869, 1621.562178211888, 1691.4840973503076, 1714.9571260718458, 1751.30823324786, 1800.4958611588777, 85406.0, 100439.0, 105812.47093764482, 106513.93486065118, 111308.4434577822, 10305.227107966932, 10494.0, 10701.83947240792, 10716.089132423675, 10834.945825270823, 12149.574764883364, 12615.0, 13336.266505342299, 13362.665933351549, 13368.197908125543, 8502.234798868009, 8738.69414570487, 8746.300295976307, 8849.4247873888, 8866.246369058574, 9137.862932056025, 9147.359684821999, 9147.359684822131, 9181.219596334386, 9223.53882305882, 6043.0, 6086.908696369558, 6109.419605137505, 6111.297200821873, 6111.358307377662, 1814.5121000779234, 1822.7903791064198, 1837.2283640870867, 1838.9448316550524, 1840.18111940188, 846.3905987688854, 965.8164948659733, 979.5543027922421, 1084.2843723142846, 1133.9149563782748, 18693.626127477648, 19539.0, 20242.797572024385, 20374.388768336972, 21020.369388918356, 918.8024574716468, 1024.144839059379, 1055.904968552834, 1057.3021805608416, 1060.04066319979, 9129.863052054225, 9734.464604446683, 11104.333739975627, 11511.136664750176, 11558.364289964133, 640942.0, 643752.0, 651078.744606274, 658106.0, 659369.0, 102814.48592756988, 106179.469102654, 106235.40646890303, 108094.3785843213, 109414.0, 1081.4592703648175, 1085.6688709943385, 1105.4196546812987, 1108.3294606762954, 1112.3937454087543, 18196.90901545484, 18390.804597701106, 18532.166052527937, 18642.813571864106, 18702.719459207852, 47407.0, 47666.0, 50055.49944500509, 50182.0, 50474.24288635747, 50018.749906251694, 64945.35054649393, 67714.0, 68816.65591672009, 69606.0, 7802.804929876798, 7968.163342848918, 7985.5208687478935, 8174.0, 8360.12218717026, 12844.293563854078, 13105.803412949004, 13255.0, 13433.395497202844, 13468.326583670972, 11552.711182220512, 11639.825402618799, 11778.882211177779, 11905.761884762429, 11971.940140299243, 11368.0, 11372.260803047775, 11440.370779607201, 11753.647390578297, 11913.940430297793, 11813.527458901548, 11844.585439509921, 12020.398980051137, 12029.338386388832, 12076.637700868989, 7719.652615632423, 8133.67465301405, 8185.222403871623, 8303.377246706643, 8480.491170529787, 10319.380837149794, 11610.0, 11867.881321186678, 11904.464299106734, 11927.522899083939], "unit": "score", "name": "jquery.html", "value": 9643.714108921911}, {"lowerIsBetter": false, "replicates": [1500.5723368839883, 1638.2627817482132, 1658.3449537432714, 1987.2647120565393, 2039.9796002039984, 8206.302464290535, 8866.822663546725, 9026.458412495254, 9029.864552031724, 9040.502772347518, 8690.73927782166, 8905.732828015154, 8936.55317234139, 8937.374383793138, 8942.016378198408, 2119.1735223262863, 2497.6877890263763, 2536.175742883561, 2538.0355464923305, 2542.8220024598286, 2493.2769496845895, 2528.962065569018, 2532.189699296226, 2537.5178716043984, 2547.936301592466, 2238.82089432845, 2480.045182604692, 2508.7240403555593, 2535.2521006303186, 2546.719860815309, 2121.459027947879, 2490.5766019776684, 2524.179641616473, 2524.4320027993645, 2535.7210706822234, 2461.9261422157365, 2499.3501689560844, 2499.6250562415603, 2499.762522560354, 2541.009006487471, 8647.481151130953, 8890.06654301302, 8980.19178273952, 9052.954735226347, 9060.411073280216, 5464.9453505464835, 5636.520895723868, 5678.801241956512, 5683.403242659544, 5690.174924635905, 3580.946285805715, 3689.944650830213, 3700.481932529421, 3739.66343029126, 3754.0239537720117, 1043.6764602973103, 1058.4972138234355, 1063.8829728729834, 1074.5379486820664, 1101.5483651702764, 11958.402079896057, 12290.877091229062, 12302.753944921142, 12315.876841231562, 12322.630321090382, 4776.3644636109875, 4810.062037902575, 4822.541858523435, 4834.129856625841, 4898.0, 9637.036296370306, 9637.18083962857, 9640.276979226446, 9643.758906027266, 9649.179819715402, 5543.057680194376, 5549.334079910436, 5555.055640541118, 5561.499465048165, 5562.471565201299, 4535.138323718483, 4714.0, 4914.754262286871, 5097.388313402415, 5149.922751158736, 3836.1943991761486, 3879.321118804198, 3887.2031233597045, 3915.1778126593736, 3944.8422063117728, 1207.8007128823822, 1219.6584956212098, 1228.4103630257525, 1238.0838179746922, 1239.900807935381, 1014.2241185493103, 1054.920880933933, 1209.0992210802833, 1328.2893651896188, 1464.545990742873, 8278.793030174173, 8296.792580185424, 8302.750917472486, 8333.499990000619, 8367.497950123012, 624.5097598385246, 639.6769631336145, 642.399356601579, 648.0570769530322, 797.2904115337354, 6067.939320606825, 6324.367563243731, 6326.272478665012, 6329.936700633027, 6330.430261276507, 10736.248462607542, 11108.389038602792, 11119.110471162288, 11236.438178091063, 11325.508388154592, 11152.275102118336, 11156.107511399068, 11243.156763242789, 11286.0, 11292.0, 8377.204165604258, 8613.78465538354, 8656.307495400353, 8705.825883482295, 8717.825643486967, 8097.878531822145, 8134.75595732129, 8135.064467586303, 8141.552214628252, 8190.549519776231, 9650.613975440903, 9850.0, 9964.10323070898, 10057.0, 10077.647282345082, 8642.524661143698, 10054.396736195851, 10205.489725513844, 10306.793864122825, 10316.793664126826, 7126.966589844547, 7130.465215108784, 7168.784936451915, 7201.2438693938475, 7214.74748383804, 8296.65133367339, 8461.576921154041, 8467.15328467173, 8501.277391421798, 8544.0, 6241.43827055549, 7473.850522989618, 7572.8485430292185, 7707.152213256425, 7737.458377913492, 7219.494635375683, 7300.233475484997, 7327.706891724484, 7346.375558077623, 7403.18564957865, 7889.2110788920645, 7974.5215287082965, 7978.361731061617, 7981.561014144278, 7989.0, 6917.792466226021, 7112.57324560528, 7189.964050179716, 7194.928050719635, 7196.280371962762, 7222.169450513258, 7327.523710958983, 7332.23011583776, 7359.77920662381, 7370.852582948204], "unit": "score", "name": "mootools.html", "value": 4938.493207679453}, {"lowerIsBetter": false, "replicates": [331.2497193855916, 333.0856798089245, 338.82381161795854, 339.4687314353037, 342.6419391735636, 6606.3063378345305, 6696.48881669374, 6705.161854768154, 6718.764843230488, 6739.494537909652, 6239.65681887496, 6828.726850925969, 6836.350546698068, 6838.794836154923, 6851.486138539617, 4768.403949506312, 4795.496472870351, 4806.990531988269, 4873.342098816667, 4974.950250497494, 4863.610911127119, 4882.536159064884, 4885.902281954376, 4918.926216106744, 4938.580220681247, 4875.049365373736, 4879.487653796354, 4881.414230292352, 4881.438634557018, 4889.462159162489, 3915.8042097895277, 4615.907681846361, 4729.47975722672, 4829.806807727687, 4859.781309841065, 3403.302323023774, 3621.2214373909474, 4159.7920103994675, 4166.604172603597, 4168.374743788426, 5323.0, 6049.395060493959, 6373.681315934231, 6396.2964073951825, 6403.103565500834, 5805.477507024388, 5812.564057695689, 5815.767369305223, 5829.154772557998, 5837.678927658977, 7066.681999309992, 7067.328603782633, 7081.575105493635, 7082.397996170332, 7086.185088714812, 4505.301678239878, 4737.715737055788, 4762.1428142934255, 4762.523747625244, 4779.283107533863, 7329.926700732978, 7515.398768098594, 7517.5113617615225, 7533.849323013618, 7544.019277493946, 4836.056968891103, 4839.661223714376, 4850.320955066293, 4859.34398856157, 4864.173090574611, 4901.877453063631, 4916.287138364917, 4925.285833554115, 4927.260910863328, 4928.162212423825, 5847.970760146257, 5851.922567488566, 5864.413558644187, 5873.148393482921, 5874.0, 5469.261649677323, 6991.0, 7015.579065255999, 7016.228214896358, 7019.29807019294, 1312.7308901675133, 1665.950021499357, 1703.5059832648642, 1703.9914800425918, 1704.3608646757466, 1036.8237399642078, 1070.3096502755834, 1091.683411810566, 1094.1192340166083, 1127.7349822791637, 6509.511786616023, 6697.6986035628515, 6707.3628005339415, 6707.731690732316, 6725.226598941086, 7417.8145546361775, 7425.294597013275, 7427.554346739213, 7447.069116360455, 7452.919326697598, 5455.318085239345, 5925.674087925206, 6663.333666633298, 6665.700043498055, 6723.697433615499, 3255.7232635225796, 3799.3731034379016, 3873.3608954522188, 3917.8432862685745, 3930.941035884407, 7491.325780679765, 7743.0, 7785.571793551296, 7800.765977020698, 7815.25755053269, 6564.376384243489, 7659.846803063908, 7674.9232507674205, 7690.807729806687, 7730.1110372306775, 7751.379889608817, 7758.262965018314, 7771.028621422435, 7784.260495252942, 7798.220177982384, 7144.3570078693165, 7398.593077380796, 7424.925750742424, 7425.104209358246, 7445.664945077377, 6558.458432446616, 6708.362705542965, 7266.818329541804, 7300.598467084362, 7310.707571697072, 6717.992301154671, 7245.384142347749, 7738.41961852852, 7738.961305193438, 7773.650185741768, 3867.555231148454, 4414.095110502275, 4569.428821397325, 4637.628989680885, 4644.767761611974, 7000.824979375557, 7355.852882942204, 7370.44721645868, 7380.5940673263485, 7386.0767404074495, 6094.481969032682, 6530.379613936669, 7102.360787529147, 7129.7861064168155, 7131.786046418616, 7098.787036388917, 7110.715571377087, 7132.679029443584, 7133.5719856808755, 7146.392556632536, 5580.302462192226, 6888.48336374784, 6918.0, 6923.688434020582, 6946.409555187865, 6840.760573379908, 7112.57324560528, 7116.857662846817, 7118.750843720445, 7157.427405807627, 6659.53383263167, 6790.694418751267, 6797.93202067973, 6924.0, 7019.0], "unit": "score", "name": "prototype.html", "value": 5165.089270891842}, {"lowerIsBetter": false, "replicates": [702.7294491620726, 746.1754760989105, 758.3743411685361, 783.7335305995964, 789.1201310538751, 15057.322420491077, 15290.31193596288, 15319.157446340447, 15348.539543813675, 15387.076775393483, 13917.443302267922, 14089.084209526374, 14089.929550352233, 14094.859051409483, 14126.929365353184, 795.4352409789057, 796.2395911904117, 949.5157469690473, 949.7578117580008, 975.9463229522373, 925.8518637018078, 938.6245501799301, 938.9859152112724, 940.7930255343813, 992.5831150916596, 849.5370023337265, 1001.4642166440956, 1005.602786899178, 1005.783756492354, 1052.4369462337652, 1011.5801942194017, 1029.9588016479331, 1030.1192480429274, 1031.3038698878302, 1033.1115240892825, 762.4624639629048, 768.4812751392843, 776.0648418655506, 776.4758787818257, 777.3237283563336, 14666.973311868174, 14722.631934201623, 14760.852391476055, 14766.483173088998, 14773.556793296219, 12606.117571769979, 12677.17598356104, 12877.806832897513, 12999.350032498338, 13284.667883302898, 9773.462459564722, 9878.308518403715, 9885.703428897144, 9958.850617240747, 10150.984901509864, 3961.21127948215, 4075.0, 4083.3262511685534, 4087.346024636044, 4162.250794856925, 78329.08354582306, 78553.03617409553, 78628.0, 78927.0, 80030.0, 9231.676891308905, 9358.344915855962, 9427.0, 9479.0, 9562.856557151648, 21487.46281342979, 21488.24791132303, 22065.0, 22385.992630331675, 22425.32724018282, 7589.089309282811, 7618.0, 7836.686532538749, 7858.371330293677, 7929.048514178336, 4103.384492326175, 4198.202341555156, 4227.87316380509, 4230.873073807791, 4294.549072347421, 3726.124360775216, 3772.679322257584, 3777.905552361213, 3782.3759079752085, 3782.8108594570713, 541.8076582813045, 653.7352372289231, 692.8129405060706, 702.1293595940996, 716.5342527357155, 538.8922215556826, 584.9502792262621, 600.648620556979, 625.8060001399581, 634.1280738983897, 7298.379637730853, 7803.648835802403, 8003.599820008976, 8201.917980820235, 8541.829163416696, 598.9670568118795, 612.2744547710977, 615.5875563372551, 632.4055387935326, 639.48840927258, 3876.9418458723144, 3897.3569361055106, 3952.0, 3977.9801100994887, 3982.6216509431556, 98599.50700246452, 99926.0, 100460.49309260368, 101300.0, 102288.48855755673, 83576.0, 83860.16139838645, 84132.0, 84261.31477370419, 85129.57435212909, 73114.0, 74069.62965185248, 74176.88734668984, 74205.88691169636, 75580.24419755732, 8351.457155284887, 8388.412811103164, 8436.36219134805, 8578.871316930376, 8664.310459460345, 47336.76331618457, 48012.7599362001, 49039.0, 50658.74670626623, 52903.0, 52511.16210932599, 67839.0, 70266.48667566704, 71666.64166679133, 71832.64083679549, 11195.944020279847, 11300.265482743594, 11434.37110958872, 11572.537098515964, 11960.10299227544, 11818.290902545874, 11837.704057398634, 12055.51777928873, 12426.62720118398, 12453.315067671365, 11325.546978121112, 11587.188896777145, 11772.941135294612, 11994.160408771302, 12004.2197257178, 11105.66682999479, 11488.425578721197, 11495.712607184552, 11500.942495287805, 11505.079593632656, 11053.668389948314, 11434.256773309708, 11496.022838058525, 11642.0, 11906.940465297617, 9204.907950920406, 9355.298352623444, 9532.046795320413, 9556.856647150438, 9567.760805979906, 9213.815723685622, 9782.657606984007, 9787.559559819967, 9792.706218813448, 9843.0], "unit": "score", "name": "yui.html", "value": 7101.445688280831}], "name": "dromaeo_css", "value": 7662.058280497242}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 111.0, 111.0, 110.0, 112.0, 112.0, 119.0, 112.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.8}, {"lowerIsBetter": true, "replicates": [154.0, 119.0, 155.0, 159.0, 151.0, 137.0, 101.0, 180.0, 176.0, 149.0], "unit": "score", "name": "audio-beat-detection", "value": 148.1}, {"lowerIsBetter": true, "replicates": [185.0, 185.0, 185.0, 185.0, 184.0, 187.0, 184.0, 185.0, 184.0, 184.0], "unit": "score", "name": "audio-dft", "value": 184.8}, {"lowerIsBetter": true, "replicates": [73.0, 80.0, 74.0, 116.0, 56.0, 57.0, 57.0, 58.0, 114.0, 55.0], "unit": "score", "name": "audio-fft", "value": 74.0}, {"lowerIsBetter": true, "replicates": [92.0, 95.0, 129.0, 80.0, 78.0, 88.0, 118.0, 78.0, 79.0, 116.0], "unit": "score", "name": "audio-oscillator", "value": 95.3}, {"lowerIsBetter": true, "replicates": [86.0, 82.0, 86.0, 85.0, 89.0, 83.0, 86.0, 83.0, 86.0, 83.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 84.9}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 93.0, 93.0, 93.0, 92.0, 93.0, 94.0, 93.0, 91.0], "unit": "score", "name": "imaging-darkroom", "value": 92.6}, {"lowerIsBetter": true, "replicates": [86.0, 87.0, 85.0, 87.0, 85.0, 84.0, 83.0, 86.0, 84.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 86.3}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 58.0, 57.0, 61.0, 59.0, 59.0, 70.0, 54.0, 51.0], "unit": "score", "name": "json-parse-financial", "value": 58.2}, {"lowerIsBetter": true, "replicates": [62.0, 65.0, 66.0, 74.0, 69.0, 65.0, 65.0, 64.0, 67.0, 72.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.9}, {"lowerIsBetter": true, "replicates": [80.0, 82.0, 82.0, 82.0, 82.0, 89.0, 88.0, 86.0, 82.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.8}, {"lowerIsBetter": true, "replicates": [119.0, 118.0, 121.0, 131.0, 137.0, 122.0, 117.0, 120.0, 131.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.7}, {"lowerIsBetter": true, "replicates": [134.0, 123.0, 132.0, 135.0, 139.0, 123.0, 134.0, 134.0, 132.0, 134.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 132.0}, {"lowerIsBetter": true, "replicates": [70.0, 66.0, 67.0, 67.0, 66.0, 66.0, 72.0, 55.0, 61.0, 79.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.9}], "name": "kraken", "value": 1409.3000000000002}]} 18:22:54 INFO - Return code: 0 18:22:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:22:54 INFO - # TBPL SUCCESS # 18:22:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:22:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:22:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:22:54 INFO - 2016-04-04 18:22:54.099 screenresolution[1677:9898] starting screenresolution argv=screenresolution get 18:22:54 INFO - 2016-04-04 18:22:54.102 screenresolution[1677:9898] Display 0: 1600x1200x32@60 18:22:54 INFO - 2016-04-04 18:22:54.107 screenresolution[1678:9900] starting screenresolution argv=screenresolution list 18:22:54 INFO - Available Modes on Display 0 18:22:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:22:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:22:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:22:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:22:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:22:54 INFO - Intel Iris: 18:22:54 INFO - Chipset Model: Intel Iris 18:22:54 INFO - Type: GPU 18:22:54 INFO - Bus: Built-In 18:22:54 INFO - VRAM (Dynamic, Max): 1536 MB 18:22:54 INFO - Vendor: Intel (0x8086) 18:22:54 INFO - Device ID: 0x0a2e 18:22:54 INFO - Revision ID: 0x0009 18:22:54 INFO - Displays: 18:22:54 INFO - Display: 18:22:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:22:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:22:54 INFO - Display Serial Number: 1600x1200 60 18:22:54 INFO - Main Display: Yes 18:22:54 INFO - Mirror: Off 18:22:54 INFO - Online: Yes 18:22:54 INFO - Rotation: Supported 18:22:54 INFO - Return code: 0 18:22:54 INFO - Running post-action listener: _resource_record_post_action 18:22:54 INFO - Running post-run listener: _resource_record_post_run 18:22:55 INFO - Total resource usage - Wall time: 1202s; CPU: 53.0%; Read bytes: 37668352; Write bytes: 664273920; Read time: 395; Write time: 2049 18:22:55 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 351894016; Write bytes: 352871936; Read time: 27006; Write time: 620 18:22:55 INFO - run-tests - Wall time: 1171s; CPU: 53.0%; Read bytes: 36713984; Write bytes: 300813824; Read time: 379; Write time: 1395 18:22:55 INFO - Running post-run listener: _upload_blobber_files 18:22:55 INFO - Blob upload gear active. 18:22:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:22:55 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 18:22:55 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:22:55 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:22:56 INFO - (blobuploader) - INFO - Open directory for files ... 18:22:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:22:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:22:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:22:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:22:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:22:57 INFO - (blobuploader) - INFO - Done attempting. 18:22:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:22:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:22:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:22:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:22:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:22:58 INFO - (blobuploader) - INFO - Done attempting. 18:22:58 INFO - (blobuploader) - INFO - Iteration through files over. 18:22:58 INFO - Return code: 0 18:22:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:22:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:22:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/27b3efb8dca02e016cef73e4b0d7879f870effb4f324c73ae3901b63e601d19b42ba2e37e830e54a4833d03518aef7788a9bada547ec3bc9300cccf68276983c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/966e9f5b506d90a9b737e8f5b7d87701af200cc4f8034364c2a3ba9e854b736bbc77a7ea6e6d2d97a0a75c2a771e1b41e8e801b046250102b395d5ec344b13fd"} 18:22:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:22:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:22:58 INFO - Contents: 18:22:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/27b3efb8dca02e016cef73e4b0d7879f870effb4f324c73ae3901b63e601d19b42ba2e37e830e54a4833d03518aef7788a9bada547ec3bc9300cccf68276983c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/966e9f5b506d90a9b737e8f5b7d87701af200cc4f8034364c2a3ba9e854b736bbc77a7ea6e6d2d97a0a75c2a771e1b41e8e801b046250102b395d5ec344b13fd"} 18:22:58 INFO - Running post-run listener: copy_logs_to_upload_dir 18:22:58 INFO - Copying logs to upload dir... 18:22:58 INFO - mkdir: /builds/slave/test/build/upload/logs 18:22:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.620218 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-04-04 18:22:58.370176) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-04 18:22:58.373218) ========= 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.3hJ26QjEQ7/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.72gN0tdMii/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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/Mozilla-Aurora/sha512/27b3efb8dca02e016cef73e4b0d7879f870effb4f324c73ae3901b63e601d19b42ba2e37e830e54a4833d03518aef7788a9bada547ec3bc9300cccf68276983c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/966e9f5b506d90a9b737e8f5b7d87701af200cc4f8034364c2a3ba9e854b736bbc77a7ea6e6d2d97a0a75c2a771e1b41e8e801b046250102b395d5ec344b13fd"} build_url:https://queue.taskcluster.net/v1/task/IkKXPF2XTIaV_zSbaYm1-g/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011349 build_url: 'https://queue.taskcluster.net/v1/task/IkKXPF2XTIaV_zSbaYm1-g/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/27b3efb8dca02e016cef73e4b0d7879f870effb4f324c73ae3901b63e601d19b42ba2e37e830e54a4833d03518aef7788a9bada547ec3bc9300cccf68276983c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/966e9f5b506d90a9b737e8f5b7d87701af200cc4f8034364c2a3ba9e854b736bbc77a7ea6e6d2d97a0a75c2a771e1b41e8e801b046250102b395d5ec344b13fd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-04 18:22:58.400984) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 18:22:58.401265) ========= 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.3hJ26QjEQ7/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.72gN0tdMii/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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.005167 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 18:22:58.451861) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-04 18:22:58.452148) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-04 18:22:58.452479) ========= ========= Total master_lag: 0.27 =========