builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0143 starttime: 1457017024.35 results: success (0) buildid: 20160303052435 builduid: 606940d951dd449a97555ef92dc80887 revision: 6f9ea75e0270ae093bf285729612dd9d960f1aa9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-03 06:57:04.352741) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-03 06:57:04.353210) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-03 06:57:04.353514) ========= 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.cgAoLDtFsa/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.OmHJ7IjD6T/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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.005735 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-03 06:57:04.376356) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-03 06:57:04.376682) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-03 06:57:04.423951) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 06:57:04.424352) ========= 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.cgAoLDtFsa/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.OmHJ7IjD6T/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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.005350 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 06:57:04.472927) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-03 06:57:04.473260) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-03 06:57:04.473622) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 06:57:04.473921) ========= 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.cgAoLDtFsa/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.OmHJ7IjD6T/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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-03-03 06:57:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.01M=0.001s 2016-03-03 06:57:04 (8.01 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.153657 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 06:57:04.642358) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 06:57:04.642672) ========= 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.cgAoLDtFsa/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.OmHJ7IjD6T/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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.019629 ========= master_lag: 0.23 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 06:57:04.895375) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-03 06:57:04.895727) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6f9ea75e0270ae093bf285729612dd9d960f1aa9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 6f9ea75e0270ae093bf285729612dd9d960f1aa9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cgAoLDtFsa/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.OmHJ7IjD6T/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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-03-03 06:57:04,976 truncating revision to first 12 chars 2016-03-03 06:57:04,976 Setting DEBUG logging. 2016-03-03 06:57:04,976 attempt 1/10 2016-03-03 06:57:04,976 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6f9ea75e0270?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-03 06:57:06,883 unpacking tar archive at: fx-team-6f9ea75e0270/testing/mozharness/ program finished with exit code 0 elapsedTime=2.159541 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-03 06:57:07.071371) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-03 06:57:07.071755) ========= echo 6f9ea75e0270ae093bf285729612dd9d960f1aa9 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'6f9ea75e0270ae093bf285729612dd9d960f1aa9'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cgAoLDtFsa/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.OmHJ7IjD6T/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 6f9ea75e0270ae093bf285729612dd9d960f1aa9 program finished with exit code 0 elapsedTime=0.005013 script_repo_revision: '6f9ea75e0270ae093bf285729612dd9d960f1aa9' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-03 06:57:07.121940) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-03 06:57:07.122278) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-03 06:57:07.135088) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-03-03 06:57:07.135439) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cgAoLDtFsa/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.OmHJ7IjD6T/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 06:57:07 INFO - MultiFileLogger online at 20160303 06:57:07 in /builds/slave/test 06:57:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 06:57:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:57:07 INFO - {'append_to_log': False, 06:57:07 INFO - 'base_work_dir': '/builds/slave/test', 06:57:07 INFO - 'blob_upload_branch': 'Fx-Team', 06:57:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:57:07 INFO - 'branch': 'Fx-Team', 06:57:07 INFO - 'buildbot_json_path': 'buildprops.json', 06:57:07 INFO - 'config_files': ('talos/mac_config.py',), 06:57:07 INFO - 'default_actions': ('clobber', 06:57:07 INFO - 'read-buildbot-config', 06:57:07 INFO - 'download-and-extract', 06:57:07 INFO - 'populate-webroot', 06:57:07 INFO - 'create-virtualenv', 06:57:07 INFO - 'install', 06:57:07 INFO - 'run-tests'), 06:57:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:57:07 INFO - 'download_minidump_stackwalk': True, 06:57:07 INFO - 'download_symbols': 'ondemand', 06:57:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:57:07 INFO - 'tooltool.py': '/tools/tooltool.py', 06:57:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:57:07 INFO - '/tools/misc-python/virtualenv.py')}, 06:57:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:57:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:57:07 INFO - 'installer_path': 'installer.exe', 06:57:07 INFO - 'log_level': 'info', 06:57:07 INFO - 'log_name': 'talos', 06:57:07 INFO - 'log_to_console': True, 06:57:07 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:57:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:57:07 INFO - 'opt_config_files': (), 06:57:07 INFO - 'pip_index': False, 06:57:07 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:57:07 INFO - 'cmd': ('bash', 06:57:07 INFO - '-c', 06:57:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:57:07 INFO - 'enabled': True, 06:57:07 INFO - 'halt_on_failure': False, 06:57:07 INFO - 'name': 'check_screen_resolution'},), 06:57:07 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:57:07 INFO - 'cmd': ('bash', 06:57:07 INFO - '-c', 06:57:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:57:07 INFO - 'enabled': True, 06:57:07 INFO - 'halt_on_failure': False, 06:57:07 INFO - 'name': 'check_screen_resolution'},), 06:57:07 INFO - 'run_cmd_checks_enabled': True, 06:57:07 INFO - 'sps_profile': False, 06:57:07 INFO - 'sps_profile_interval': 0, 06:57:07 INFO - 'suite': 'dromaeojs', 06:57:07 INFO - 'system_bits': '32', 06:57:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:57:07 INFO - 'title': 't-yosemite-r7-0143', 06:57:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:57:07 INFO - 'use_talos_json': True, 06:57:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:57:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:57:07 INFO - 'work_dir': 'build'} 06:57:07 INFO - ##### 06:57:07 INFO - ##### Running clobber step. 06:57:07 INFO - ##### 06:57:07 INFO - Running pre-action listener: _resource_record_pre_action 06:57:07 INFO - Running main action method: clobber 06:57:07 INFO - rmtree: /builds/slave/test/build 06:57:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:57:08 INFO - Running post-action listener: _resource_record_post_action 06:57:08 INFO - ##### 06:57:08 INFO - ##### Running read-buildbot-config step. 06:57:08 INFO - ##### 06:57:08 INFO - Running pre-action listener: _resource_record_pre_action 06:57:08 INFO - Running main action method: read_buildbot_config 06:57:08 INFO - Using buildbot properties: 06:57:08 INFO - { 06:57:08 INFO - "project": "", 06:57:08 INFO - "product": "firefox", 06:57:08 INFO - "script_repo_revision": "production", 06:57:08 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 06:57:08 INFO - "repository": "", 06:57:08 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 06:57:08 INFO - "buildid": "20160303052435", 06:57:08 INFO - "pgo_build": "False", 06:57:08 INFO - "basedir": "/builds/slave/test", 06:57:08 INFO - "buildnumber": 445, 06:57:08 INFO - "slavename": "t-yosemite-r7-0143", 06:57:08 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 06:57:08 INFO - "platform": "yosemite_r7", 06:57:08 INFO - "scheduler": "tests-fx-team-macosx64-talos", 06:57:08 INFO - "branch": "fx-team", 06:57:08 INFO - "repo_path": "integration/fx-team", 06:57:08 INFO - "revision": "6f9ea75e0270ae093bf285729612dd9d960f1aa9", 06:57:08 INFO - "stage_platform": "macosx64", 06:57:08 INFO - "builduid": "606940d951dd449a97555ef92dc80887", 06:57:08 INFO - "slavebuilddir": "test" 06:57:08 INFO - } 06:57:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/EllbazKoQcamMHfGFKy7NQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 06:57:08 INFO - Running post-action listener: _resource_record_post_action 06:57:08 INFO - ##### 06:57:08 INFO - ##### Running download-and-extract step. 06:57:08 INFO - ##### 06:57:08 INFO - Running pre-action listener: _resource_record_pre_action 06:57:08 INFO - Running main action method: download_and_extract 06:57:08 INFO - mkdir: /builds/slave/test/build/tests 06:57:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:08 INFO - https://queue.taskcluster.net/v1/task/EllbazKoQcamMHfGFKy7NQ/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 06:57:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EllbazKoQcamMHfGFKy7NQ/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 06:57:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EllbazKoQcamMHfGFKy7NQ/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 06:57:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EllbazKoQcamMHfGFKy7NQ/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 06:57:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EllbazKoQcamMHfGFKy7NQ/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json'}, attempt #1 06:57:09 INFO - Downloaded 1277 bytes. 06:57:09 INFO - Reading from file /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 06:57:09 INFO - Using the following test package requirements: 06:57:09 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 06:57:09 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:57:09 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 06:57:09 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:57:09 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 06:57:09 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:57:09 INFO - u'jsshell-mac.zip'], 06:57:09 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:57:09 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 06:57:09 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 06:57:09 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:57:09 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 06:57:09 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:57:09 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 06:57:09 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:57:09 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 06:57:09 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 06:57:09 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:57:09 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 06:57:09 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:57:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:09 INFO - https://queue.taskcluster.net/v1/task/EllbazKoQcamMHfGFKy7NQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:57:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EllbazKoQcamMHfGFKy7NQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 06:57:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EllbazKoQcamMHfGFKy7NQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 06:57:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EllbazKoQcamMHfGFKy7NQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 06:57:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EllbazKoQcamMHfGFKy7NQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:57:10 INFO - Downloaded 17855024 bytes. 06:57:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:57:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:57:13 INFO - Return code: 0 06:57:13 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 06:57:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:13 INFO - https://queue.taskcluster.net/v1/task/EllbazKoQcamMHfGFKy7NQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:57:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EllbazKoQcamMHfGFKy7NQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 06:57:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EllbazKoQcamMHfGFKy7NQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 06:57:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EllbazKoQcamMHfGFKy7NQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 06:57:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EllbazKoQcamMHfGFKy7NQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:57:14 INFO - Downloaded 17855024 bytes. 06:57:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:57:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:57:18 INFO - Return code: 0 06:57:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:18 INFO - https://queue.taskcluster.net/v1/task/EllbazKoQcamMHfGFKy7NQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 06:57:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EllbazKoQcamMHfGFKy7NQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 06:57:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EllbazKoQcamMHfGFKy7NQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 06:57:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EllbazKoQcamMHfGFKy7NQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 06:57:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EllbazKoQcamMHfGFKy7NQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 06:57:19 INFO - Downloaded 10808282 bytes. 06:57:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:57:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 06:57:19 INFO - Return code: 0 06:57:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:19 INFO - https://queue.taskcluster.net/v1/task/EllbazKoQcamMHfGFKy7NQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 06:57:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EllbazKoQcamMHfGFKy7NQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 06:57:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EllbazKoQcamMHfGFKy7NQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 06:57:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EllbazKoQcamMHfGFKy7NQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 06:57:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EllbazKoQcamMHfGFKy7NQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 06:57:22 INFO - Downloaded 110944313 bytes. 06:57:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EllbazKoQcamMHfGFKy7NQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 06:57:22 INFO - mkdir: /builds/slave/test/properties 06:57:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:57:22 INFO - Writing to file /builds/slave/test/properties/build_url 06:57:22 INFO - Contents: 06:57:22 INFO - build_url:https://queue.taskcluster.net/v1/task/EllbazKoQcamMHfGFKy7NQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 06:57:24 INFO - Running post-action listener: _resource_record_post_action 06:57:24 INFO - Running post-action listener: set_extra_try_arguments 06:57:24 INFO - ##### 06:57:24 INFO - ##### Running populate-webroot step. 06:57:24 INFO - ##### 06:57:24 INFO - Running pre-action listener: _resource_record_pre_action 06:57:24 INFO - Running main action method: populate_webroot 06:57:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:57:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:57:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:57:24 INFO - '--tppagecycles', 06:57:24 INFO - '7'], 06:57:24 INFO - 'tests': ['tsvgm']}}, 06:57:24 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:57:24 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:57:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:57:24 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 06:57:24 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:57:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:57:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:57:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:57:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:57:24 INFO - 'talos_options': ['--e10s'], 06:57:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:57:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:57:24 INFO - 'tests': ['damp', 'tps']}, 06:57:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:57:24 INFO - 'talos_options': ['--e10s'], 06:57:24 INFO - 'tests': ['damp', 'tps']}, 06:57:24 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:57:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:57:24 INFO - 'other': {'tests': ['a11yr', 06:57:24 INFO - 'ts_paint', 06:57:24 INFO - 'tpaint', 06:57:24 INFO - 'sessionrestore', 06:57:24 INFO - 'sessionrestore_no_auto_restore']}, 06:57:24 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:57:24 INFO - 'tests': ['a11yr', 06:57:24 INFO - 'ts_paint', 06:57:24 INFO - 'tpaint', 06:57:24 INFO - 'sessionrestore', 06:57:24 INFO - 'sessionrestore_no_auto_restore']}, 06:57:24 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:57:24 INFO - 'tests': ['a11yr', 06:57:24 INFO - 'ts_paint', 06:57:24 INFO - 'tpaint', 06:57:24 INFO - 'sessionrestore', 06:57:24 INFO - 'sessionrestore_no_auto_restore']}, 06:57:24 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:57:24 INFO - 'tests': ['a11yr', 06:57:24 INFO - 'ts_paint', 06:57:24 INFO - 'tpaint', 06:57:24 INFO - 'sessionrestore', 06:57:24 INFO - 'sessionrestore_no_auto_restore']}, 06:57:24 INFO - 'other_l64': {'tests': ['a11yr', 06:57:24 INFO - 'ts_paint', 06:57:24 INFO - 'tpaint', 06:57:24 INFO - 'sessionrestore', 06:57:24 INFO - 'sessionrestore_no_auto_restore']}, 06:57:24 INFO - 'other_nol64': {'tests': ['a11yr', 06:57:24 INFO - 'ts_paint', 06:57:24 INFO - 'tpaint', 06:57:24 INFO - 'sessionrestore', 06:57:24 INFO - 'sessionrestore_no_auto_restore']}, 06:57:24 INFO - 'svgr': {'tests': ['tsvgx', 06:57:24 INFO - 'tsvgr_opacity', 06:57:24 INFO - 'tart', 06:57:24 INFO - 'tscrollx', 06:57:24 INFO - 'cart']}, 06:57:24 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:57:24 INFO - 'tests': ['tsvgx', 06:57:24 INFO - 'tsvgr_opacity', 06:57:24 INFO - 'tart', 06:57:24 INFO - 'tscrollx', 06:57:24 INFO - 'cart']}, 06:57:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:57:24 INFO - 'tests': ['tp5o']}, 06:57:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:57:24 INFO - 'talos_options': ['--e10s'], 06:57:24 INFO - 'tests': ['tp5o']}, 06:57:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:57:24 INFO - 'talos_options': ['--xperf_path', 06:57:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:57:24 INFO - 'tests': ['tp5n']}, 06:57:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:57:24 INFO - 'talos_options': ['--e10s', 06:57:24 INFO - '--xperf_path', 06:57:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:57:24 INFO - 'tests': ['tp5n']}}, 06:57:24 INFO - 'talos.zip': {'path': '', 06:57:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:57:24 INFO - Running post-action listener: _resource_record_post_action 06:57:24 INFO - ##### 06:57:24 INFO - ##### Running create-virtualenv step. 06:57:24 INFO - ##### 06:57:24 INFO - Running pre-action listener: _resource_record_pre_action 06:57:24 INFO - Running main action method: create_virtualenv 06:57:24 INFO - Creating virtualenv /builds/slave/test/build/venv 06:57:24 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:57:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:57:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:57:24 INFO - Using real prefix '/tools/python27' 06:57:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:57:24 INFO - Installing distribute.............................................................................................................................................................................................done. 06:57:27 INFO - Installing pip.................done. 06:57:27 INFO - Return code: 0 06:57:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:57:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10529ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052a64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3e3467640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105142d30>, '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 0x104f66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105139b20>, '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.cgAoLDtFsa/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.OmHJ7IjD6T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:57:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:57:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:57:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cgAoLDtFsa/Render', 06:57:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:57:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:57:27 INFO - 'HOME': '/Users/cltbld', 06:57:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:57:27 INFO - 'LOGNAME': 'cltbld', 06:57:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:27 INFO - 'MOZ_NO_REMOTE': '1', 06:57:27 INFO - 'NO_EM_RESTART': '1', 06:57:27 INFO - 'PAGER': '/bin/cat', 06:57:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:57:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:27 INFO - 'PWD': '/builds/slave/test', 06:57:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:57:27 INFO - 'SHELL': '/bin/bash', 06:57:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OmHJ7IjD6T/Listeners', 06:57:27 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 06:57:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:57:27 INFO - 'USER': 'cltbld', 06:57:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:57:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:57:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:27 INFO - 'XPC_FLAGS': '0x0', 06:57:27 INFO - 'XPC_SERVICE_NAME': '0', 06:57:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:57:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:28 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:57:28 INFO - Cleaning up... 06:57:28 INFO - Return code: 0 06:57:28 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:57:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57: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', '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 0x10529ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052a64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3e3467640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105142d30>, '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 0x104f66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105139b20>, '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.cgAoLDtFsa/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.OmHJ7IjD6T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:57: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', 'psutil>=0.7.1'] in /builds/slave/test/build 06:57: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 psutil>=0.7.1 06:57:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cgAoLDtFsa/Render', 06:57:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:57:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:57:28 INFO - 'HOME': '/Users/cltbld', 06:57:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:57:28 INFO - 'LOGNAME': 'cltbld', 06:57:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:28 INFO - 'MOZ_NO_REMOTE': '1', 06:57:28 INFO - 'NO_EM_RESTART': '1', 06:57:28 INFO - 'PAGER': '/bin/cat', 06:57:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:57:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:28 INFO - 'PWD': '/builds/slave/test', 06:57:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:57:28 INFO - 'SHELL': '/bin/bash', 06:57:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OmHJ7IjD6T/Listeners', 06:57:28 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 06:57:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:57:28 INFO - 'USER': 'cltbld', 06:57:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:57:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:57:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:28 INFO - 'XPC_FLAGS': '0x0', 06:57:28 INFO - 'XPC_SERVICE_NAME': '0', 06:57:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:57:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:28 INFO - Downloading/unpacking psutil>=0.7.1 06:57: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 06:57: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 06:57: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 06:57: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 06:57: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 06:57: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 06:57:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:57:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:57:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:57:31 INFO - Installing collected packages: psutil 06:57:31 INFO - Running setup.py install for psutil 06:57:31 INFO - building 'psutil._psutil_osx' extension 06:57:31 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 06:57:31 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 06:57:31 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 06:57:31 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 06:57:31 INFO - building 'psutil._psutil_posix' extension 06:57:31 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 06:57:31 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:57:31 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:57:31 INFO - ^ 06:57:31 INFO - 1 warning generated. 06:57:31 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 06:57:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:57:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:57:32 INFO - Successfully installed psutil 06:57:32 INFO - Cleaning up... 06:57:32 INFO - Return code: 0 06:57:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:57:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:32 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 0x10529ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052a64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3e3467640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105142d30>, '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 0x104f66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105139b20>, '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.cgAoLDtFsa/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.OmHJ7IjD6T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:57:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 06:57:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 06:57:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cgAoLDtFsa/Render', 06:57:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:57:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:57:32 INFO - 'HOME': '/Users/cltbld', 06:57:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:57:32 INFO - 'LOGNAME': 'cltbld', 06:57:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:32 INFO - 'MOZ_NO_REMOTE': '1', 06:57:32 INFO - 'NO_EM_RESTART': '1', 06:57:32 INFO - 'PAGER': '/bin/cat', 06:57:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:57:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:32 INFO - 'PWD': '/builds/slave/test', 06:57:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:57:32 INFO - 'SHELL': '/bin/bash', 06:57:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OmHJ7IjD6T/Listeners', 06:57:32 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 06:57:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:57:32 INFO - 'USER': 'cltbld', 06:57:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:57:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:57:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:32 INFO - 'XPC_FLAGS': '0x0', 06:57:32 INFO - 'XPC_SERVICE_NAME': '0', 06:57:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:57:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:32 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:57: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 06:57: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 06:57: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 06:57: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 06:57: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 06:57: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 06:57:34 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:57:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:57:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:57:34 INFO - Installing collected packages: mozsystemmonitor 06:57:34 INFO - Running setup.py install for mozsystemmonitor 06:57:34 INFO - Successfully installed mozsystemmonitor 06:57:34 INFO - Cleaning up... 06:57:35 INFO - Return code: 0 06:57:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:57:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:35 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 0x10529ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052a64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3e3467640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105142d30>, '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 0x104f66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105139b20>, '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.cgAoLDtFsa/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.OmHJ7IjD6T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:57:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:57:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:57:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cgAoLDtFsa/Render', 06:57:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:57:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:57:35 INFO - 'HOME': '/Users/cltbld', 06:57:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:57:35 INFO - 'LOGNAME': 'cltbld', 06:57:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:35 INFO - 'MOZ_NO_REMOTE': '1', 06:57:35 INFO - 'NO_EM_RESTART': '1', 06:57:35 INFO - 'PAGER': '/bin/cat', 06:57:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:57:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:35 INFO - 'PWD': '/builds/slave/test', 06:57:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:57:35 INFO - 'SHELL': '/bin/bash', 06:57:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OmHJ7IjD6T/Listeners', 06:57:35 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 06:57:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:57:35 INFO - 'USER': 'cltbld', 06:57:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:57:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:57:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:35 INFO - 'XPC_FLAGS': '0x0', 06:57:35 INFO - 'XPC_SERVICE_NAME': '0', 06:57:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:57:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:35 INFO - Downloading/unpacking blobuploader==1.2.4 06:57:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:37 INFO - Downloading blobuploader-1.2.4.tar.gz 06:57:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:57:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:57:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:57:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:57:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:38 INFO - Downloading docopt-0.6.1.tar.gz 06:57:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:57:38 INFO - Installing collected packages: blobuploader, requests, docopt 06:57:38 INFO - Running setup.py install for blobuploader 06:57:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:57:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:57:39 INFO - Running setup.py install for requests 06:57:39 INFO - Running setup.py install for docopt 06:57:39 INFO - Successfully installed blobuploader requests docopt 06:57:39 INFO - Cleaning up... 06:57:39 INFO - Return code: 0 06:57:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:57:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:39 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 0x10529ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052a64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3e3467640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105142d30>, '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 0x104f66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105139b20>, '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.cgAoLDtFsa/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.OmHJ7IjD6T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:57:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:57:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:57:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cgAoLDtFsa/Render', 06:57:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:57:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:57:39 INFO - 'HOME': '/Users/cltbld', 06:57:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:57:39 INFO - 'LOGNAME': 'cltbld', 06:57:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:39 INFO - 'MOZ_NO_REMOTE': '1', 06:57:39 INFO - 'NO_EM_RESTART': '1', 06:57:39 INFO - 'PAGER': '/bin/cat', 06:57:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:57:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:39 INFO - 'PWD': '/builds/slave/test', 06:57:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:57:39 INFO - 'SHELL': '/bin/bash', 06:57:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OmHJ7IjD6T/Listeners', 06:57:39 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 06:57:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:57:39 INFO - 'USER': 'cltbld', 06:57:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:57:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:57:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:39 INFO - 'XPC_FLAGS': '0x0', 06:57:39 INFO - 'XPC_SERVICE_NAME': '0', 06:57:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:57:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:57:40 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-bBftHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:57:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:57:40 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-pU84hx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:57:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:57:40 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-DXxhvZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:57:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:57:40 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-qnjZcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:57:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:57:40 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-aKVQ7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:57:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:57:40 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-DIJhhh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:57:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:57:40 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-5snzl4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:57:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:57:40 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-rmEgDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:57:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:57:40 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-T6C7g0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:57:41 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-SnWxxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:57:41 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-ai1SrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:57:41 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-xqxsuD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:57:41 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-CH05Uo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:57:41 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-ofOJPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:57:41 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-nAyCca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:57:41 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-ymMnOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:57:41 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-QSfcGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:57:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:57:41 INFO - Running setup.py install for manifestparser 06:57:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:57:42 INFO - Running setup.py install for mozcrash 06:57:42 INFO - Running setup.py install for mozdebug 06:57:42 INFO - Running setup.py install for mozdevice 06:57:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:57:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:57:42 INFO - Running setup.py install for mozfile 06:57:42 INFO - Running setup.py install for mozhttpd 06:57:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:57:42 INFO - Running setup.py install for mozinfo 06:57:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:57:42 INFO - Running setup.py install for mozInstall 06:57:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:57:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:57:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:57:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:57:43 INFO - Running setup.py install for mozleak 06:57:43 INFO - Running setup.py install for mozlog 06:57:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:57:43 INFO - Running setup.py install for moznetwork 06:57:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:57:43 INFO - Running setup.py install for mozprocess 06:57:43 INFO - Running setup.py install for mozprofile 06:57:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:57:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:57:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:57:43 INFO - Running setup.py install for mozrunner 06:57:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:57:43 INFO - Running setup.py install for mozscreenshot 06:57:44 INFO - Running setup.py install for moztest 06:57:44 INFO - Running setup.py install for mozversion 06:57:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:57:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:57:44 INFO - Cleaning up... 06:57:44 INFO - Return code: 0 06:57:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:57:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:44 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 0x10529ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052a64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3e3467640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105142d30>, '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 0x104f66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105139b20>, '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.cgAoLDtFsa/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.OmHJ7IjD6T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:57:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:57:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:57:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cgAoLDtFsa/Render', 06:57:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:57:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:57:44 INFO - 'HOME': '/Users/cltbld', 06:57:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:57:44 INFO - 'LOGNAME': 'cltbld', 06:57:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:44 INFO - 'MOZ_NO_REMOTE': '1', 06:57:44 INFO - 'NO_EM_RESTART': '1', 06:57:44 INFO - 'PAGER': '/bin/cat', 06:57:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:57:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:44 INFO - 'PWD': '/builds/slave/test', 06:57:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:57:44 INFO - 'SHELL': '/bin/bash', 06:57:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OmHJ7IjD6T/Listeners', 06:57:44 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 06:57:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:57:44 INFO - 'USER': 'cltbld', 06:57:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:57:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:57:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:44 INFO - 'XPC_FLAGS': '0x0', 06:57:44 INFO - 'XPC_SERVICE_NAME': '0', 06:57:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:57:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:57:44 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-oiJkLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:57:44 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:57:44 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-sum3q3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:57:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:57:44 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-JjamlG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:57:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:57:45 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-LOkR1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:57:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:57:45 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-taRkCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:57:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:57:45 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-vdesEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:57:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:57:45 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-aeDAl0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:57:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:57:45 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-KI6bv0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:57:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:57:45 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-RKM80l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:57:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:57:45 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-AFFzR2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:57:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:57:45 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-jUcOjs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:57:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:57:45 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-WNzr0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:57:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:57:45 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-5G89u2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:57:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:57:46 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-5iTKaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:57:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:57:46 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-n8XPue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:57:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:57:46 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-l0F19K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:57:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:57:46 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-_YRI7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:57:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:57:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:57:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:57:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:57:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:57:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:57:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:57: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 06:57: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 06:57: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 06:57: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 06:57: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 06:57: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 06:57:49 INFO - Downloading blessings-1.6.tar.gz 06:57:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:57:49 INFO - Installing collected packages: blessings 06:57:49 INFO - Running setup.py install for blessings 06:57:49 INFO - Successfully installed blessings 06:57:49 INFO - Cleaning up... 06:57:49 INFO - Return code: 0 06:57:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:57:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:57:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:57:49 INFO - Reading from file tmpfile_stdout 06:57:49 INFO - Current package versions: 06:57:49 INFO - blessings == 1.6 06:57:49 INFO - blobuploader == 1.2.4 06:57:49 INFO - docopt == 0.6.1 06:57:49 INFO - manifestparser == 1.1 06:57:49 INFO - mozInstall == 1.12 06:57:49 INFO - mozcrash == 0.16 06:57:49 INFO - mozdebug == 0.1 06:57:49 INFO - mozdevice == 0.48 06:57:49 INFO - mozfile == 1.2 06:57:49 INFO - mozhttpd == 0.7 06:57:49 INFO - mozinfo == 0.9 06:57:49 INFO - mozleak == 0.1 06:57:49 INFO - mozlog == 3.1 06:57:49 INFO - moznetwork == 0.27 06:57:49 INFO - mozprocess == 0.22 06:57:49 INFO - mozprofile == 0.28 06:57:49 INFO - mozrunner == 6.11 06:57:49 INFO - mozscreenshot == 0.1 06:57:49 INFO - mozsystemmonitor == 0.0 06:57:49 INFO - moztest == 0.7 06:57:49 INFO - mozversion == 1.4 06:57:49 INFO - psutil == 3.1.1 06:57:49 INFO - requests == 1.2.3 06:57:49 INFO - wsgiref == 0.1.2 06:57:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:57:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:49 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 0x10529ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052a64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3e3467640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105142d30>, '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 0x104f66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105139b20>, '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.cgAoLDtFsa/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.OmHJ7IjD6T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:57:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:57:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:57:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cgAoLDtFsa/Render', 06:57:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:57:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:57:49 INFO - 'HOME': '/Users/cltbld', 06:57:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:57:49 INFO - 'LOGNAME': 'cltbld', 06:57:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:49 INFO - 'MOZ_NO_REMOTE': '1', 06:57:49 INFO - 'NO_EM_RESTART': '1', 06:57:49 INFO - 'PAGER': '/bin/cat', 06:57:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:57:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:49 INFO - 'PWD': '/builds/slave/test', 06:57:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:57:49 INFO - 'SHELL': '/bin/bash', 06:57:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OmHJ7IjD6T/Listeners', 06:57:49 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 06:57:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:57:49 INFO - 'USER': 'cltbld', 06:57:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:57:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:57:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:49 INFO - 'XPC_FLAGS': '0x0', 06:57:49 INFO - 'XPC_SERVICE_NAME': '0', 06:57:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:57:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:57:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:57:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:57:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:57:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:57:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:57:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:57:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:57:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:57:49 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:57:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:57:49 INFO - Cleaning up... 06:57:49 INFO - Return code: 0 06:57:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:57:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10529ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052a64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3e3467640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105142d30>, '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 0x104f66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105139b20>, '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.cgAoLDtFsa/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.OmHJ7IjD6T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:57:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:57:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:57:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cgAoLDtFsa/Render', 06:57:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:57:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:57:49 INFO - 'HOME': '/Users/cltbld', 06:57:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:57:49 INFO - 'LOGNAME': 'cltbld', 06:57:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:49 INFO - 'MOZ_NO_REMOTE': '1', 06:57:49 INFO - 'NO_EM_RESTART': '1', 06:57:49 INFO - 'PAGER': '/bin/cat', 06:57:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:57:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:49 INFO - 'PWD': '/builds/slave/test', 06:57:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:57:49 INFO - 'SHELL': '/bin/bash', 06:57:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OmHJ7IjD6T/Listeners', 06:57:49 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 06:57:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:57:49 INFO - 'USER': 'cltbld', 06:57:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:57:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:57:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:49 INFO - 'XPC_FLAGS': '0x0', 06:57:49 INFO - 'XPC_SERVICE_NAME': '0', 06:57:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:57:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:50 INFO - Downloading/unpacking jsonschema 06:57: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 06:57: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 06:57: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 06:57: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 06:57: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 06:57: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 06:57:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:57:52 INFO - Downloading/unpacking functools32 (from jsonschema) 06:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:52 INFO - Downloading functools32-3.2.3-2.tar.gz 06:57:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:57:53 INFO - warning: no files found matching '*.txt' 06:57:53 INFO - no previously-included directories found matching 'build' 06:57:53 INFO - no previously-included directories found matching 'dist' 06:57:53 INFO - no previously-included directories found matching '.git*' 06:57:53 INFO - Installing collected packages: jsonschema, functools32 06:57:53 INFO - Running setup.py install for functools32 06:57:53 INFO - warning: no files found matching '*.txt' 06:57:53 INFO - no previously-included directories found matching 'build' 06:57:53 INFO - no previously-included directories found matching 'dist' 06:57:53 INFO - no previously-included directories found matching '.git*' 06:57:53 INFO - Successfully installed jsonschema functools32 06:57:53 INFO - Cleaning up... 06:57:53 INFO - Return code: 0 06:57:53 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:57:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:53 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 0x10529ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052a64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3e3467640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105142d30>, '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 0x104f66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105139b20>, '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.cgAoLDtFsa/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.OmHJ7IjD6T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:57:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 06:57:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 06:57:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cgAoLDtFsa/Render', 06:57:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:57:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:57:53 INFO - 'HOME': '/Users/cltbld', 06:57:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:57:53 INFO - 'LOGNAME': 'cltbld', 06:57:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:53 INFO - 'MOZ_NO_REMOTE': '1', 06:57:53 INFO - 'NO_EM_RESTART': '1', 06:57:53 INFO - 'PAGER': '/bin/cat', 06:57:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:57:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:53 INFO - 'PWD': '/builds/slave/test', 06:57:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:57:53 INFO - 'SHELL': '/bin/bash', 06:57:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OmHJ7IjD6T/Listeners', 06:57:53 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 06:57:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:57:53 INFO - 'USER': 'cltbld', 06:57:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:57:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:57:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:53 INFO - 'XPC_FLAGS': '0x0', 06:57:53 INFO - 'XPC_SERVICE_NAME': '0', 06:57:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:57:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:53 INFO - Downloading/unpacking flake8 06:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:57:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:57:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:57:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:57:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:57:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:57:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:57:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:57:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:57:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:57:57 INFO - no previously-included directories found matching 'docs/_build' 06:57:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:57:57 INFO - Running setup.py install for pep8 06:57:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:57:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:57:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:57:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:57:57 INFO - no previously-included directories found matching 'docs/_build' 06:57:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:57:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:57:57 INFO - Cleaning up... 06:57:57 INFO - Return code: 0 06:57:57 INFO - Running post-action listener: _resource_record_post_action 06:57:57 INFO - Running post-action listener: _start_resource_monitoring 06:57:57 INFO - Starting resource monitoring. 06:57:57 INFO - ##### 06:57:57 INFO - ##### Running install step. 06:57:57 INFO - ##### 06:57:57 INFO - Running pre-action listener: _resource_record_pre_action 06:57:57 INFO - Running main action method: install 06:57:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:57:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:57:57 INFO - Reading from file tmpfile_stdout 06:57:57 INFO - Detecting whether we're running mozinstall >=1.0... 06:57:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:57:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:57:57 INFO - Reading from file tmpfile_stdout 06:57:57 INFO - Output received: 06:57:57 INFO - Usage: mozinstall [options] installer 06:57:57 INFO - Options: 06:57:57 INFO - -h, --help show this help message and exit 06:57:57 INFO - -d DEST, --destination=DEST 06:57:57 INFO - Directory to install application into. [default: 06:57:57 INFO - "/builds/slave/test"] 06:57:57 INFO - --app=APP Application being installed. [default: firefox] 06:57:57 INFO - mkdir: /builds/slave/test/build/application 06:57:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:57:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 06:58:32 INFO - Reading from file tmpfile_stdout 06:58:32 INFO - Output received: 06:58:32 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:58:32 INFO - Running post-action listener: _resource_record_post_action 06:58:32 INFO - ##### 06:58:32 INFO - ##### Running run-tests step. 06:58:32 INFO - ##### 06:58:32 INFO - Running pre-action listener: _resource_record_pre_action 06:58:32 INFO - Running main action method: run_tests 06:58:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:58:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:58:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:58:32 INFO - 2016-03-03 06:58:32.153 screenresolution[1983:13349] starting screenresolution argv=screenresolution get 06:58:32 INFO - 2016-03-03 06:58:32.156 screenresolution[1983:13349] Display 0: 1600x1200x32@60 06:58:32 INFO - 2016-03-03 06:58:32.162 screenresolution[1984:13351] starting screenresolution argv=screenresolution list 06:58:32 INFO - Available Modes on Display 0 06:58:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:58:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:58:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:58:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:58:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:58:32 INFO - Intel Iris: 06:58:32 INFO - Chipset Model: Intel Iris 06:58:32 INFO - Type: GPU 06:58:32 INFO - Bus: Built-In 06:58:32 INFO - VRAM (Dynamic, Max): 1536 MB 06:58:32 INFO - Vendor: Intel (0x8086) 06:58:32 INFO - Device ID: 0x0a2e 06:58:32 INFO - Revision ID: 0x0009 06:58:32 INFO - Displays: 06:58:32 INFO - Display: 06:58:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:58:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:58:32 INFO - Display Serial Number: 1600x1200 60 06:58:32 INFO - Main Display: Yes 06:58:32 INFO - Mirror: Off 06:58:32 INFO - Online: Yes 06:58:32 INFO - Rotation: Supported 06:58:32 INFO - Return code: 0 06:58:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:58:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:58:32 INFO - Python 2.7.3 06:58:32 INFO - Return code: 0 06:58:32 INFO - grabbing minidump binary from tooltool 06:58:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:32 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 0x105142d30>, '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 0x104f66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105139b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:58:32 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:58:32 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 06:58:32 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:58:32 INFO - Return code: 0 06:58:32 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:58:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:58:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:58:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:58:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:58:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:58:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:58:33 INFO - Return code: 0 06:58:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EllbazKoQcamMHfGFKy7NQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0143', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:58:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EllbazKoQcamMHfGFKy7NQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0143 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:58:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cgAoLDtFsa/Render', 06:58:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:58:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:58:33 INFO - 'HOME': '/Users/cltbld', 06:58:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:58:33 INFO - 'LOGNAME': 'cltbld', 06:58:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:58:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:58:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:33 INFO - 'MOZ_NO_REMOTE': '1', 06:58:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:58:33 INFO - 'NO_EM_RESTART': '1', 06:58:33 INFO - 'PAGER': '/bin/cat', 06:58:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:58:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:33 INFO - 'PWD': '/builds/slave/test', 06:58:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:58:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:58:33 INFO - 'SHELL': '/bin/bash', 06:58:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OmHJ7IjD6T/Listeners', 06:58:33 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 06:58:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:58:33 INFO - 'USER': 'cltbld', 06:58:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:58:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:58:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:33 INFO - 'XPC_FLAGS': '0x0', 06:58:33 INFO - 'XPC_SERVICE_NAME': '0', 06:58:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:58:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EllbazKoQcamMHfGFKy7NQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0143', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:58:33 INFO - mozversion application_buildid: 20160303052435 06:58:33 INFO - mozversion application_changeset: 6f9ea75e0270ae093bf285729612dd9d960f1aa9 06:58:33 INFO - mozversion application_display_name: Nightly 06:58:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:58:33 INFO - mozversion application_name: Firefox 06:58:33 INFO - mozversion application_remotingname: firefox 06:58:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:58:33 INFO - mozversion application_vendor: Mozilla 06:58:33 INFO - mozversion application_version: 47.0a1 06:58:33 INFO - mozversion platform_buildid: 20160303052435 06:58:33 INFO - mozversion platform_changeset: 6f9ea75e0270ae093bf285729612dd9d960f1aa9 06:58:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:58:33 INFO - mozversion platform_version: 47.0a1 06:58:33 INFO - using testdate: 1457017113 06:58:33 INFO - actual date: 1457017113 06:58:34 INFO - starting webserver on 'localhost:51350' 06:58:34 INFO - SUITE-START | Running 2 tests 06:58:34 INFO - TEST-START | dromaeo_css 06:58:34 INFO - operating with platform_type : mac_ 06:58:34 INFO - Initialising browser for dromaeo_css test... 06:58:34 INFO - TEST-INFO | started process 2002 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/2lld364j46g___08n54mb94h00000w/T/tmpc7UAaP/profile http://localhost:51350/getInfo.html) 06:58:36 INFO - PROCESS | 2002 | __metrics Screen width/height:1600/1200 06:58:36 INFO - PROCESS | 2002 | colorDepth:24 06:58:36 INFO - PROCESS | 2002 | Browser inner width/height: 1024/689 06:58:36 INFO - PROCESS | 2002 | __metrics 06:58:36 INFO - PROCESS | 2002 | 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" 06:58:36 INFO - PROCESS | 2002 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:58:37 INFO - TEST-INFO | 2002: exit 0 06:58:37 INFO - Browser initialized. 06:58:37 INFO - Running cycle 1/1 for dromaeo_css test... 06:58:37 INFO - TEST-INFO | started process 2005 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/2lld364j46g___08n54mb94h00000w/T/tmpc7UAaP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:58:49 INFO - PROCESS | 2005 | RSS: Main: 243482624 06:58:49 INFO - PROCESS | 2005 | 06:59:40 INFO - PROCESS | 2005 | 1457017180115 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] 07:01:50 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:51350/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51350/tests/dromaeo/cssquery-ext.html) 07:01:51 INFO - PROCESS | 2005 | RSS: Main: 411496448 07:01:51 INFO - PROCESS | 2005 | 07:04:54 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:51350/tests/dromaeo/cssquery-ext.html (next: http://localhost:51350/tests/dromaeo/cssquery-jquery.html) 07:04:55 INFO - PROCESS | 2005 | RSS: Main: 372310016 07:04:55 INFO - PROCESS | 2005 | 07:07:57 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:51350/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51350/tests/dromaeo/cssquery-mootools.html) 07:07:57 INFO - PROCESS | 2005 | RSS: Main: 374804480 07:07:57 INFO - PROCESS | 2005 | 07:11:00 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:51350/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51350/tests/dromaeo/cssquery-prototype.html) 07:11:00 INFO - PROCESS | 2005 | RSS: Main: 329588736 07:11:00 INFO - PROCESS | 2005 | 07:14:03 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:51350/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51350/tests/dromaeo/cssquery-yui.html) 07:14:04 INFO - PROCESS | 2005 | RSS: Main: 333676544 07:14:04 INFO - PROCESS | 2005 | 07:17:07 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:51350/tests/dromaeo/cssquery-yui.html (next: http://localhost:51350/tests/dromaeo/cssquery-dojo.html) 07:17:07 INFO - PROCESS | 2005 | RSS: Main: 382459904 07:17:07 INFO - PROCESS | 2005 | 07:17:07 INFO - PROCESS | 2005 | __start_tp_report 07:17:07 INFO - PROCESS | 2005 | _x_x_mozilla_page_load 07:17:07 INFO - PROCESS | 2005 | _x_x_mozilla_page_load_details 07:17:07 INFO - PROCESS | 2005 | |i|pagename|runs| 07:17:07 INFO - PROCESS | 2005 | |0;dojo.html;3383.390989621868;3465.4108801503744;3481.199324155444;3505.1412403961003;3542.6457354264576;5621.213030175769;5640.492355687988;5655.773769049239;5657.9717101414535;5660.8301750947485;5655.123455864347;5662.801801936923;5674.148877668352;5803.564732645058;5805.071188609823;5046.470120637336;5096.617753668481;5120.257562653413;5124.948750512484;5225.8954820903555;5191.610629202825;5216.061109000379;5246.868828279305;5254.8686282842855;5311.521963023327;5062.696238225718;5084.720340381277;5178.093833579109;5180.4042535108565;5184.14461613837;5116.795328186868;5128.589712823003;5151.639385243035;5151.974240128813;5163;5087;5118.206677964921;5123.974380128076;5131.563817075553;5142.280080788692;5528.170774383834;5538.169274608841;5629.521490673298;5648.152777083429;5665.773369065232;6188.350223226586;6194.1018552310115;6196.101565273055;6209.130721698965;6224.066390041485;6209.751609935597;6260.530460215502;6285.8742825143245;6286.9056964145575;6289.182406287154;5651.8304450866535;5714.628549144292;5752.683602401867;5801.274840644919;5822.417758224228;6256.718447669866;6258.593191442542;6267.0286105653695;6279.623222606659;6287.056941458818;6060.848478787977;6061.909071363933;6134.9079763803575;6147.969260153671;6159.96920015406;5196.220566914993;6128.167033931328;6174.598651087665;6278.874422511524;6314;6232.657203853741;6233.563650544418;6235.719392627252;6249;6261.7182226799905;6217.160683307786;6226.40849119333;6240.126382306481;6251.687415629201;6251.812445626639;4806.351142595705;4850.151223535867;4878.560929516289;4887.340209071801;4932.506749325111;3841.2701586698436;4325.956740432618;4404.229259879508;4434.268345722984;4501.617362524156;5640.661560306395;5660.85847853807;5665.971670141623;5678.545716342683;5679.148127780783;6162.383761623802;6175.475084617768;6176.752929882844;6181.96909015452;6185.876282474325;5526.336839579276;5618.634788738719;5624.634398764068;5653.378128405872;5703.74333155009;5334.653247538898;5376.838694839083;5388.54197393226;5426.050441172858;5439.728013599304;6315.5894866833505;6325.304216536086;6332.208473940757;6333.018382150774;6337.271213810286;6148.50811935053;6172.722227499863;6236.064590311489;6298.590591611531;6307.716152773228;5233.424323324507;6279.058141278845;6345.397187267202;6347.904781428375;6353.9046914295395;6167.938320616737;6186.721597528032;6186.907196392148;6188.535859810442;6188.535859810622;6094.289949776058;6180.289266734383;6285.151504546828;6289.7484100635465;6318.968405157945;6107.9389206109145;6110.801781737314;6116.579253789288;6124.777645458507;6125.84596676928;6036.7585296589405;6076.453119219292;6085.513158947185;6091.42131497507;6098;5823.4467725566;5827.562932779973;5904.114382842608;5942.049272116441;5959.910601340896;5997.950358687125;6021.488173505301;6054.848628784315;6067.302260240129;6073.817785466443;5896.970515147397;5900.262467191601;5908.645481271137;5910.881782364243;5918.348981611933 07:17:07 INFO - PROCESS | 2005 | |1;ext.html;456.4522572912506;566.2921348314607;566.3486989961541;627.2786295759876;639.6322114784;35162;38737;38797.80601096994;38825.8058709706;39029.80485097578;42196.57803421965;42519.36220956688;42886.35670464946;42892.785536072355;42938.78530607343;9509.33434659574;9712;9733.707988760349;9741;9749.366291191085;9514.286428517855;9659.372140810825;9662.32363734539;9669.854952175723;9673.03269673034;9739.853902191473;9817.754556136118;9819.067188617106;9829.901700983006;9848.064433878806;9733;9774.218062554979;9809.509524523744;9812.705618831447;9844.45855477952;9574.090461406155;9751.317407781458;9755.463449510275;9762.951185244028;9765.267604929588;40496;40813;40827.97930051743;40838.59161408377;40872.59127408747;3127.62468503781;3177.618685757701;3186.9203269918207;3220.162757682996;3406.744494162948;29068;29373.853130734424;30778;30847.84576077105;30924.381512369626;2721.727827217282;2729.508688436081;2848.1455563331124;2866.7276608722136;2873.698261682514;394994;396375;397801;398501;399256.9999999971;46471;47210.76394618005;66566.33433665601;66707;67887;46852.297215541796;47098.52901470941;47287.29069063967;47327;47380;15635.687286254439;15919.363225471083;15926.761098583298;15931.681366372608;15959.962602430805;12709.809352859715;12797.872021279854;12808.743825123633;12816.615501534969;12837.422315995616;15150;15157.924210378878;15181.392744290326;15201.771973420407;15330.080195188324;6640.767573134917;6778.423833974168;6780.694868730919;6794.184697836291;6815.591064536144;946.9715908522755;952.8713623660856;974.1962880623514;1005.2309982863115;1027.9640212592674;28918.710812892023;28972.27569310742;29479.11562653124;29713.108606741833;29799.255018624706;1109.4286442482128;1112.7385064509833;1129.9830152862326;1136.7158210447387;1189.8572171339322;14705.41178352854;14735.778963315559;14761;15076.623084422758;15206.619834504227;512856;513933;519542;520177;520878;57406.7129664349;57965;57985.420145798846;58003.83992320214;58068;1391.2765362011899;1396.3367400484892;1419.8985501457694;1428.3429622373824;1432.6776475293184;28084.578731318637;28099.43801124007;28653.997110101045;28861.85569072141;28923.276918077216;44283.89290267769;44813.10373792441;45254.54745452635;45339.546604533534;45346.319805202285;253054;268785;272718;274251;274521;28676.713232867405;32628.510572340958;33045.83477082599;33638.663613363555;33924.83037584895;39805.60194398019;40151.59848401479;40414.79792601018;40503.59496405116;41455;34068.829655851565;34425.31149377049;34525.482117768755;35206.82396588001;35387.761428349884;33372.49941250835;33568.49647255342;33941.321173576885;34359;34412.31175376428;34149.82925085359;34270.828645856614;34408.795692150656;34818.30363392769;35436.46845297374;29449.705502944696;30009.549856752605;31080;31643.20891977719;31702.524462133548;23338.592239049856;23798.405039874142;24061.398465038514;24262.63606045946;24303.14938977127 07:17:07 INFO - PROCESS | 2005 | |2;jquery.html;320.0143557841847;349.4513613626606;350.6581083443643;353.36218126282057;357.82466591370206;15923.283452244648;16399.83600163998;19399.70900436493;19716.21135154594;20729.378118656463;15588.454404095859;19614.41156765296;20326.983650817474;20360.79639203611;20395.082221300076;5787.565932555054;5980.521558275327;6019.337872833985;7428.220036896102;7795.961020194891;4675.602573781232;7441.181470038291;7684.116326622454;7749.30256276935;7758.418118641096;7731.652075656581;7743.148253692089;7751.573663448508;7755.534667919943;7755.728549500768;7519.398448124164;7593.734219302325;7734;7775.300222979959;7784.883226751604;7141.178764442052;7269.454790890652;7377;7402.481826272163;7493.512921660074;27330.5900411494;27439.45121097567;28229.29426764327;28415.43169136606;28691.139265822057;2405.879706014692;2415.806735461159;2482.15606693725;2543.237028891344;2992.7156920092557;12159.93920030403;14375.640608984859;15420.922895385564;15865.206739663086;16243.350265989346;1821.581036361631;1826.6255417639352;1833.0193346559527;1843.0672279299336;1913.3494611831904;109636.4518177412;113812.43093784561;118553;118992;120414.3979280098;15759;18926.905365473085;19007.90496047511;19187.136578853984;19382.8061719381;24803.87598061998;25685.101021464157;28662.570061449096;28698.569521457193;28711.13866584006;9631.422114673142;9838.557264923096;10337.379757214441;10528.473576321307;10814.026737593496;9152.039035901134;9153.496557689392;9160.6793762218;9246.630134794668;9260.166585007248;8566.27186689126;8627.6980305689;8677;8736.8689469658;8737.38838281327;3288.6127288892003;3334.449815780418;3355.597328320617;3386.102682789063;3408.897733068012;396.8591150141716;397.7196076765873;411.3172134257119;709.9280087068564;1022.7136401807505;11638.359890205951;11926.940365298118;12043.096767742454;12053.216540924986;12111;431.38096831047545;449.27217906990234;455.8267858213924;458.04954718958294;460.68673302154184;4853.296272040534;6040.124181993587;6152.692365381713;6158.322584515699;10902.945485272523;626651;634946;648011;649305;650208;90420.88897109882;126322.36838815747;126840;127501;128383;1011.3325205364424;1023.6110278094426;1033.1579762493543;1035.5909415780875;1057.1912486947645;18544;18742.625147497245;18792.53018674544;18816.15327310247;18951.810481895005;40635.796821015705;40797;52813.20780188377;53036;54379;68667.28331791745;68785;73430.63284683542;73431;73450.53098938098;6479.514036447191;8144.8778268327205;8170.346372290083;8237.382196335178;8384.58077096155;12571.1200215984;13217.669558261121;13430.664233393853;13641.658958526115;13719.931400342934;10815;11606.12954028468;11621.418929053345;11849.644510664693;11930.582429614922;9942;11460.713482163013;11492.080633549129;11499.8275025873;11803.996660283972;9753.853692194481;11837.053035756946;11908.225965312573;11911.106666999836;12038.939805301268;7902.209779022051;7993.520388776459;8197;8221.506709597443;8364.163583641588;8039.718609848627;11657.591984280509;11725.472353743931;11926.284422934652;12007.279563226235 07:17:07 INFO - PROCESS | 2005 | |3;mootools.html;1333.2667033131775;1524.6112241378448;1548.396125511051;1796.1109250920797;1962.0091853613924;7914.287714105736;8497.830043399128;8664.0902705216;8671.08953559875;8674.86987695185;8410.495370277788;8624.439411438252;8628.741137765861;8630.95684521578;8637.006744224416;2161.167950339115;2400.9039638414442;2416.226807421626;2449.497852940152;2470.0490311230215;2464.938376540592;2466.1984854922134;2468.2841975827077;2470.7158676752133;2476.1457297232514;2388.319328991238;2444.2178502879087;2458.840175388594;2461.027893981876;2461.1386014894733;2028;2417.673614062114;2467.901283948649;2475.084218839041;2476.9009239630395;2437.4515733959893;2465.174166654173;2478.479519300949;2480.1071614218868;2491.763282488179;8769.605367758466;8842.381033327669;8844.55777211137;8852.955735221347;8862.822743545157;4752.904941901177;5360.490753378423;5512.972435137839;5551.666899986014;5553.527950124244;3548.254866478043;3663.322285377187;3687.575928768172;3717.8326975286177;3736.196717705679;1037.870266216723;1046.2519298701388;1063.2344711807486;1064.0476773287864;1074.4788777442934;10002.49987500622;12044.277343359427;12048.759024819543;12074.034077273796;12075.879241207564;4810.6632535722865;4839;4909.214525675875;4918.311436398907;4930.457649658535;10334.896651033394;10336.741581460523;10336.844947325797;10342.896571034344;10358.689239322832;5485.396606373296;5488.835334939959;5494.1758736189095;5494.890102197934;5495.670259784426;4434.357018232338;4594.908101837945;4840.322354870321;4888.462269150391;4944.9258261126115;3876.3604005339366;3945.151792364655;3965.5439624443557;3999.7400168988925;4001.799910004488;1285.1967520299813;1291.341415877909;1291.5027714329863;1303.2506308872437;1307.1307580458888;1312.5143696832233;1333.0402110480438;1348.5886804524519;1365.808786769853;1367.131871261756;8280.875786863202;8283.875741863756;8337.249647531751;8343.582820859054;8343.957005374328;504.43207485498397;515.3480846728891;521.3717470448177;523.228238348433;528.643165863041;6294.527910406738;6301;6306.747730090837;6317.273513545909;6351.841203969938;10492.842607360895;10878.836817447745;11010.284331518425;11012.284201527036;11034.337939723642;10328.328658637314;10694.197935154894;10794.622188223375;10873.021428071354;10890.509927053301;8377.120402357787;8403.285720713686;8460.78848028792;8470.788230294169;8476.745697629081;7794.103678077094;7944.126146124037;8012.479188852706;8165.183481651788;8167.856500090111;9264.073592640681;9533.475658838553;9617.2306215504;9685;9785.217182625514;9679.467629280176;9891;10014.849777253201;10054.899451005396;10056.89943100589;6708.19501659804;7207.783766487014;7484.962575187089;7493.475456717977;7608.353289970414;8300.04549476818;8311.127331630334;8354.248117669438;8363;8373.37199710012;7194.280571942764;7343.485955983244;7418.629068546443;7570.848583028419;7609.505382150142;6716.462682985251;6816.079829222991;7250.274972502708;7254.782356529313;7351.889721654286;7618.314351708151;7714.729984450517;7719.884201736866;7721.996140501698;7722.652480638497;6911.93088069133;6923.307669233036;7012.6844292008;7013.228544860163;7023.438124950094;7015.403690686348;7161.641917904188;7207.819804504929;7216.603086830275;7217.963910180415 07:17:07 INFO - PROCESS | 2005 | |4;prototype.html;318.5476623195063;318.7577441144729;326.21912039462626;328.1746407784422;328.7205875006245;6731;6746.662666866656;6762.797116086519;6799.4560435165195;6822.249552549216;6677.165354330708;6742.157230346207;6746.662666866661;6751.223609284933;6763.59418434893;4710.74090924999;4785.808567657289;4812.590929770956;4921.015796840628;4969.204927211656;3903.789825154197;4034.0721634024194;4893.657443978923;4934.925976110343;4946.060248552782;4884.6824956377895;4893.632977526682;4920.606351491872;4922.335484709554;4928.901421971558;4200.642945349649;4697.647676424264;4767.308740232682;4885.438174609894;4912;4209.789510524462;4216.873493795191;4222.535521092677;4227.598378154071;4236.957630423687;6527.4125328720165;6531.510136739764;6538;6540.247871494791;6550.770723024719;5093.745312734349;5526;5868.647881127104;5870.532366908273;5872.559558033165;6797.1843378794365;7152.070230870006;7152.99574178841;7160.391366733782;7169.856602867913;4724.5747882690375;4731.834385796481;4743;4751.501092385319;4779.354787103731;7423.40612750984;7524.736634217831;7541.811454713621;7544.660490277951;7587.772366829004;4833.879153021132;4838.612910967114;4846.75766211688;4850.151223535867;4862.027594481118;4071.2875246831686;4898.14282500561;4905.386826646669;4907.484714105039;4921.8523444296725;5579.553635709215;5815.767369305265;5815.82552523425;5830.650160990269;5837.270341207349;5868.530517558585;7156.60638664868;7197.640117994079;7203.099612548432;7242.13094428672;1689.4931520543787;1716.519374575121;1722.3196837249216;1724.034540657211;1727.9222434990204;1039.604950118965;1079.7084787107594;1098.4727330881221;1114.3369695031442;1145.0839328537138;6679.165104361955;6743.5953842769595;6748.7300507979135;6763.391294783493;6809.38715515606;7540;7543.1325397578885;7549.8112547185665;7567.31894129531;7627.122880868771;5782.190493330937;6697.162854643169;6806.659667016629;6820.113385259884;6839.179298484214;3788.242351529705;3937.1928754605237;3969.6824254059607;3970.4441378207075;3979.820908059144;7844.333231675371;7902.683892644345;7904.4071694623135;7905.130435652074;7907.209279072047;6327.746890124436;7686.846263074707;7714.421418393643;7733.41999350051;7750.457467977188;7843.803904902423;7845.7253996111;7848.254415830487;7856.135825059239;7857.2928436441;7166;7471.663775130023;7496.850062998818;7501.1373692023935;7509.962450187714;6590.50571207171;7342.70629174827;7344.449166312441;7351.8529629408185;7364.668589913574;7842.803929901798;7854.764357069297;7857.646405911633;7858.489198202327;7868.331191848757;3990.4014397840556;4311.504177019683;4668.673192876602;4876.292937523968;4877.975610121926;6284.805886881478;7091.60996145217;7227.205007449072;7422.406207503494;7445.813854653677;7185.389241914496;7213.891791623025;7215.783526494213;7276.781696549112;7281.7062625272865;7224.277572242734;7239.927600724136;7244.384227340735;7250;7263.019492368674;7066.611336376549;7077.079979602619;7087.574745515286;7093.467989900882;7094.893576596252;6916.204636466669;7134;7233.421326293989;7242.674079666533;7244.746433874789;6777.661116944231;6861.759838405832;6975.093237879043;6993.930060699327;7079.115110611174 07:17:07 INFO - PROCESS | 2005 | |5;yui.html;628.2743431336806;722.4076257468878;731.0386841303686;741.0884611927328;743.0266351080086;15192.544223673294;15273.618159546017;15305.617359566017;15306.081635101902;15313.46402875901;13594.728105437885;14045.36795844187;14054.156750594946;14069.296535173225;14072.859271407282;697.5814511293235;705.6648092156236;851.5146366571057;857.2499063319596;860.6385318166385;765.9348955338803;840.8312445700482;873.9082396348388;874.4534665833854;875.7110153649312;914.7347269291897;927.3415874728951;928.4382948316272;928.5821380378823;928.7306681062483;729.4055344893922;901.3870568013748;921.0099143420816;921.0329154387933;926.0369216015335;674.834665506949;680.6460640466979;682.2324884504932;682.5972676121063;683.641088428579;14835.554933352018;14863;14898.776518352124;14899.553013409615;14900.925495372561;10784.784304313947;12245.387730613435;12391.876081239163;12442.315672638002;12673.93663031688;9918.652847150388;10162.085412312854;10177.084062434342;10778.838317425245;10927;3557.48416479609;3640.9987253505233;3648.434492653643;3737;3764.9247015059545;84536.15463845344;84951;85158.72261916139;85178;85209;9242.86135707965;9270.814583708423;9472.715818525456;9560.187384072293;9564.521773911276;20629.96850157516;20663.690044649342;20678;20695.172193112106;20735;7360.631968401559;7367.77896663101;7405.407567394704;7432.145303290191;7582.165961744204;3993;4034.1326614777963;4057;4083.305838007546;4092.8362865485046;3454.032870796181;3490.1798077451776;3510.947335789965;3515.226650136966;3516.7362447816517;616.9753209871644;629.5718911140468;637.1080487317699;641.2561428742636;650.2392201124695;515.2271592611083;576.8644368573382;580.7154494297764;597.357840321656;600.0399361022329;7603.505772124794;7852.097008843942;8095;8144.14486478923;8384.8742268866;507.91619382801423;564.6583816790783;576.685706290073;594.8542607061211;601.6119602856133;3792;3805.7250820975282;3852.287326844487;3858.9035274118373;3875.2443273561385;85909;88317;88344;88350.55824720835;89980;78924;78989;79163;79240;80759;70674.64662676757;71310.64344678243;71723.6413817938;71777;72296.63851680708;7642.4650274480255;7790.220977902164;7852.568108753845;8029.8394032120195;8082.7171049013;45426.772866135456;47627.76186119047;47995.76002119967;48212.75893620509;48285.7928551789;61199;65414;65630.67184664046;65983;66334.66832665805;9862.457564833716;9875.308728388944;9916.603335866484;10119.291649584458;10254.436006019741;10749.516271767945;10860;10901.291416057931;11141.777164456827;11618.70953226176;10235.283530152818;10333.276670633284;10572.947135264274;10683.94658026736;11204.66386008421;9931.950340248253;10138.89861101409;10220;10311.329763565343;11070.446477676245;9985.700428987142;10024.548895299875;10043.949780251052;10049.045340692623;10444.373337599769;8569.528675922884;8675.652973880975;8850.955745221232;8972.641094356153;8989.336208962472;8148.674053037812;8748.369044843195;8934.4192627479;8987.505687187268;9038.412503187272 07:17:07 INFO - PROCESS | 2005 | __end_tp_report 07:17:07 INFO - PROCESS | 2005 | __start_cc_report 07:17:07 INFO - PROCESS | 2005 | _x_x_mozilla_cycle_collect,1626 07:17:07 INFO - PROCESS | 2005 | __end_cc_report 07:17:07 INFO - PROCESS | 2005 | __startTimestamp1457018227679__endTimestamp 07:17:07 INFO - PROCESS | 2005 | 07:17:07 INFO - PROCESS | 2005 | ------- Summary: start ------- 07:17:07 INFO - PROCESS | 2005 | Number of tests: 6 07:17:07 INFO - PROCESS | 2005 | 07:17:07 INFO - PROCESS | 2005 | [#0] dojo.html Cycles:165 Average:5711.25 Median:5908.65 stddev:642.52 (10.9%) stddev-sans-first:617.99 07:17:07 INFO - PROCESS | 2005 | Values: 3383.4 3465.4 3481.2 3505.1 3542.6 5621.2 5640.5 5655.8 5658.0 5660.8 5655.1 5662.8 5674.1 5803.6 5805.1 5046.5 5096.6 5120.3 5124.9 5225.9 5191.6 5216.1 5246.9 5254.9 5311.5 5062.7 5084.7 5178.1 5180.4 5184.1 5116.8 5128.6 5151.6 5152.0 5163.0 5087.0 5118.2 5124.0 5131.6 5142.3 5528.2 5538.2 5629.5 5648.2 5665.8 6188.4 6194.1 6196.1 6209.1 6224.1 6209.8 6260.5 6285.9 6286.9 6289.2 5651.8 5714.6 5752.7 5801.3 5822.4 6256.7 6258.6 6267.0 6279.6 6287.1 6060.8 6061.9 6134.9 6148.0 6160.0 5196.2 6128.2 6174.6 6278.9 6314.0 6232.7 6233.6 6235.7 6249.0 6261.7 6217.2 6226.4 6240.1 6251.7 6251.8 4806.4 4850.2 4878.6 4887.3 4932.5 3841.3 4326.0 4404.2 4434.3 4501.6 5640.7 5660.9 5666.0 5678.5 5679.1 6162.4 6175.5 6176.8 6182.0 6185.9 5526.3 5618.6 5624.6 5653.4 5703.7 5334.7 5376.8 5388.5 5426.1 5439.7 6315.6 6325.3 6332.2 6333.0 6337.3 6148.5 6172.7 6236.1 6298.6 6307.7 5233.4 6279.1 6345.4 6347.9 6353.9 6167.9 6186.7 6186.9 6188.5 6188.5 6094.3 6180.3 6285.2 6289.7 6319.0 6107.9 6110.8 6116.6 6124.8 6125.8 6036.8 6076.5 6085.5 6091.4 6098.0 5823.4 5827.6 5904.1 5942.0 5959.9 5998.0 6021.5 6054.8 6067.3 6073.8 5897.0 5900.3 5908.6 5910.9 5918.3 07:17:07 INFO - PROCESS | 2005 | 07:17:07 INFO - PROCESS | 2005 | [#1] ext.html Cycles:180 Average:54372.59 Median:35297.29 stddev:108238.17 (306.6%) stddev-sans-first:108466.11 07:17:07 INFO - PROCESS | 2005 | Values: 456.5 566.3 566.3 627.3 639.6 35162.0 38737.0 38797.8 38825.8 39029.8 42196.6 42519.4 42886.4 42892.8 42938.8 9509.3 9712.0 9733.7 9741.0 9749.4 9514.3 9659.4 9662.3 9669.9 9673.0 9739.9 9817.8 9819.1 9829.9 9848.1 9733.0 9774.2 9809.5 9812.7 9844.5 9574.1 9751.3 9755.5 9763.0 9765.3 40496.0 40813.0 40828.0 40838.6 40872.6 3127.6 3177.6 3186.9 3220.2 3406.7 29068.0 29373.9 30778.0 30847.8 30924.4 2721.7 2729.5 2848.1 2866.7 2873.7 394994.0 396375.0 397801.0 398501.0 399257.0 46471.0 47210.8 66566.3 66707.0 67887.0 46852.3 47098.5 47287.3 47327.0 47380.0 15635.7 15919.4 15926.8 15931.7 15960.0 12709.8 12797.9 12808.7 12816.6 12837.4 15150.0 15157.9 15181.4 15201.8 15330.1 6640.8 6778.4 6780.7 6794.2 6815.6 947.0 952.9 974.2 1005.2 1028.0 28918.7 28972.3 29479.1 29713.1 29799.3 1109.4 1112.7 1130.0 1136.7 1189.9 14705.4 14735.8 14761.0 15076.6 15206.6 512856.0 513933.0 519542.0 520177.0 520878.0 57406.7 57965.0 57985.4 58003.8 58068.0 1391.3 1396.3 1419.9 1428.3 1432.7 28084.6 28099.4 28654.0 28861.9 28923.3 44283.9 44813.1 45254.5 45339.5 45346.3 253054.0 268785.0 272718.0 274251.0 274521.0 28676.7 32628.5 33045.8 33638.7 33924.8 39805.6 40151.6 40414.8 40503.6 41455.0 34068.8 34425.3 34525.5 35206.8 35387.8 33372.5 33568.5 33941.3 34359.0 34412.3 34149.8 34270.8 34408.8 34818.3 35436.5 29449.7 30009.5 31080.0 31643.2 31702.5 23338.6 23798.4 24061.4 24262.6 24303.1 07:17:07 INFO - PROCESS | 2005 | 07:17:07 INFO - PROCESS | 2005 | [#2] jquery.html Cycles:180 Average:36420.31 Median:1656.37 stddev:106315.58 (6418.6%) stddev-sans-first:106579.27 07:17:07 INFO - PROCESS | 2005 | Values: 320.0 349.5 350.7 353.4 357.8 15923.3 16399.8 19399.7 19716.2 20729.4 15588.5 19614.4 20327.0 20360.8 20395.1 5787.6 5980.5 6019.3 7428.2 7796.0 4675.6 7441.2 7684.1 7749.3 7758.4 7731.7 7743.1 7751.6 7755.5 7755.7 7519.4 7593.7 7734.0 7775.3 7784.9 7141.2 7269.5 7377.0 7402.5 7493.5 27330.6 27439.5 28229.3 28415.4 28691.1 2405.9 2415.8 2482.2 2543.2 2992.7 12159.9 14375.6 15420.9 15865.2 16243.4 1821.6 1826.6 1833.0 1843.1 1913.3 109636.5 113812.4 118553.0 118992.0 120414.4 15759.0 18926.9 19007.9 19187.1 19382.8 24803.9 25685.1 28662.6 28698.6 28711.1 9631.4 9838.6 10337.4 10528.5 10814.0 9152.0 9153.5 9160.7 9246.6 9260.2 8566.3 8627.7 8677.0 8736.9 8737.4 3288.6 3334.4 3355.6 3386.1 3408.9 396.9 397.7 411.3 709.9 1022.7 11638.4 11926.9 12043.1 12053.2 12111.0 431.4 449.3 455.8 458.0 460.7 4853.3 6040.1 6152.7 6158.3 10902.9 626651.0 634946.0 648011.0 649305.0 650208.0 90420.9 126322.4 126840.0 127501.0 128383.0 1011.3 1023.6 1033.2 1035.6 1057.2 18544.0 18742.6 18792.5 18816.2 18951.8 40635.8 40797.0 52813.2 53036.0 54379.0 68667.3 68785.0 73430.6 73431.0 73450.5 6479.5 8144.9 8170.3 8237.4 8384.6 12571.1 13217.7 13430.7 13641.7 13719.9 10815.0 11606.1 11621.4 11849.6 11930.6 9942.0 11460.7 11492.1 11499.8 11804.0 9753.9 11837.1 11908.2 11911.1 12038.9 7902.2 7993.5 8197.0 8221.5 8364.2 8039.7 11657.6 11725.5 11926.3 12007.3 07:17:07 INFO - PROCESS | 2005 | 07:17:07 INFO - PROCESS | 2005 | [#3] mootools.html Cycles:180 Average:6060.04 Median:518.36 stddev:3226.45 (622.4%) stddev-sans-first:3215.94 07:17:07 INFO - PROCESS | 2005 | Values: 1333.3 1524.6 1548.4 1796.1 1962.0 7914.3 8497.8 8664.1 8671.1 8674.9 8410.5 8624.4 8628.7 8631.0 8637.0 2161.2 2400.9 2416.2 2449.5 2470.0 2464.9 2466.2 2468.3 2470.7 2476.1 2388.3 2444.2 2458.8 2461.0 2461.1 2028.0 2417.7 2467.9 2475.1 2476.9 2437.5 2465.2 2478.5 2480.1 2491.8 8769.6 8842.4 8844.6 8853.0 8862.8 4752.9 5360.5 5513.0 5551.7 5553.5 3548.3 3663.3 3687.6 3717.8 3736.2 1037.9 1046.3 1063.2 1064.0 1074.5 10002.5 12044.3 12048.8 12074.0 12075.9 4810.7 4839.0 4909.2 4918.3 4930.5 10334.9 10336.7 10336.8 10342.9 10358.7 5485.4 5488.8 5494.2 5494.9 5495.7 4434.4 4594.9 4840.3 4888.5 4944.9 3876.4 3945.2 3965.5 3999.7 4001.8 1285.2 1291.3 1291.5 1303.3 1307.1 1312.5 1333.0 1348.6 1365.8 1367.1 8280.9 8283.9 8337.2 8343.6 8344.0 504.4 515.3 521.4 523.2 528.6 6294.5 6301.0 6306.7 6317.3 6351.8 10492.8 10878.8 11010.3 11012.3 11034.3 10328.3 10694.2 10794.6 10873.0 10890.5 8377.1 8403.3 8460.8 8470.8 8476.7 7794.1 7944.1 8012.5 8165.2 8167.9 9264.1 9533.5 9617.2 9685.0 9785.2 9679.5 9891.0 10014.8 10054.9 10056.9 6708.2 7207.8 7485.0 7493.5 7608.4 8300.0 8311.1 8354.2 8363.0 8373.4 7194.3 7343.5 7418.6 7570.8 7609.5 6716.5 6816.1 7250.3 7254.8 7351.9 7618.3 7714.7 7719.9 7722.0 7722.7 6911.9 6923.3 7012.7 7013.2 7023.4 7015.4 7161.6 7207.8 7216.6 7218.0 07:17:07 INFO - PROCESS | 2005 | 07:17:07 INFO - PROCESS | 2005 | [#4] prototype.html Cycles:180 Average:5874.61 Median:6745.13 stddev:1899.97 (28.2%) stddev-sans-first:1858.97 07:17:07 INFO - PROCESS | 2005 | Values: 318.5 318.8 326.2 328.2 328.7 6731.0 6746.7 6762.8 6799.5 6822.2 6677.2 6742.2 6746.7 6751.2 6763.6 4710.7 4785.8 4812.6 4921.0 4969.2 3903.8 4034.1 4893.7 4934.9 4946.1 4884.7 4893.6 4920.6 4922.3 4928.9 4200.6 4697.6 4767.3 4885.4 4912.0 4209.8 4216.9 4222.5 4227.6 4237.0 6527.4 6531.5 6538.0 6540.2 6550.8 5093.7 5526.0 5868.6 5870.5 5872.6 6797.2 7152.1 7153.0 7160.4 7169.9 4724.6 4731.8 4743.0 4751.5 4779.4 7423.4 7524.7 7541.8 7544.7 7587.8 4833.9 4838.6 4846.8 4850.2 4862.0 4071.3 4898.1 4905.4 4907.5 4921.9 5579.6 5815.8 5815.8 5830.7 5837.3 5868.5 7156.6 7197.6 7203.1 7242.1 1689.5 1716.5 1722.3 1724.0 1727.9 1039.6 1079.7 1098.5 1114.3 1145.1 6679.2 6743.6 6748.7 6763.4 6809.4 7540.0 7543.1 7549.8 7567.3 7627.1 5782.2 6697.2 6806.7 6820.1 6839.2 3788.2 3937.2 3969.7 3970.4 3979.8 7844.3 7902.7 7904.4 7905.1 7907.2 6327.7 7686.8 7714.4 7733.4 7750.5 7843.8 7845.7 7848.3 7856.1 7857.3 7166.0 7471.7 7496.9 7501.1 7510.0 6590.5 7342.7 7344.4 7351.9 7364.7 7842.8 7854.8 7857.6 7858.5 7868.3 3990.4 4311.5 4668.7 4876.3 4878.0 6284.8 7091.6 7227.2 7422.4 7445.8 7185.4 7213.9 7215.8 7276.8 7281.7 7224.3 7239.9 7244.4 7250.0 7263.0 7066.6 7077.1 7087.6 7093.5 7094.9 6916.2 7134.0 7233.4 7242.7 7244.7 6777.7 6861.8 6975.1 6993.9 7079.1 07:17:07 INFO - PROCESS | 2005 | 07:17:07 INFO - PROCESS | 2005 | [#5] yui.html Cycles:180 Average:18000.02 Median:33032.12 stddev:25679.03 (77.7%) stddev-sans-first:25717.94 07:17:07 INFO - PROCESS | 2005 | Values: 628.3 722.4 731.0 741.1 743.0 15192.5 15273.6 15305.6 15306.1 15313.5 13594.7 14045.4 14054.2 14069.3 14072.9 697.6 705.7 851.5 857.2 860.6 765.9 840.8 873.9 874.5 875.7 914.7 927.3 928.4 928.6 928.7 729.4 901.4 921.0 921.0 926.0 674.8 680.6 682.2 682.6 683.6 14835.6 14863.0 14898.8 14899.6 14900.9 10784.8 12245.4 12391.9 12442.3 12673.9 9918.7 10162.1 10177.1 10778.8 10927.0 3557.5 3641.0 3648.4 3737.0 3764.9 84536.2 84951.0 85158.7 85178.0 85209.0 9242.9 9270.8 9472.7 9560.2 9564.5 20630.0 20663.7 20678.0 20695.2 20735.0 7360.6 7367.8 7405.4 7432.1 7582.2 3993.0 4034.1 4057.0 4083.3 4092.8 3454.0 3490.2 3510.9 3515.2 3516.7 617.0 629.6 637.1 641.3 650.2 515.2 576.9 580.7 597.4 600.0 7603.5 7852.1 8095.0 8144.1 8384.9 507.9 564.7 576.7 594.9 601.6 3792.0 3805.7 3852.3 3858.9 3875.2 85909.0 88317.0 88344.0 88350.6 89980.0 78924.0 78989.0 79163.0 79240.0 80759.0 70674.6 71310.6 71723.6 71777.0 72296.6 7642.5 7790.2 7852.6 8029.8 8082.7 45426.8 47627.8 47995.8 48212.8 48285.8 61199.0 65414.0 65630.7 65983.0 66334.7 9862.5 9875.3 9916.6 10119.3 10254.4 10749.5 10860.0 10901.3 11141.8 11618.7 10235.3 10333.3 10572.9 10683.9 11204.7 9932.0 10138.9 10220.0 10311.3 11070.4 9985.7 10024.5 10043.9 10049.0 10444.4 8569.5 8675.7 8851.0 8972.6 8989.3 8148.7 8748.4 8934.4 8987.5 9038.4 07:17:07 INFO - PROCESS | 2005 | -------- Summary: end -------- 07:17:07 INFO - PROCESS | 2005 | 07:17:08 INFO - TEST-INFO | 2005: exit 0 07:17:08 INFO - TEST-OK | dromaeo_css | took 1113844ms 07:17:08 INFO - TEST-START | kraken 07:17:08 INFO - operating with platform_type : mac_ 07:17:08 INFO - Initialising browser for kraken test... 07:17:08 INFO - TEST-INFO | started process 2008 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/2lld364j46g___08n54mb94h00000w/T/tmpzY7SrM/profile http://localhost:51350/getInfo.html) 07:17:10 INFO - PROCESS | 2008 | __metrics Screen width/height:1600/1200 07:17:10 INFO - PROCESS | 2008 | colorDepth:24 07:17:10 INFO - PROCESS | 2008 | Browser inner width/height: 1024/689 07:17:10 INFO - PROCESS | 2008 | __metrics 07:17:10 INFO - PROCESS | 2008 | 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" 07:17:10 INFO - PROCESS | 2008 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:17:11 INFO - TEST-INFO | 2008: exit 0 07:17:11 INFO - Browser initialized. 07:17:11 INFO - Running cycle 1/1 for kraken test... 07:17:11 INFO - TEST-INFO | started process 2010 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/2lld364j46g___08n54mb94h00000w/T/tmpzY7SrM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:17:23 INFO - PROCESS | 2010 | RSS: Main: 243298304 07:17:23 INFO - PROCESS | 2010 | 07:17:25 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:51350/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51350/tests/kraken/driver.html?testName=audio-beat-detection) 07:17:26 INFO - PROCESS | 2010 | RSS: Main: 289955840 07:17:26 INFO - PROCESS | 2010 | 07:17:29 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:51350/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51350/tests/kraken/driver.html?testName=audio-dft) 07:17:29 INFO - PROCESS | 2010 | RSS: Main: 299790336 07:17:29 INFO - PROCESS | 2010 | 07:17:32 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:51350/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51350/tests/kraken/driver.html?testName=audio-fft) 07:17:33 INFO - PROCESS | 2010 | RSS: Main: 285126656 07:17:33 INFO - PROCESS | 2010 | 07:17:35 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:51350/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51350/tests/kraken/driver.html?testName=audio-oscillator) 07:17:35 INFO - PROCESS | 2010 | RSS: Main: 286789632 07:17:35 INFO - PROCESS | 2010 | 07:17:38 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:51350/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51350/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:17:38 INFO - PROCESS | 2010 | RSS: Main: 287444992 07:17:38 INFO - PROCESS | 2010 | 07:17:41 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:51350/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51350/tests/kraken/driver.html?testName=imaging-darkroom) 07:17:41 INFO - PROCESS | 2010 | RSS: Main: 288022528 07:17:41 INFO - PROCESS | 2010 | 07:17:44 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:51350/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51350/tests/kraken/driver.html?testName=imaging-desaturate) 07:17:45 INFO - PROCESS | 2010 | RSS: Main: 287498240 07:17:45 INFO - PROCESS | 2010 | 07:17:48 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:51350/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51350/tests/kraken/driver.html?testName=json-parse-financial) 07:17:48 INFO - PROCESS | 2010 | RSS: Main: 289955840 07:17:48 INFO - PROCESS | 2010 | 07:17:50 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:51350/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51350/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:17:50 INFO - PROCESS | 2010 | RSS: Main: 322945024 07:17:50 INFO - PROCESS | 2010 | 07:17:52 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:51350/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51350/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:17:53 INFO - PROCESS | 2010 | RSS: Main: 322875392 07:17:53 INFO - PROCESS | 2010 | 07:17:55 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:51350/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51350/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:17:56 INFO - PROCESS | 2010 | RSS: Main: 332558336 07:17:56 INFO - PROCESS | 2010 | 07:17:58 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:51350/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51350/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:17:59 INFO - PROCESS | 2010 | RSS: Main: 333819904 07:17:59 INFO - PROCESS | 2010 | 07:18:01 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:51350/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51350/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:18:02 INFO - PROCESS | 2010 | RSS: Main: 333058048 07:18:02 INFO - PROCESS | 2010 | 07:18:03 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:51350/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51350/tests/kraken/driver.html?testName=ai-astar) 07:18:04 INFO - PROCESS | 2010 | RSS: Main: 393678848 07:18:04 INFO - PROCESS | 2010 | 07:18:04 INFO - PROCESS | 2010 | __start_tp_report 07:18:04 INFO - PROCESS | 2010 | _x_x_mozilla_page_load 07:18:04 INFO - PROCESS | 2010 | _x_x_mozilla_page_load_details 07:18:04 INFO - PROCESS | 2010 | |i|pagename|runs| 07:18:04 INFO - PROCESS | 2010 | |0;ai-astar;109;108;108;108;110;109;114;109;110;109 07:18:04 INFO - PROCESS | 2010 | |1;audio-beat-detection;157;121;150;183;153;136;142;117;167;128 07:18:04 INFO - PROCESS | 2010 | |2;audio-dft;183;188;186;183;184;182;185;181;184;183 07:18:04 INFO - PROCESS | 2010 | |3;audio-fft;84;75;86;79;57;56;58;79;77;56 07:18:04 INFO - PROCESS | 2010 | |4;audio-oscillator;96;96;130;79;77;86;109;77;81;106 07:18:04 INFO - PROCESS | 2010 | |5;imaging-gaussian-blur;88;85;88;85;88;86;91;85;87;84 07:18:04 INFO - PROCESS | 2010 | |6;imaging-darkroom;103;140;93;93;92;93;93;93;91;92 07:18:04 INFO - PROCESS | 2010 | |7;imaging-desaturate;87;85;101;85;84;85;84;84;85;84 07:18:04 INFO - PROCESS | 2010 | |8;json-parse-financial;55;55;54;54;54;54;54;64;55;53 07:18:04 INFO - PROCESS | 2010 | |9;json-stringify-tinderbox;64;72;69;78;70;70;67;69;69;68 07:18:04 INFO - PROCESS | 2010 | |10;stanford-crypto-aes;81;83;81;82;83;81;83;96;105;107 07:18:04 INFO - PROCESS | 2010 | |11;stanford-crypto-ccm;125;122;119;126;125;127;119;119;130;121 07:18:04 INFO - PROCESS | 2010 | |12;stanford-crypto-pbkdf2;142;139;139;131;140;127;140;140;138;137 07:18:04 INFO - PROCESS | 2010 | |13;stanford-crypto-sha256-iterative;66;67;65;68;68;65;66;66;66;67 07:18:04 INFO - PROCESS | 2010 | __end_tp_report 07:18:04 INFO - PROCESS | 2010 | __start_cc_report 07:18:04 INFO - PROCESS | 2010 | _x_x_mozilla_cycle_collect,1260 07:18:04 INFO - PROCESS | 2010 | __end_cc_report 07:18:04 INFO - PROCESS | 2010 | __startTimestamp1457018284221__endTimestamp 07:18:04 INFO - PROCESS | 2010 | 07:18:04 INFO - PROCESS | 2010 | ------- Summary: start ------- 07:18:04 INFO - PROCESS | 2010 | Number of tests: 14 07:18:04 INFO - PROCESS | 2010 | 07:18:04 INFO - PROCESS | 2010 | [#0] ai-astar Cycles:10 Average:109.40 Median:109.00 stddev:1.78 (1.6%) stddev-sans-first:1.88 07:18:04 INFO - PROCESS | 2010 | Values: 109.0 108.0 108.0 108.0 110.0 109.0 114.0 109.0 110.0 109.0 07:18:04 INFO - PROCESS | 2010 | 07:18:04 INFO - PROCESS | 2010 | [#1] audio-beat-detection Cycles:10 Average:145.40 Median:151.50 stddev:20.81 (13.7%) stddev-sans-first:21.65 07:18:04 INFO - PROCESS | 2010 | Values: 157.0 121.0 150.0 183.0 153.0 136.0 142.0 117.0 167.0 128.0 07:18:04 INFO - PROCESS | 2010 | 07:18:04 INFO - PROCESS | 2010 | [#2] audio-dft Cycles:10 Average:183.90 Median:184.00 stddev:2.02 (1.1%) stddev-sans-first:2.12 07:18:04 INFO - PROCESS | 2010 | Values: 183.0 188.0 186.0 183.0 184.0 182.0 185.0 181.0 184.0 183.0 07:18:04 INFO - PROCESS | 2010 | 07:18:04 INFO - PROCESS | 2010 | [#3] audio-fft Cycles:10 Average:70.70 Median:78.00 stddev:12.42 (15.9%) stddev-sans-first:12.20 07:18:04 INFO - PROCESS | 2010 | Values: 84.0 75.0 86.0 79.0 57.0 56.0 58.0 79.0 77.0 56.0 07:18:04 INFO - PROCESS | 2010 | 07:18:04 INFO - PROCESS | 2010 | [#4] audio-oscillator Cycles:10 Average:93.70 Median:80.00 stddev:17.35 (21.7%) stddev-sans-first:18.38 07:18:04 INFO - PROCESS | 2010 | Values: 96.0 96.0 130.0 79.0 77.0 86.0 109.0 77.0 81.0 106.0 07:18:04 INFO - PROCESS | 2010 | 07:18:04 INFO - PROCESS | 2010 | [#5] imaging-gaussian-blur Cycles:10 Average:86.70 Median:87.50 stddev:2.11 (2.4%) stddev-sans-first:2.19 07:18:04 INFO - PROCESS | 2010 | Values: 88.0 85.0 88.0 85.0 88.0 86.0 91.0 85.0 87.0 84.0 07:18:04 INFO - PROCESS | 2010 | 07:18:04 INFO - PROCESS | 2010 | [#6] imaging-darkroom Cycles:10 Average:98.30 Median:93.00 stddev:15.03 (16.2%) stddev-sans-first:15.85 07:18:04 INFO - PROCESS | 2010 | Values: 103.0 140.0 93.0 93.0 92.0 93.0 93.0 93.0 91.0 92.0 07:18:04 INFO - PROCESS | 2010 | 07:18:04 INFO - PROCESS | 2010 | [#7] imaging-desaturate Cycles:10 Average:86.40 Median:85.00 stddev:5.21 (6.1%) stddev-sans-first:5.52 07:18:04 INFO - PROCESS | 2010 | Values: 87.0 85.0 101.0 85.0 84.0 85.0 84.0 84.0 85.0 84.0 07:18:04 INFO - PROCESS | 2010 | 07:18:04 INFO - PROCESS | 2010 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:54.50 stddev:3.16 (5.8%) stddev-sans-first:3.35 07:18:04 INFO - PROCESS | 2010 | Values: 55.0 55.0 54.0 54.0 54.0 54.0 54.0 64.0 55.0 53.0 07:18:04 INFO - PROCESS | 2010 | 07:18:04 INFO - PROCESS | 2010 | [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:69.50 stddev:3.63 (5.2%) stddev-sans-first:3.23 07:18:04 INFO - PROCESS | 2010 | Values: 64.0 72.0 69.0 78.0 70.0 70.0 67.0 69.0 69.0 68.0 07:18:04 INFO - PROCESS | 2010 | 07:18:04 INFO - PROCESS | 2010 | [#10] stanford-crypto-aes Cycles:10 Average:88.20 Median:82.50 stddev:10.39 (12.6%) stddev-sans-first:10.69 07:18:04 INFO - PROCESS | 2010 | Values: 81.0 83.0 81.0 82.0 83.0 81.0 83.0 96.0 105.0 107.0 07:18:04 INFO - PROCESS | 2010 | 07:18:04 INFO - PROCESS | 2010 | [#11] stanford-crypto-ccm Cycles:10 Average:123.30 Median:125.00 stddev:3.86 (3.1%) stddev-sans-first:4.04 07:18:04 INFO - PROCESS | 2010 | Values: 125.0 122.0 119.0 126.0 125.0 127.0 119.0 119.0 130.0 121.0 07:18:04 INFO - PROCESS | 2010 | 07:18:04 INFO - PROCESS | 2010 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.30 Median:139.50 stddev:4.67 (3.3%) stddev-sans-first:4.63 07:18:04 INFO - PROCESS | 2010 | Values: 142.0 139.0 139.0 131.0 140.0 127.0 140.0 140.0 138.0 137.0 07:18:04 INFO - PROCESS | 2010 | 07:18:04 INFO - PROCESS | 2010 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:66.50 stddev:1.07 (1.6%) stddev-sans-first:1.13 07:18:04 INFO - PROCESS | 2010 | Values: 66.0 67.0 65.0 68.0 68.0 65.0 66.0 66.0 66.0 67.0 07:18:04 INFO - PROCESS | 2010 | -------- Summary: end -------- 07:18:04 INFO - PROCESS | 2010 | 07:18:04 INFO - TEST-INFO | 2010: exit 0 07:18:04 INFO - TEST-OK | kraken | took 56710ms 07:18:04 INFO - SUITE-END | took 1170s 07:18:05 INFO - Completed test suite (00:19:30) 07:18:05 INFO - Working with test: dromaeo_css 07:18:05 INFO - Generating results file: dromaeo_css 07:18:05 INFO - Working with test: kraken 07:18:05 INFO - Generating results file: kraken 07:18:05 INFO - javascript benchmark 07:18:05 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:18:05 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 07:18:05 INFO - process_Request line: dromaeo_css 7521.80 graph.html#tests=[[72,64,59]] 07:18:05 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:18:05 INFO - process_Request line: kraken 1414.50 graph.html#tests=[[232,64,59]] 07:18:05 INFO - RETURN: dromaeo_css: 7521.80 07:18:05 INFO - RETURN: kraken: 1414.50 07:18:05 INFO - javascript benchmark 07:18:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3383.390989621868, 3465.4108801503744, 3481.199324155444, 3505.1412403961003, 3542.6457354264576, 5621.213030175769, 5640.492355687988, 5655.773769049239, 5657.9717101414535, 5660.8301750947485, 5655.123455864347, 5662.801801936923, 5674.148877668352, 5803.564732645058, 5805.071188609823, 5046.470120637336, 5096.617753668481, 5120.257562653413, 5124.948750512484, 5225.8954820903555, 5191.610629202825, 5216.061109000379, 5246.868828279305, 5254.8686282842855, 5311.521963023327, 5062.696238225718, 5084.720340381277, 5178.093833579109, 5180.4042535108565, 5184.14461613837, 5116.795328186868, 5128.589712823003, 5151.639385243035, 5151.974240128813, 5163.0, 5087.0, 5118.206677964921, 5123.974380128076, 5131.563817075553, 5142.280080788692, 5528.170774383834, 5538.169274608841, 5629.521490673298, 5648.152777083429, 5665.773369065232, 6188.350223226586, 6194.1018552310115, 6196.101565273055, 6209.130721698965, 6224.066390041485, 6209.751609935597, 6260.530460215502, 6285.8742825143245, 6286.9056964145575, 6289.182406287154, 5651.8304450866535, 5714.628549144292, 5752.683602401867, 5801.274840644919, 5822.417758224228, 6256.718447669866, 6258.593191442542, 6267.0286105653695, 6279.623222606659, 6287.056941458818, 6060.848478787977, 6061.909071363933, 6134.9079763803575, 6147.969260153671, 6159.96920015406, 5196.220566914993, 6128.167033931328, 6174.598651087665, 6278.874422511524, 6314.0, 6232.657203853741, 6233.563650544418, 6235.719392627252, 6249.0, 6261.7182226799905, 6217.160683307786, 6226.40849119333, 6240.126382306481, 6251.687415629201, 6251.812445626639, 4806.351142595705, 4850.151223535867, 4878.560929516289, 4887.340209071801, 4932.506749325111, 3841.2701586698436, 4325.956740432618, 4404.229259879508, 4434.268345722984, 4501.617362524156, 5640.661560306395, 5660.85847853807, 5665.971670141623, 5678.545716342683, 5679.148127780783, 6162.383761623802, 6175.475084617768, 6176.752929882844, 6181.96909015452, 6185.876282474325, 5526.336839579276, 5618.634788738719, 5624.634398764068, 5653.378128405872, 5703.74333155009, 5334.653247538898, 5376.838694839083, 5388.54197393226, 5426.050441172858, 5439.728013599304, 6315.5894866833505, 6325.304216536086, 6332.208473940757, 6333.018382150774, 6337.271213810286, 6148.50811935053, 6172.722227499863, 6236.064590311489, 6298.590591611531, 6307.716152773228, 5233.424323324507, 6279.058141278845, 6345.397187267202, 6347.904781428375, 6353.9046914295395, 6167.938320616737, 6186.721597528032, 6186.907196392148, 6188.535859810442, 6188.535859810622, 6094.289949776058, 6180.289266734383, 6285.151504546828, 6289.7484100635465, 6318.968405157945, 6107.9389206109145, 6110.801781737314, 6116.579253789288, 6124.777645458507, 6125.84596676928, 6036.7585296589405, 6076.453119219292, 6085.513158947185, 6091.42131497507, 6098.0, 5823.4467725566, 5827.562932779973, 5904.114382842608, 5942.049272116441, 5959.910601340896, 5997.950358687125, 6021.488173505301, 6054.848628784315, 6067.302260240129, 6073.817785466443, 5896.970515147397, 5900.262467191601, 5908.645481271137, 5910.881782364243, 5918.348981611933], "unit": "score", "name": "dojo.html", "value": 5670.723703227301}, {"lowerIsBetter": false, "replicates": [456.4522572912506, 566.2921348314607, 566.3486989961541, 627.2786295759876, 639.6322114784, 35162.0, 38737.0, 38797.80601096994, 38825.8058709706, 39029.80485097578, 42196.57803421965, 42519.36220956688, 42886.35670464946, 42892.785536072355, 42938.78530607343, 9509.33434659574, 9712.0, 9733.707988760349, 9741.0, 9749.366291191085, 9514.286428517855, 9659.372140810825, 9662.32363734539, 9669.854952175723, 9673.03269673034, 9739.853902191473, 9817.754556136118, 9819.067188617106, 9829.901700983006, 9848.064433878806, 9733.0, 9774.218062554979, 9809.509524523744, 9812.705618831447, 9844.45855477952, 9574.090461406155, 9751.317407781458, 9755.463449510275, 9762.951185244028, 9765.267604929588, 40496.0, 40813.0, 40827.97930051743, 40838.59161408377, 40872.59127408747, 3127.62468503781, 3177.618685757701, 3186.9203269918207, 3220.162757682996, 3406.744494162948, 29068.0, 29373.853130734424, 30778.0, 30847.84576077105, 30924.381512369626, 2721.727827217282, 2729.508688436081, 2848.1455563331124, 2866.7276608722136, 2873.698261682514, 394994.0, 396375.0, 397801.0, 398501.0, 399256.9999999971, 46471.0, 47210.76394618005, 66566.33433665601, 66707.0, 67887.0, 46852.297215541796, 47098.52901470941, 47287.29069063967, 47327.0, 47380.0, 15635.687286254439, 15919.363225471083, 15926.761098583298, 15931.681366372608, 15959.962602430805, 12709.809352859715, 12797.872021279854, 12808.743825123633, 12816.615501534969, 12837.422315995616, 15150.0, 15157.924210378878, 15181.392744290326, 15201.771973420407, 15330.080195188324, 6640.767573134917, 6778.423833974168, 6780.694868730919, 6794.184697836291, 6815.591064536144, 946.9715908522755, 952.8713623660856, 974.1962880623514, 1005.2309982863115, 1027.9640212592674, 28918.710812892023, 28972.27569310742, 29479.11562653124, 29713.108606741833, 29799.255018624706, 1109.4286442482128, 1112.7385064509833, 1129.9830152862326, 1136.7158210447387, 1189.8572171339322, 14705.41178352854, 14735.778963315559, 14761.0, 15076.623084422758, 15206.619834504227, 512856.0, 513933.0, 519542.0, 520177.0, 520878.0, 57406.7129664349, 57965.0, 57985.420145798846, 58003.83992320214, 58068.0, 1391.2765362011899, 1396.3367400484892, 1419.8985501457694, 1428.3429622373824, 1432.6776475293184, 28084.578731318637, 28099.43801124007, 28653.997110101045, 28861.85569072141, 28923.276918077216, 44283.89290267769, 44813.10373792441, 45254.54745452635, 45339.546604533534, 45346.319805202285, 253054.0, 268785.0, 272718.0, 274251.0, 274521.0, 28676.713232867405, 32628.510572340958, 33045.83477082599, 33638.663613363555, 33924.83037584895, 39805.60194398019, 40151.59848401479, 40414.79792601018, 40503.59496405116, 41455.0, 34068.829655851565, 34425.31149377049, 34525.482117768755, 35206.82396588001, 35387.761428349884, 33372.49941250835, 33568.49647255342, 33941.321173576885, 34359.0, 34412.31175376428, 34149.82925085359, 34270.828645856614, 34408.795692150656, 34818.30363392769, 35436.46845297374, 29449.705502944696, 30009.549856752605, 31080.0, 31643.20891977719, 31702.524462133548, 23338.592239049856, 23798.405039874142, 24061.398465038514, 24262.63606045946, 24303.14938977127], "unit": "score", "name": "ext.html", "value": 18679.902646964856}, {"lowerIsBetter": false, "replicates": [320.0143557841847, 349.4513613626606, 350.6581083443643, 353.36218126282057, 357.82466591370206, 15923.283452244648, 16399.83600163998, 19399.70900436493, 19716.21135154594, 20729.378118656463, 15588.454404095859, 19614.41156765296, 20326.983650817474, 20360.79639203611, 20395.082221300076, 5787.565932555054, 5980.521558275327, 6019.337872833985, 7428.220036896102, 7795.961020194891, 4675.602573781232, 7441.181470038291, 7684.116326622454, 7749.30256276935, 7758.418118641096, 7731.652075656581, 7743.148253692089, 7751.573663448508, 7755.534667919943, 7755.728549500768, 7519.398448124164, 7593.734219302325, 7734.0, 7775.300222979959, 7784.883226751604, 7141.178764442052, 7269.454790890652, 7377.0, 7402.481826272163, 7493.512921660074, 27330.5900411494, 27439.45121097567, 28229.29426764327, 28415.43169136606, 28691.139265822057, 2405.879706014692, 2415.806735461159, 2482.15606693725, 2543.237028891344, 2992.7156920092557, 12159.93920030403, 14375.640608984859, 15420.922895385564, 15865.206739663086, 16243.350265989346, 1821.581036361631, 1826.6255417639352, 1833.0193346559527, 1843.0672279299336, 1913.3494611831904, 109636.4518177412, 113812.43093784561, 118553.0, 118992.0, 120414.3979280098, 15759.0, 18926.905365473085, 19007.90496047511, 19187.136578853984, 19382.8061719381, 24803.87598061998, 25685.101021464157, 28662.570061449096, 28698.569521457193, 28711.13866584006, 9631.422114673142, 9838.557264923096, 10337.379757214441, 10528.473576321307, 10814.026737593496, 9152.039035901134, 9153.496557689392, 9160.6793762218, 9246.630134794668, 9260.166585007248, 8566.27186689126, 8627.6980305689, 8677.0, 8736.8689469658, 8737.38838281327, 3288.6127288892003, 3334.449815780418, 3355.597328320617, 3386.102682789063, 3408.897733068012, 396.8591150141716, 397.7196076765873, 411.3172134257119, 709.9280087068564, 1022.7136401807505, 11638.359890205951, 11926.940365298118, 12043.096767742454, 12053.216540924986, 12111.0, 431.38096831047545, 449.27217906990234, 455.8267858213924, 458.04954718958294, 460.68673302154184, 4853.296272040534, 6040.124181993587, 6152.692365381713, 6158.322584515699, 10902.945485272523, 626651.0, 634946.0, 648011.0, 649305.0, 650208.0, 90420.88897109882, 126322.36838815747, 126840.0, 127501.0, 128383.0, 1011.3325205364424, 1023.6110278094426, 1033.1579762493543, 1035.5909415780875, 1057.1912486947645, 18544.0, 18742.625147497245, 18792.53018674544, 18816.15327310247, 18951.810481895005, 40635.796821015705, 40797.0, 52813.20780188377, 53036.0, 54379.0, 68667.28331791745, 68785.0, 73430.63284683542, 73431.0, 73450.53098938098, 6479.514036447191, 8144.8778268327205, 8170.346372290083, 8237.382196335178, 8384.58077096155, 12571.1200215984, 13217.669558261121, 13430.664233393853, 13641.658958526115, 13719.931400342934, 10815.0, 11606.12954028468, 11621.418929053345, 11849.644510664693, 11930.582429614922, 9942.0, 11460.713482163013, 11492.080633549129, 11499.8275025873, 11803.996660283972, 9753.853692194481, 11837.053035756946, 11908.225965312573, 11911.106666999836, 12038.939805301268, 7902.209779022051, 7993.520388776459, 8197.0, 8221.506709597443, 8364.163583641588, 8039.718609848627, 11657.591984280509, 11725.472353743931, 11926.284422934652, 12007.279563226235], "unit": "score", "name": "jquery.html", "value": 10062.823499197573}, {"lowerIsBetter": false, "replicates": [1333.2667033131775, 1524.6112241378448, 1548.396125511051, 1796.1109250920797, 1962.0091853613924, 7914.287714105736, 8497.830043399128, 8664.0902705216, 8671.08953559875, 8674.86987695185, 8410.495370277788, 8624.439411438252, 8628.741137765861, 8630.95684521578, 8637.006744224416, 2161.167950339115, 2400.9039638414442, 2416.226807421626, 2449.497852940152, 2470.0490311230215, 2464.938376540592, 2466.1984854922134, 2468.2841975827077, 2470.7158676752133, 2476.1457297232514, 2388.319328991238, 2444.2178502879087, 2458.840175388594, 2461.027893981876, 2461.1386014894733, 2028.0, 2417.673614062114, 2467.901283948649, 2475.084218839041, 2476.9009239630395, 2437.4515733959893, 2465.174166654173, 2478.479519300949, 2480.1071614218868, 2491.763282488179, 8769.605367758466, 8842.381033327669, 8844.55777211137, 8852.955735221347, 8862.822743545157, 4752.904941901177, 5360.490753378423, 5512.972435137839, 5551.666899986014, 5553.527950124244, 3548.254866478043, 3663.322285377187, 3687.575928768172, 3717.8326975286177, 3736.196717705679, 1037.870266216723, 1046.2519298701388, 1063.2344711807486, 1064.0476773287864, 1074.4788777442934, 10002.49987500622, 12044.277343359427, 12048.759024819543, 12074.034077273796, 12075.879241207564, 4810.6632535722865, 4839.0, 4909.214525675875, 4918.311436398907, 4930.457649658535, 10334.896651033394, 10336.741581460523, 10336.844947325797, 10342.896571034344, 10358.689239322832, 5485.396606373296, 5488.835334939959, 5494.1758736189095, 5494.890102197934, 5495.670259784426, 4434.357018232338, 4594.908101837945, 4840.322354870321, 4888.462269150391, 4944.9258261126115, 3876.3604005339366, 3945.151792364655, 3965.5439624443557, 3999.7400168988925, 4001.799910004488, 1285.1967520299813, 1291.341415877909, 1291.5027714329863, 1303.2506308872437, 1307.1307580458888, 1312.5143696832233, 1333.0402110480438, 1348.5886804524519, 1365.808786769853, 1367.131871261756, 8280.875786863202, 8283.875741863756, 8337.249647531751, 8343.582820859054, 8343.957005374328, 504.43207485498397, 515.3480846728891, 521.3717470448177, 523.228238348433, 528.643165863041, 6294.527910406738, 6301.0, 6306.747730090837, 6317.273513545909, 6351.841203969938, 10492.842607360895, 10878.836817447745, 11010.284331518425, 11012.284201527036, 11034.337939723642, 10328.328658637314, 10694.197935154894, 10794.622188223375, 10873.021428071354, 10890.509927053301, 8377.120402357787, 8403.285720713686, 8460.78848028792, 8470.788230294169, 8476.745697629081, 7794.103678077094, 7944.126146124037, 8012.479188852706, 8165.183481651788, 8167.856500090111, 9264.073592640681, 9533.475658838553, 9617.2306215504, 9685.0, 9785.217182625514, 9679.467629280176, 9891.0, 10014.849777253201, 10054.899451005396, 10056.89943100589, 6708.19501659804, 7207.783766487014, 7484.962575187089, 7493.475456717977, 7608.353289970414, 8300.04549476818, 8311.127331630334, 8354.248117669438, 8363.0, 8373.37199710012, 7194.280571942764, 7343.485955983244, 7418.629068546443, 7570.848583028419, 7609.505382150142, 6716.462682985251, 6816.079829222991, 7250.274972502708, 7254.782356529313, 7351.889721654286, 7618.314351708151, 7714.729984450517, 7719.884201736866, 7721.996140501698, 7722.652480638497, 6911.93088069133, 6923.307669233036, 7012.6844292008, 7013.228544860163, 7023.438124950094, 7015.403690686348, 7161.641917904188, 7207.819804504929, 7216.603086830275, 7217.963910180415], "unit": "score", "name": "mootools.html", "value": 4851.101560019117}, {"lowerIsBetter": false, "replicates": [318.5476623195063, 318.7577441144729, 326.21912039462626, 328.1746407784422, 328.7205875006245, 6731.0, 6746.662666866656, 6762.797116086519, 6799.4560435165195, 6822.249552549216, 6677.165354330708, 6742.157230346207, 6746.662666866661, 6751.223609284933, 6763.59418434893, 4710.74090924999, 4785.808567657289, 4812.590929770956, 4921.015796840628, 4969.204927211656, 3903.789825154197, 4034.0721634024194, 4893.657443978923, 4934.925976110343, 4946.060248552782, 4884.6824956377895, 4893.632977526682, 4920.606351491872, 4922.335484709554, 4928.901421971558, 4200.642945349649, 4697.647676424264, 4767.308740232682, 4885.438174609894, 4912.0, 4209.789510524462, 4216.873493795191, 4222.535521092677, 4227.598378154071, 4236.957630423687, 6527.4125328720165, 6531.510136739764, 6538.0, 6540.247871494791, 6550.770723024719, 5093.745312734349, 5526.0, 5868.647881127104, 5870.532366908273, 5872.559558033165, 6797.1843378794365, 7152.070230870006, 7152.99574178841, 7160.391366733782, 7169.856602867913, 4724.5747882690375, 4731.834385796481, 4743.0, 4751.501092385319, 4779.354787103731, 7423.40612750984, 7524.736634217831, 7541.811454713621, 7544.660490277951, 7587.772366829004, 4833.879153021132, 4838.612910967114, 4846.75766211688, 4850.151223535867, 4862.027594481118, 4071.2875246831686, 4898.14282500561, 4905.386826646669, 4907.484714105039, 4921.8523444296725, 5579.553635709215, 5815.767369305265, 5815.82552523425, 5830.650160990269, 5837.270341207349, 5868.530517558585, 7156.60638664868, 7197.640117994079, 7203.099612548432, 7242.13094428672, 1689.4931520543787, 1716.519374575121, 1722.3196837249216, 1724.034540657211, 1727.9222434990204, 1039.604950118965, 1079.7084787107594, 1098.4727330881221, 1114.3369695031442, 1145.0839328537138, 6679.165104361955, 6743.5953842769595, 6748.7300507979135, 6763.391294783493, 6809.38715515606, 7540.0, 7543.1325397578885, 7549.8112547185665, 7567.31894129531, 7627.122880868771, 5782.190493330937, 6697.162854643169, 6806.659667016629, 6820.113385259884, 6839.179298484214, 3788.242351529705, 3937.1928754605237, 3969.6824254059607, 3970.4441378207075, 3979.820908059144, 7844.333231675371, 7902.683892644345, 7904.4071694623135, 7905.130435652074, 7907.209279072047, 6327.746890124436, 7686.846263074707, 7714.421418393643, 7733.41999350051, 7750.457467977188, 7843.803904902423, 7845.7253996111, 7848.254415830487, 7856.135825059239, 7857.2928436441, 7166.0, 7471.663775130023, 7496.850062998818, 7501.1373692023935, 7509.962450187714, 6590.50571207171, 7342.70629174827, 7344.449166312441, 7351.8529629408185, 7364.668589913574, 7842.803929901798, 7854.764357069297, 7857.646405911633, 7858.489198202327, 7868.331191848757, 3990.4014397840556, 4311.504177019683, 4668.673192876602, 4876.292937523968, 4877.975610121926, 6284.805886881478, 7091.60996145217, 7227.205007449072, 7422.406207503494, 7445.813854653677, 7185.389241914496, 7213.891791623025, 7215.783526494213, 7276.781696549112, 7281.7062625272865, 7224.277572242734, 7239.927600724136, 7244.384227340735, 7250.0, 7263.019492368674, 7066.611336376549, 7077.079979602619, 7087.574745515286, 7093.467989900882, 7094.893576596252, 6916.204636466669, 7134.0, 7233.421326293989, 7242.674079666533, 7244.746433874789, 6777.661116944231, 6861.759838405832, 6975.093237879043, 6993.930060699327, 7079.115110611174], "unit": "score", "name": "prototype.html", "value": 5238.729225411668}, {"lowerIsBetter": false, "replicates": [628.2743431336806, 722.4076257468878, 731.0386841303686, 741.0884611927328, 743.0266351080086, 15192.544223673294, 15273.618159546017, 15305.617359566017, 15306.081635101902, 15313.46402875901, 13594.728105437885, 14045.36795844187, 14054.156750594946, 14069.296535173225, 14072.859271407282, 697.5814511293235, 705.6648092156236, 851.5146366571057, 857.2499063319596, 860.6385318166385, 765.9348955338803, 840.8312445700482, 873.9082396348388, 874.4534665833854, 875.7110153649312, 914.7347269291897, 927.3415874728951, 928.4382948316272, 928.5821380378823, 928.7306681062483, 729.4055344893922, 901.3870568013748, 921.0099143420816, 921.0329154387933, 926.0369216015335, 674.834665506949, 680.6460640466979, 682.2324884504932, 682.5972676121063, 683.641088428579, 14835.554933352018, 14863.0, 14898.776518352124, 14899.553013409615, 14900.925495372561, 10784.784304313947, 12245.387730613435, 12391.876081239163, 12442.315672638002, 12673.93663031688, 9918.652847150388, 10162.085412312854, 10177.084062434342, 10778.838317425245, 10927.0, 3557.48416479609, 3640.9987253505233, 3648.434492653643, 3737.0, 3764.9247015059545, 84536.15463845344, 84951.0, 85158.72261916139, 85178.0, 85209.0, 9242.86135707965, 9270.814583708423, 9472.715818525456, 9560.187384072293, 9564.521773911276, 20629.96850157516, 20663.690044649342, 20678.0, 20695.172193112106, 20735.0, 7360.631968401559, 7367.77896663101, 7405.407567394704, 7432.145303290191, 7582.165961744204, 3993.0, 4034.1326614777963, 4057.0, 4083.305838007546, 4092.8362865485046, 3454.032870796181, 3490.1798077451776, 3510.947335789965, 3515.226650136966, 3516.7362447816517, 616.9753209871644, 629.5718911140468, 637.1080487317699, 641.2561428742636, 650.2392201124695, 515.2271592611083, 576.8644368573382, 580.7154494297764, 597.357840321656, 600.0399361022329, 7603.505772124794, 7852.097008843942, 8095.0, 8144.14486478923, 8384.8742268866, 507.91619382801423, 564.6583816790783, 576.685706290073, 594.8542607061211, 601.6119602856133, 3792.0, 3805.7250820975282, 3852.287326844487, 3858.9035274118373, 3875.2443273561385, 85909.0, 88317.0, 88344.0, 88350.55824720835, 89980.0, 78924.0, 78989.0, 79163.0, 79240.0, 80759.0, 70674.64662676757, 71310.64344678243, 71723.6413817938, 71777.0, 72296.63851680708, 7642.4650274480255, 7790.220977902164, 7852.568108753845, 8029.8394032120195, 8082.7171049013, 45426.772866135456, 47627.76186119047, 47995.76002119967, 48212.75893620509, 48285.7928551789, 61199.0, 65414.0, 65630.67184664046, 65983.0, 66334.66832665805, 9862.457564833716, 9875.308728388944, 9916.603335866484, 10119.291649584458, 10254.436006019741, 10749.516271767945, 10860.0, 10901.291416057931, 11141.777164456827, 11618.70953226176, 10235.283530152818, 10333.276670633284, 10572.947135264274, 10683.94658026736, 11204.66386008421, 9931.950340248253, 10138.89861101409, 10220.0, 10311.329763565343, 11070.446477676245, 9985.700428987142, 10024.548895299875, 10043.949780251052, 10049.045340692623, 10444.373337599769, 8569.528675922884, 8675.652973880975, 8850.955745221232, 8972.641094356153, 8989.336208962472, 8148.674053037812, 8748.369044843195, 8934.4192627479, 8987.505687187268, 9038.412503187272], "unit": "score", "name": "yui.html", "value": 6684.954994715661}], "name": "dromaeo_css", "value": 7521.802931254136}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 108.0, 108.0, 108.0, 110.0, 109.0, 114.0, 109.0, 110.0, 109.0], "unit": "score", "name": "ai-astar", "value": 109.4}, {"lowerIsBetter": true, "replicates": [157.0, 121.0, 150.0, 183.0, 153.0, 136.0, 142.0, 117.0, 167.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 145.4}, {"lowerIsBetter": true, "replicates": [183.0, 188.0, 186.0, 183.0, 184.0, 182.0, 185.0, 181.0, 184.0, 183.0], "unit": "score", "name": "audio-dft", "value": 183.9}, {"lowerIsBetter": true, "replicates": [84.0, 75.0, 86.0, 79.0, 57.0, 56.0, 58.0, 79.0, 77.0, 56.0], "unit": "score", "name": "audio-fft", "value": 70.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 130.0, 79.0, 77.0, 86.0, 109.0, 77.0, 81.0, 106.0], "unit": "score", "name": "audio-oscillator", "value": 93.7}, {"lowerIsBetter": true, "replicates": [88.0, 85.0, 88.0, 85.0, 88.0, 86.0, 91.0, 85.0, 87.0, 84.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 86.7}, {"lowerIsBetter": true, "replicates": [103.0, 140.0, 93.0, 93.0, 92.0, 93.0, 93.0, 93.0, 91.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 98.3}, {"lowerIsBetter": true, "replicates": [87.0, 85.0, 101.0, 85.0, 84.0, 85.0, 84.0, 84.0, 85.0, 84.0], "unit": "score", "name": "imaging-desaturate", "value": 86.4}, {"lowerIsBetter": true, "replicates": [55.0, 55.0, 54.0, 54.0, 54.0, 54.0, 54.0, 64.0, 55.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.2}, {"lowerIsBetter": true, "replicates": [64.0, 72.0, 69.0, 78.0, 70.0, 70.0, 67.0, 69.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.6}, {"lowerIsBetter": true, "replicates": [81.0, 83.0, 81.0, 82.0, 83.0, 81.0, 83.0, 96.0, 105.0, 107.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.2}, {"lowerIsBetter": true, "replicates": [125.0, 122.0, 119.0, 126.0, 125.0, 127.0, 119.0, 119.0, 130.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.3}, {"lowerIsBetter": true, "replicates": [142.0, 139.0, 139.0, 131.0, 140.0, 127.0, 140.0, 140.0, 138.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.3}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 65.0, 68.0, 68.0, 65.0, 66.0, 66.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.4}], "name": "kraken", "value": 1414.5}]} 07:18:05 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1414.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7521.80"}}} 07:18:05 INFO - Return code: 0 07:18:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:18:05 INFO - # TBPL SUCCESS # 07:18:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:18:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:18:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:18:05 INFO - 2016-03-03 07:18:05.957 screenresolution[2014:15239] starting screenresolution argv=screenresolution get 07:18:05 INFO - 2016-03-03 07:18:05.959 screenresolution[2014:15239] Display 0: 1600x1200x32@60 07:18:05 INFO - 2016-03-03 07:18:05.965 screenresolution[2015:15242] starting screenresolution argv=screenresolution list 07:18:05 INFO - Available Modes on Display 0 07:18:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:18:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:18:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:18:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:18:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:18:06 INFO - Intel Iris: 07:18:06 INFO - Chipset Model: Intel Iris 07:18:06 INFO - Type: GPU 07:18:06 INFO - Bus: Built-In 07:18:06 INFO - VRAM (Dynamic, Max): 1536 MB 07:18:06 INFO - Vendor: Intel (0x8086) 07:18:06 INFO - Device ID: 0x0a2e 07:18:06 INFO - Revision ID: 0x0009 07:18:06 INFO - Displays: 07:18:06 INFO - Display: 07:18:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:18:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:18:06 INFO - Display Serial Number: 1600x1200 60 07:18:06 INFO - Main Display: Yes 07:18:06 INFO - Mirror: Off 07:18:06 INFO - Online: Yes 07:18:06 INFO - Rotation: Supported 07:18:06 INFO - Return code: 0 07:18:06 INFO - Running post-action listener: _resource_record_post_action 07:18:06 INFO - Running post-run listener: _resource_record_post_run 07:18:07 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 754176; Write bytes: 703470592; Read time: 10; Write time: 1978 07:18:07 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 394211840; Write bytes: 388040192; Read time: 29820; Write time: 685 07:18:07 INFO - run-tests - Wall time: 1174s; CPU: 52.0%; Read bytes: 754176; Write bytes: 298651648; Read time: 10; Write time: 1240 07:18:07 INFO - Running post-run listener: _upload_blobber_files 07:18:07 INFO - Blob upload gear active. 07:18:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:18:07 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 07:18:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:18:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:18:07 INFO - (blobuploader) - INFO - Open directory for files ... 07:18:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:18:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:18:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:18:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:18:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:18:08 INFO - (blobuploader) - INFO - Done attempting. 07:18:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:18:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:18:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:18:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:18:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:18:09 INFO - (blobuploader) - INFO - Done attempting. 07:18:09 INFO - (blobuploader) - INFO - Iteration through files over. 07:18:09 INFO - Return code: 0 07:18:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:18:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:18:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/63e1415fbf243193f3e94e77a0e276a167a95fff28784133ea819fef06610408833fba26b4d7d8646fbc329e26028c65a85fb7b3b4417f92ca18ba0fde750b34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a189f552df0887ac3e63b913da921f7fd5ba6fa613d3f15cafaf72c426443c7afba95dcbfc012dcc8eaa31983a41707bdcc3605836aa3d4a8a538c5ca70af70e"} 07:18:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:18:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:18:09 INFO - Contents: 07:18:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/63e1415fbf243193f3e94e77a0e276a167a95fff28784133ea819fef06610408833fba26b4d7d8646fbc329e26028c65a85fb7b3b4417f92ca18ba0fde750b34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a189f552df0887ac3e63b913da921f7fd5ba6fa613d3f15cafaf72c426443c7afba95dcbfc012dcc8eaa31983a41707bdcc3605836aa3d4a8a538c5ca70af70e"} 07:18:09 INFO - Running post-run listener: copy_logs_to_upload_dir 07:18:09 INFO - Copying logs to upload dir... 07:18:09 INFO - mkdir: /builds/slave/test/build/upload/logs 07:18:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.245338 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-03-03 07:18:09.414204) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-03 07:18:09.419297) ========= 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.cgAoLDtFsa/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.OmHJ7IjD6T/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/63e1415fbf243193f3e94e77a0e276a167a95fff28784133ea819fef06610408833fba26b4d7d8646fbc329e26028c65a85fb7b3b4417f92ca18ba0fde750b34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a189f552df0887ac3e63b913da921f7fd5ba6fa613d3f15cafaf72c426443c7afba95dcbfc012dcc8eaa31983a41707bdcc3605836aa3d4a8a538c5ca70af70e"} build_url:https://queue.taskcluster.net/v1/task/EllbazKoQcamMHfGFKy7NQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011600 build_url: 'https://queue.taskcluster.net/v1/task/EllbazKoQcamMHfGFKy7NQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/63e1415fbf243193f3e94e77a0e276a167a95fff28784133ea819fef06610408833fba26b4d7d8646fbc329e26028c65a85fb7b3b4417f92ca18ba0fde750b34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a189f552df0887ac3e63b913da921f7fd5ba6fa613d3f15cafaf72c426443c7afba95dcbfc012dcc8eaa31983a41707bdcc3605836aa3d4a8a538c5ca70af70e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-03 07:18:09.446779) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 07:18:09.447115) ========= 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.cgAoLDtFsa/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.OmHJ7IjD6T/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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.005236 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 07:18:09.495749) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-03 07:18:09.496099) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-03 07:18:09.496656) ========= ========= Total master_lag: 0.46 =========