builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0164 starttime: 1455885462.76 results: success (0) buildid: 20160219025600 builduid: 8104c96d43c8414e890f19853baaeb97 revision: cc1448afa617045d5b00c2ed183ec5b5707ee1f8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-19 04:37:42.762814) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-19 04:37:42.763260) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-19 04:37:42.763546) ========= 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.kQ1dtTmyqU/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.RPo9prGHSP/Listeners TMPDIR=/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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.005829 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-19 04:37:42.788575) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-19 04:37:42.788881) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-19 04:37:42.803952) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 04:37:42.804315) ========= 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.kQ1dtTmyqU/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.RPo9prGHSP/Listeners TMPDIR=/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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.005620 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 04:37:42.853513) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-19 04:37:42.853878) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-19 04:37:42.854257) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 04:37:42.854534) ========= 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.kQ1dtTmyqU/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.RPo9prGHSP/Listeners TMPDIR=/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-02-19 04:37:42-- 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% 145M=0s 2016-02-19 04:37:42 (145 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.106540 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 04:37:42.978818) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 04:37:42.979140) ========= 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.kQ1dtTmyqU/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.RPo9prGHSP/Listeners TMPDIR=/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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.019583 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 04:37:43.028218) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-19 04:37:43.028747) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev cc1448afa617045d5b00c2ed183ec5b5707ee1f8 --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 cc1448afa617045d5b00c2ed183ec5b5707ee1f8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kQ1dtTmyqU/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.RPo9prGHSP/Listeners TMPDIR=/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-02-19 04:37:43,104 truncating revision to first 12 chars 2016-02-19 04:37:43,104 Setting DEBUG logging. 2016-02-19 04:37:43,104 attempt 1/10 2016-02-19 04:37:43,104 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/cc1448afa617?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-19 04:37:44,104 unpacking tar archive at: fx-team-cc1448afa617/testing/mozharness/ program finished with exit code 0 elapsedTime=1.255757 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-19 04:37:44.300633) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-19 04:37:44.301023) ========= echo cc1448afa617045d5b00c2ed183ec5b5707ee1f8 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'cc1448afa617045d5b00c2ed183ec5b5707ee1f8'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kQ1dtTmyqU/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.RPo9prGHSP/Listeners TMPDIR=/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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 cc1448afa617045d5b00c2ed183ec5b5707ee1f8 program finished with exit code 0 elapsedTime=0.005202 script_repo_revision: 'cc1448afa617045d5b00c2ed183ec5b5707ee1f8' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-19 04:37:44.351419) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-19 04:37:44.351727) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-19 04:37:44.365670) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-02-19 04:37:44.366100) ========= /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.kQ1dtTmyqU/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.RPo9prGHSP/Listeners TMPDIR=/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:37:44 INFO - MultiFileLogger online at 20160219 04:37:44 in /builds/slave/test 04:37:44 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 04:37:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:37:44 INFO - {'append_to_log': False, 04:37:44 INFO - 'base_work_dir': '/builds/slave/test', 04:37:44 INFO - 'blob_upload_branch': 'Fx-Team', 04:37:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:37:44 INFO - 'branch': 'Fx-Team', 04:37:44 INFO - 'buildbot_json_path': 'buildprops.json', 04:37:44 INFO - 'config_files': ('talos/mac_config.py',), 04:37:44 INFO - 'default_actions': ('clobber', 04:37:44 INFO - 'read-buildbot-config', 04:37:44 INFO - 'download-and-extract', 04:37:44 INFO - 'populate-webroot', 04:37:44 INFO - 'create-virtualenv', 04:37:44 INFO - 'install', 04:37:44 INFO - 'run-tests'), 04:37:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:37:44 INFO - 'download_minidump_stackwalk': True, 04:37:44 INFO - 'download_symbols': 'ondemand', 04:37:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:37:44 INFO - 'tooltool.py': '/tools/tooltool.py', 04:37:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:37:44 INFO - '/tools/misc-python/virtualenv.py')}, 04:37:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:37:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:37:44 INFO - 'installer_path': 'installer.exe', 04:37:44 INFO - 'log_level': 'info', 04:37:44 INFO - 'log_name': 'talos', 04:37:44 INFO - 'log_to_console': True, 04:37:44 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:37:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:37:44 INFO - 'opt_config_files': (), 04:37:44 INFO - 'pip_index': False, 04:37:44 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:37:44 INFO - 'cmd': ('bash', 04:37:44 INFO - '-c', 04:37:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:37:44 INFO - 'enabled': True, 04:37:44 INFO - 'halt_on_failure': False, 04:37:44 INFO - 'name': 'check_screen_resolution'},), 04:37:44 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:37:44 INFO - 'cmd': ('bash', 04:37:44 INFO - '-c', 04:37:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:37:44 INFO - 'enabled': True, 04:37:44 INFO - 'halt_on_failure': False, 04:37:44 INFO - 'name': 'check_screen_resolution'},), 04:37:44 INFO - 'run_cmd_checks_enabled': True, 04:37:44 INFO - 'sps_profile': False, 04:37:44 INFO - 'sps_profile_interval': 0, 04:37:44 INFO - 'suite': 'dromaeojs', 04:37:44 INFO - 'system_bits': '32', 04:37:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:37:44 INFO - 'title': 't-yosemite-r7-0164', 04:37:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:37:44 INFO - 'use_talos_json': True, 04:37:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:37:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:37:44 INFO - 'work_dir': 'build'} 04:37:44 INFO - ##### 04:37:44 INFO - ##### Running clobber step. 04:37:44 INFO - ##### 04:37:44 INFO - Running pre-action listener: _resource_record_pre_action 04:37:44 INFO - Running main action method: clobber 04:37:44 INFO - rmtree: /builds/slave/test/build 04:37:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:37:45 INFO - Running post-action listener: _resource_record_post_action 04:37:45 INFO - ##### 04:37:45 INFO - ##### Running read-buildbot-config step. 04:37:45 INFO - ##### 04:37:45 INFO - Running pre-action listener: _resource_record_pre_action 04:37:45 INFO - Running main action method: read_buildbot_config 04:37:45 INFO - Using buildbot properties: 04:37:45 INFO - { 04:37:45 INFO - "project": "", 04:37:45 INFO - "product": "firefox", 04:37:45 INFO - "script_repo_revision": "production", 04:37:45 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 04:37:45 INFO - "repository": "", 04:37:45 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 04:37:45 INFO - "buildid": "20160219025600", 04:37:45 INFO - "pgo_build": "False", 04:37:45 INFO - "basedir": "/builds/slave/test", 04:37:45 INFO - "buildnumber": 392, 04:37:45 INFO - "slavename": "t-yosemite-r7-0164", 04:37:45 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 04:37:45 INFO - "platform": "yosemite_r7", 04:37:45 INFO - "scheduler": "tests-fx-team-macosx64-talos", 04:37:45 INFO - "branch": "fx-team", 04:37:45 INFO - "repo_path": "integration/fx-team", 04:37:45 INFO - "revision": "cc1448afa617045d5b00c2ed183ec5b5707ee1f8", 04:37:45 INFO - "stage_platform": "macosx64", 04:37:45 INFO - "builduid": "8104c96d43c8414e890f19853baaeb97", 04:37:45 INFO - "slavebuilddir": "test" 04:37:45 INFO - } 04:37:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/VzgcD2VaS4GCXDHY5AIo5Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 04:37:45 INFO - Running post-action listener: _resource_record_post_action 04:37:45 INFO - ##### 04:37:45 INFO - ##### Running download-and-extract step. 04:37:45 INFO - ##### 04:37:45 INFO - Running pre-action listener: _resource_record_pre_action 04:37:45 INFO - Running main action method: download_and_extract 04:37:45 INFO - mkdir: /builds/slave/test/build/tests 04:37:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:45 INFO - https://queue.taskcluster.net/v1/task/VzgcD2VaS4GCXDHY5AIo5Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:37:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VzgcD2VaS4GCXDHY5AIo5Q/artifacts/public/build/test_packages.json 04:37:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VzgcD2VaS4GCXDHY5AIo5Q/artifacts/public/build/test_packages.json 04:37:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VzgcD2VaS4GCXDHY5AIo5Q/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:37:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VzgcD2VaS4GCXDHY5AIo5Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:37:46 INFO - Downloaded 1277 bytes. 04:37:46 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:37:46 INFO - Using the following test package requirements: 04:37:46 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:37:46 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:37:46 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 04:37:46 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:37:46 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 04:37:46 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:37:46 INFO - u'jsshell-mac.zip'], 04:37:46 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:37:46 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 04:37:46 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:37:46 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:37:46 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 04:37:46 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:37:46 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 04:37:46 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:37:46 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 04:37:46 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:37:46 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:37:46 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 04:37:46 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:37:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:46 INFO - https://queue.taskcluster.net/v1/task/VzgcD2VaS4GCXDHY5AIo5Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:37:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VzgcD2VaS4GCXDHY5AIo5Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:37:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VzgcD2VaS4GCXDHY5AIo5Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:37:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VzgcD2VaS4GCXDHY5AIo5Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:37:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VzgcD2VaS4GCXDHY5AIo5Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:37:48 INFO - Downloaded 17807227 bytes. 04:37:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:37:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:37:51 INFO - Return code: 0 04:37:51 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:37:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:51 INFO - https://queue.taskcluster.net/v1/task/VzgcD2VaS4GCXDHY5AIo5Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:37:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VzgcD2VaS4GCXDHY5AIo5Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:37:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VzgcD2VaS4GCXDHY5AIo5Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:37:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VzgcD2VaS4GCXDHY5AIo5Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:37:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VzgcD2VaS4GCXDHY5AIo5Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:37:52 INFO - Downloaded 17807227 bytes. 04:37:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:37:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:37:55 INFO - Return code: 0 04:37:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:55 INFO - https://queue.taskcluster.net/v1/task/VzgcD2VaS4GCXDHY5AIo5Q/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:37:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VzgcD2VaS4GCXDHY5AIo5Q/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 04:37:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VzgcD2VaS4GCXDHY5AIo5Q/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 04:37:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VzgcD2VaS4GCXDHY5AIo5Q/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 04:37:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VzgcD2VaS4GCXDHY5AIo5Q/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:37:56 INFO - Downloaded 10707015 bytes. 04:37:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:37:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 04:37:56 INFO - Return code: 0 04:37:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:56 INFO - https://queue.taskcluster.net/v1/task/VzgcD2VaS4GCXDHY5AIo5Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 04:37:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VzgcD2VaS4GCXDHY5AIo5Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:37:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VzgcD2VaS4GCXDHY5AIo5Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:37:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VzgcD2VaS4GCXDHY5AIo5Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 04:37:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VzgcD2VaS4GCXDHY5AIo5Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 04:37:59 INFO - Downloaded 111322905 bytes. 04:37:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VzgcD2VaS4GCXDHY5AIo5Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:37:59 INFO - mkdir: /builds/slave/test/properties 04:37:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:37:59 INFO - Writing to file /builds/slave/test/properties/build_url 04:37:59 INFO - Contents: 04:37:59 INFO - build_url:https://queue.taskcluster.net/v1/task/VzgcD2VaS4GCXDHY5AIo5Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:38:00 INFO - Running post-action listener: _resource_record_post_action 04:38:00 INFO - Running post-action listener: set_extra_try_arguments 04:38:00 INFO - ##### 04:38:00 INFO - ##### Running populate-webroot step. 04:38:00 INFO - ##### 04:38:00 INFO - Running pre-action listener: _resource_record_pre_action 04:38:00 INFO - Running main action method: populate_webroot 04:38:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:38:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:38:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:38:00 INFO - '--tppagecycles', 04:38:00 INFO - '7'], 04:38:00 INFO - 'tests': ['tsvgm']}}, 04:38:00 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:38:00 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:38:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:38:00 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:38:00 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:38:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:38:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:38:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:38:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:38:00 INFO - 'talos_options': ['--e10s'], 04:38:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:38:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:38:00 INFO - 'tests': ['damp', 'tps']}, 04:38:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:38:00 INFO - 'talos_options': ['--e10s'], 04:38:00 INFO - 'tests': ['damp', 'tps']}, 04:38:00 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:38:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:38:00 INFO - 'other': {'tests': ['a11yr', 04:38:00 INFO - 'ts_paint', 04:38:00 INFO - 'tpaint', 04:38:00 INFO - 'sessionrestore', 04:38:00 INFO - 'sessionrestore_no_auto_restore']}, 04:38:00 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:38:00 INFO - 'tests': ['a11yr', 04:38:00 INFO - 'ts_paint', 04:38:00 INFO - 'tpaint', 04:38:00 INFO - 'sessionrestore', 04:38:00 INFO - 'sessionrestore_no_auto_restore']}, 04:38:00 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:38:00 INFO - 'tests': ['a11yr', 04:38:00 INFO - 'ts_paint', 04:38:00 INFO - 'tpaint', 04:38:00 INFO - 'sessionrestore', 04:38:00 INFO - 'sessionrestore_no_auto_restore']}, 04:38:00 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:38:00 INFO - 'tests': ['a11yr', 04:38:00 INFO - 'ts_paint', 04:38:00 INFO - 'tpaint', 04:38:00 INFO - 'sessionrestore', 04:38:00 INFO - 'sessionrestore_no_auto_restore']}, 04:38:00 INFO - 'other_l64': {'tests': ['a11yr', 04:38:00 INFO - 'ts_paint', 04:38:00 INFO - 'tpaint', 04:38:00 INFO - 'sessionrestore', 04:38:00 INFO - 'sessionrestore_no_auto_restore']}, 04:38:00 INFO - 'other_nol64': {'tests': ['a11yr', 04:38:00 INFO - 'ts_paint', 04:38:00 INFO - 'tpaint', 04:38:00 INFO - 'sessionrestore', 04:38:00 INFO - 'sessionrestore_no_auto_restore']}, 04:38:00 INFO - 'svgr': {'tests': ['tsvgx', 04:38:00 INFO - 'tsvgr_opacity', 04:38:00 INFO - 'tart', 04:38:00 INFO - 'tscrollx', 04:38:00 INFO - 'cart']}, 04:38:00 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:38:00 INFO - 'tests': ['tsvgx', 04:38:00 INFO - 'tsvgr_opacity', 04:38:00 INFO - 'tart', 04:38:00 INFO - 'tscrollx', 04:38:00 INFO - 'cart']}, 04:38:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:38:00 INFO - 'tests': ['tp5o']}, 04:38:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:38:00 INFO - 'talos_options': ['--e10s'], 04:38:00 INFO - 'tests': ['tp5o']}, 04:38:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:38:00 INFO - 'talos_options': ['--xperf_path', 04:38:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:38:00 INFO - 'tests': ['tp5n']}, 04:38:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:38:00 INFO - 'talos_options': ['--e10s', 04:38:00 INFO - '--xperf_path', 04:38:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:38:00 INFO - 'tests': ['tp5n']}}, 04:38:00 INFO - 'talos.zip': {'path': '', 04:38:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:38:00 INFO - Running post-action listener: _resource_record_post_action 04:38:00 INFO - ##### 04:38:00 INFO - ##### Running create-virtualenv step. 04:38:00 INFO - ##### 04:38:00 INFO - Running pre-action listener: _resource_record_pre_action 04:38:00 INFO - Running main action method: create_virtualenv 04:38:00 INFO - Creating virtualenv /builds/slave/test/build/venv 04:38:00 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:38:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:38:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:38:00 INFO - Using real prefix '/tools/python27' 04:38:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:38:01 INFO - Installing distribute.............................................................................................................................................................................................done. 04:38:04 INFO - Installing pip.................done. 04:38:04 INFO - Return code: 0 04:38:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:38:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:04 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 0x109df6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109dfe4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd84ac83280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c9ad30>, '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 0x109abedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c91b20>, '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.kQ1dtTmyqU/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.RPo9prGHSP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:38:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:38:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:38:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kQ1dtTmyqU/Render', 04:38:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:04 INFO - 'HOME': '/Users/cltbld', 04:38:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:04 INFO - 'LOGNAME': 'cltbld', 04:38:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:04 INFO - 'MOZ_NO_REMOTE': '1', 04:38:04 INFO - 'NO_EM_RESTART': '1', 04:38:04 INFO - 'PAGER': '/bin/cat', 04:38:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:04 INFO - 'PWD': '/builds/slave/test', 04:38:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:04 INFO - 'SHELL': '/bin/bash', 04:38:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RPo9prGHSP/Listeners', 04:38:04 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 04:38:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:04 INFO - 'USER': 'cltbld', 04:38:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:04 INFO - 'XPC_FLAGS': '0x0', 04:38:04 INFO - 'XPC_SERVICE_NAME': '0', 04:38:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:04 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:38:04 INFO - Cleaning up... 04:38:04 INFO - Return code: 0 04:38:04 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:38:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:04 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 0x109df6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109dfe4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd84ac83280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c9ad30>, '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 0x109abedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c91b20>, '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.kQ1dtTmyqU/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.RPo9prGHSP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:38:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:38:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:38:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kQ1dtTmyqU/Render', 04:38:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:04 INFO - 'HOME': '/Users/cltbld', 04:38:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:04 INFO - 'LOGNAME': 'cltbld', 04:38:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:04 INFO - 'MOZ_NO_REMOTE': '1', 04:38:04 INFO - 'NO_EM_RESTART': '1', 04:38:04 INFO - 'PAGER': '/bin/cat', 04:38:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:04 INFO - 'PWD': '/builds/slave/test', 04:38:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:04 INFO - 'SHELL': '/bin/bash', 04:38:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RPo9prGHSP/Listeners', 04:38:04 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 04:38:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:04 INFO - 'USER': 'cltbld', 04:38:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:04 INFO - 'XPC_FLAGS': '0x0', 04:38:04 INFO - 'XPC_SERVICE_NAME': '0', 04:38:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:05 INFO - Downloading/unpacking psutil>=0.7.1 04:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:38:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:38:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:38:07 INFO - Installing collected packages: psutil 04:38:07 INFO - Running setup.py install for psutil 04:38:07 INFO - building 'psutil._psutil_osx' extension 04:38:07 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:38:08 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:38:08 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:38:08 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:38:08 INFO - building 'psutil._psutil_posix' extension 04:38:08 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:38:08 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:38:08 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:38:08 INFO - ^ 04:38:08 INFO - 1 warning generated. 04:38:08 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:38:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:38:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:38:08 INFO - Successfully installed psutil 04:38:08 INFO - Cleaning up... 04:38:08 INFO - Return code: 0 04:38:08 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:38: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')]} 04:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38: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')]} 04:38:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:08 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 0x109df6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109dfe4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd84ac83280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c9ad30>, '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 0x109abedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c91b20>, '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.kQ1dtTmyqU/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.RPo9prGHSP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:38:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:38:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:38:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kQ1dtTmyqU/Render', 04:38:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:08 INFO - 'HOME': '/Users/cltbld', 04:38:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:08 INFO - 'LOGNAME': 'cltbld', 04:38:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:08 INFO - 'MOZ_NO_REMOTE': '1', 04:38:08 INFO - 'NO_EM_RESTART': '1', 04:38:08 INFO - 'PAGER': '/bin/cat', 04:38:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:08 INFO - 'PWD': '/builds/slave/test', 04:38:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:08 INFO - 'SHELL': '/bin/bash', 04:38:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RPo9prGHSP/Listeners', 04:38:08 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 04:38:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:08 INFO - 'USER': 'cltbld', 04:38:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:08 INFO - 'XPC_FLAGS': '0x0', 04:38:08 INFO - 'XPC_SERVICE_NAME': '0', 04:38:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:08 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:38:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:38:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:38:11 INFO - Installing collected packages: mozsystemmonitor 04:38:11 INFO - Running setup.py install for mozsystemmonitor 04:38:11 INFO - Successfully installed mozsystemmonitor 04:38:11 INFO - Cleaning up... 04:38:11 INFO - Return code: 0 04:38:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:38:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:11 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 0x109df6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109dfe4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd84ac83280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c9ad30>, '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 0x109abedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c91b20>, '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.kQ1dtTmyqU/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.RPo9prGHSP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:38:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:38:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:38:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kQ1dtTmyqU/Render', 04:38:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:11 INFO - 'HOME': '/Users/cltbld', 04:38:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:11 INFO - 'LOGNAME': 'cltbld', 04:38:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:11 INFO - 'MOZ_NO_REMOTE': '1', 04:38:11 INFO - 'NO_EM_RESTART': '1', 04:38:11 INFO - 'PAGER': '/bin/cat', 04:38:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:11 INFO - 'PWD': '/builds/slave/test', 04:38:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:11 INFO - 'SHELL': '/bin/bash', 04:38:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RPo9prGHSP/Listeners', 04:38:11 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 04:38:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:11 INFO - 'USER': 'cltbld', 04:38:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:11 INFO - 'XPC_FLAGS': '0x0', 04:38:11 INFO - 'XPC_SERVICE_NAME': '0', 04:38:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:11 INFO - Downloading/unpacking blobuploader==1.2.4 04:38:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:14 INFO - Downloading blobuploader-1.2.4.tar.gz 04:38:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:38:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:38:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:15 INFO - Downloading docopt-0.6.1.tar.gz 04:38:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:38:15 INFO - Installing collected packages: blobuploader, requests, docopt 04:38:15 INFO - Running setup.py install for blobuploader 04:38:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:38:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:38:15 INFO - Running setup.py install for requests 04:38:15 INFO - Running setup.py install for docopt 04:38:16 INFO - Successfully installed blobuploader requests docopt 04:38:16 INFO - Cleaning up... 04:38:16 INFO - Return code: 0 04:38:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:38:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:16 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 0x109df6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109dfe4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd84ac83280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c9ad30>, '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 0x109abedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c91b20>, '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.kQ1dtTmyqU/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.RPo9prGHSP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:38:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:38:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:38:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kQ1dtTmyqU/Render', 04:38:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:16 INFO - 'HOME': '/Users/cltbld', 04:38:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:16 INFO - 'LOGNAME': 'cltbld', 04:38:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:16 INFO - 'MOZ_NO_REMOTE': '1', 04:38:16 INFO - 'NO_EM_RESTART': '1', 04:38:16 INFO - 'PAGER': '/bin/cat', 04:38:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:16 INFO - 'PWD': '/builds/slave/test', 04:38:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:16 INFO - 'SHELL': '/bin/bash', 04:38:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RPo9prGHSP/Listeners', 04:38:16 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 04:38:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:16 INFO - 'USER': 'cltbld', 04:38:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:16 INFO - 'XPC_FLAGS': '0x0', 04:38:16 INFO - 'XPC_SERVICE_NAME': '0', 04:38:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:38:16 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-83Bqvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:38:16 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-HLT8zn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:38:16 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-wA9vEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:38:16 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-SOtxaQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:38:16 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-RfhfhJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:38:17 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-cHAkz3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:38:17 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-WnXTx3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:38:17 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-tYzS77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:38:17 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-sVUF8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:38:17 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-NY4oro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:38:17 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-mVzjva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:38:17 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-0DI1Og-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:38:17 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-nmMb9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:38:17 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-AtN6jw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:38:17 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-2CGyLf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:38:18 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-oPSah3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:38:18 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-nyc5JM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:38:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:38:18 INFO - Running setup.py install for manifestparser 04:38:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:38:18 INFO - Running setup.py install for mozcrash 04:38:18 INFO - Running setup.py install for mozdebug 04:38:18 INFO - Running setup.py install for mozdevice 04:38:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:38:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:38:18 INFO - Running setup.py install for mozfile 04:38:18 INFO - Running setup.py install for mozhttpd 04:38:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:38:19 INFO - Running setup.py install for mozinfo 04:38:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:38:19 INFO - Running setup.py install for mozInstall 04:38:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:38:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:38:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:38:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:38:19 INFO - Running setup.py install for mozleak 04:38:19 INFO - Running setup.py install for mozlog 04:38:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:38:19 INFO - Running setup.py install for moznetwork 04:38:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:38:19 INFO - Running setup.py install for mozprocess 04:38:20 INFO - Running setup.py install for mozprofile 04:38:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:38:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:38:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:38:20 INFO - Running setup.py install for mozrunner 04:38:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:38:20 INFO - Running setup.py install for mozscreenshot 04:38:20 INFO - Running setup.py install for moztest 04:38:20 INFO - Running setup.py install for mozversion 04:38:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:38:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:38:20 INFO - Cleaning up... 04:38:20 INFO - Return code: 0 04:38:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:38:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:20 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 0x109df6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109dfe4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd84ac83280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c9ad30>, '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 0x109abedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c91b20>, '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.kQ1dtTmyqU/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.RPo9prGHSP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:38:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:38:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:38:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kQ1dtTmyqU/Render', 04:38:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:20 INFO - 'HOME': '/Users/cltbld', 04:38:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:20 INFO - 'LOGNAME': 'cltbld', 04:38:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:20 INFO - 'MOZ_NO_REMOTE': '1', 04:38:20 INFO - 'NO_EM_RESTART': '1', 04:38:20 INFO - 'PAGER': '/bin/cat', 04:38:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:20 INFO - 'PWD': '/builds/slave/test', 04:38:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:20 INFO - 'SHELL': '/bin/bash', 04:38:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RPo9prGHSP/Listeners', 04:38:20 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 04:38:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:20 INFO - 'USER': 'cltbld', 04:38:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:20 INFO - 'XPC_FLAGS': '0x0', 04:38:20 INFO - 'XPC_SERVICE_NAME': '0', 04:38:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:38:21 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-B1ZzPs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:38:21 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:38:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:38:21 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-1lSrWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:38:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:38:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:38:21 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-fbi3Mq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:38:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:38:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:38:21 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-uNZt8A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:38:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:38:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:38:21 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-1FwwnW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:38:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:38:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:38:21 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-P8ehnD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:38:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:38:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:38:21 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-X1pB49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:38:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:38:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:38:21 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-YySfm8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:38:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:38:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:38:21 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-s8zEhd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:38:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:38:22 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-CqXY0Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:38:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:38:22 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-h4trhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:38:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:38:22 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-T2KXPs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:38:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:38:22 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-ZqtXH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:38:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:38:22 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-XHlZsL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:38:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:38:22 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-6loJZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:38:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:38:22 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-gclaFy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:38:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:38:22 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-mCQDy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:38:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:38:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:38:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:38:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:38:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:38:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:38:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:38:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:25 INFO - Downloading blessings-1.6.tar.gz 04:38:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:38:25 INFO - Installing collected packages: blessings 04:38:25 INFO - Running setup.py install for blessings 04:38:25 INFO - Successfully installed blessings 04:38:25 INFO - Cleaning up... 04:38:25 INFO - Return code: 0 04:38:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:38:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:38:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:38:25 INFO - Reading from file tmpfile_stdout 04:38:25 INFO - Current package versions: 04:38:25 INFO - blessings == 1.6 04:38:25 INFO - blobuploader == 1.2.4 04:38:25 INFO - docopt == 0.6.1 04:38:25 INFO - manifestparser == 1.1 04:38:25 INFO - mozInstall == 1.12 04:38:25 INFO - mozcrash == 0.16 04:38:25 INFO - mozdebug == 0.1 04:38:25 INFO - mozdevice == 0.48 04:38:25 INFO - mozfile == 1.2 04:38:25 INFO - mozhttpd == 0.7 04:38:25 INFO - mozinfo == 0.9 04:38:25 INFO - mozleak == 0.1 04:38:25 INFO - mozlog == 3.1 04:38:25 INFO - moznetwork == 0.27 04:38:25 INFO - mozprocess == 0.22 04:38:25 INFO - mozprofile == 0.28 04:38:25 INFO - mozrunner == 6.11 04:38:25 INFO - mozscreenshot == 0.1 04:38:25 INFO - mozsystemmonitor == 0.0 04:38:25 INFO - moztest == 0.7 04:38:25 INFO - mozversion == 1.4 04:38:25 INFO - psutil == 3.1.1 04:38:25 INFO - requests == 1.2.3 04:38:25 INFO - wsgiref == 0.1.2 04:38:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:38:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:25 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 0x109df6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109dfe4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd84ac83280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c9ad30>, '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 0x109abedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c91b20>, '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.kQ1dtTmyqU/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.RPo9prGHSP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:38:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:38:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:38:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kQ1dtTmyqU/Render', 04:38:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:25 INFO - 'HOME': '/Users/cltbld', 04:38:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:25 INFO - 'LOGNAME': 'cltbld', 04:38:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:25 INFO - 'MOZ_NO_REMOTE': '1', 04:38:25 INFO - 'NO_EM_RESTART': '1', 04:38:25 INFO - 'PAGER': '/bin/cat', 04:38:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:25 INFO - 'PWD': '/builds/slave/test', 04:38:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:25 INFO - 'SHELL': '/bin/bash', 04:38:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RPo9prGHSP/Listeners', 04:38:25 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 04:38:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:25 INFO - 'USER': 'cltbld', 04:38:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:25 INFO - 'XPC_FLAGS': '0x0', 04:38:25 INFO - 'XPC_SERVICE_NAME': '0', 04:38:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:38:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:38:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:38:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:38:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:38:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:38:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:38:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:38:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:38:26 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:38:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:38:26 INFO - Cleaning up... 04:38:26 INFO - Return code: 0 04:38:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:38:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:26 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 0x109df6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109dfe4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd84ac83280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c9ad30>, '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 0x109abedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c91b20>, '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.kQ1dtTmyqU/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.RPo9prGHSP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:38:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:38:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:38:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kQ1dtTmyqU/Render', 04:38:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:26 INFO - 'HOME': '/Users/cltbld', 04:38:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:26 INFO - 'LOGNAME': 'cltbld', 04:38:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:26 INFO - 'MOZ_NO_REMOTE': '1', 04:38:26 INFO - 'NO_EM_RESTART': '1', 04:38:26 INFO - 'PAGER': '/bin/cat', 04:38:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:26 INFO - 'PWD': '/builds/slave/test', 04:38:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:26 INFO - 'SHELL': '/bin/bash', 04:38:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RPo9prGHSP/Listeners', 04:38:26 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 04:38:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:26 INFO - 'USER': 'cltbld', 04:38:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:26 INFO - 'XPC_FLAGS': '0x0', 04:38:26 INFO - 'XPC_SERVICE_NAME': '0', 04:38:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:26 INFO - Downloading/unpacking jsonschema 04:38:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:38:28 INFO - Downloading/unpacking functools32 (from jsonschema) 04:38: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 04:38: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 04:38: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 04:38: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 04:38: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 04:38: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 04:38:29 INFO - Downloading functools32-3.2.3-2.tar.gz 04:38:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:38:29 INFO - warning: no files found matching '*.txt' 04:38:29 INFO - no previously-included directories found matching 'build' 04:38:29 INFO - no previously-included directories found matching 'dist' 04:38:29 INFO - no previously-included directories found matching '.git*' 04:38:29 INFO - Installing collected packages: jsonschema, functools32 04:38:29 INFO - Running setup.py install for functools32 04:38:29 INFO - warning: no files found matching '*.txt' 04:38:29 INFO - no previously-included directories found matching 'build' 04:38:29 INFO - no previously-included directories found matching 'dist' 04:38:29 INFO - no previously-included directories found matching '.git*' 04:38:29 INFO - Successfully installed jsonschema functools32 04:38:29 INFO - Cleaning up... 04:38:29 INFO - Return code: 0 04:38:29 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:38:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:29 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 0x109df6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109dfe4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd84ac83280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c9ad30>, '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 0x109abedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c91b20>, '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.kQ1dtTmyqU/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.RPo9prGHSP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:38:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:38:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:38:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kQ1dtTmyqU/Render', 04:38:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:29 INFO - 'HOME': '/Users/cltbld', 04:38:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:29 INFO - 'LOGNAME': 'cltbld', 04:38:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:29 INFO - 'MOZ_NO_REMOTE': '1', 04:38:29 INFO - 'NO_EM_RESTART': '1', 04:38:29 INFO - 'PAGER': '/bin/cat', 04:38:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:29 INFO - 'PWD': '/builds/slave/test', 04:38:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:29 INFO - 'SHELL': '/bin/bash', 04:38:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RPo9prGHSP/Listeners', 04:38:29 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 04:38:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:29 INFO - 'USER': 'cltbld', 04:38:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:29 INFO - 'XPC_FLAGS': '0x0', 04:38:29 INFO - 'XPC_SERVICE_NAME': '0', 04:38:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:29 INFO - Downloading/unpacking flake8 04:38:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:31 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:38:32 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:38: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 04:38: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 04:38: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 04:38: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 04:38: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 04:38: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 04:38:32 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:38:32 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:38: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 04:38: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 04:38: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 04:38: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 04:38: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 04:38: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 04:38:32 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:38: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 04:38: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 04:38: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 04:38: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 04:38: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 04:38: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 04:38:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:38:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:38:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:38:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:38:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:38:33 INFO - no previously-included directories found matching 'docs/_build' 04:38:33 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:38:33 INFO - Running setup.py install for pep8 04:38:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:38:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:38:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:38:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:38:33 INFO - no previously-included directories found matching 'docs/_build' 04:38:33 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:38:33 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:38:33 INFO - Cleaning up... 04:38:33 INFO - Return code: 0 04:38:33 INFO - Running post-action listener: _resource_record_post_action 04:38:33 INFO - Running post-action listener: _start_resource_monitoring 04:38:33 INFO - Starting resource monitoring. 04:38:33 INFO - ##### 04:38:33 INFO - ##### Running install step. 04:38:33 INFO - ##### 04:38:33 INFO - Running pre-action listener: _resource_record_pre_action 04:38:33 INFO - Running main action method: install 04:38:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:38:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:38:33 INFO - Reading from file tmpfile_stdout 04:38:33 INFO - Detecting whether we're running mozinstall >=1.0... 04:38:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:38:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:38:33 INFO - Reading from file tmpfile_stdout 04:38:33 INFO - Output received: 04:38:33 INFO - Usage: mozinstall [options] installer 04:38:33 INFO - Options: 04:38:33 INFO - -h, --help show this help message and exit 04:38:33 INFO - -d DEST, --destination=DEST 04:38:33 INFO - Directory to install application into. [default: 04:38:33 INFO - "/builds/slave/test"] 04:38:33 INFO - --app=APP Application being installed. [default: firefox] 04:38:33 INFO - mkdir: /builds/slave/test/build/application 04:38:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:38:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:39:08 INFO - Reading from file tmpfile_stdout 04:39:08 INFO - Output received: 04:39:08 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:39:08 INFO - Running post-action listener: _resource_record_post_action 04:39:08 INFO - ##### 04:39:08 INFO - ##### Running run-tests step. 04:39:08 INFO - ##### 04:39:08 INFO - Running pre-action listener: _resource_record_pre_action 04:39:08 INFO - Running main action method: run_tests 04:39:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:39:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:39:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:39:08 INFO - 2016-02-19 04:39:08.595 screenresolution[2900:21163] starting screenresolution argv=screenresolution get 04:39:08 INFO - 2016-02-19 04:39:08.598 screenresolution[2900:21163] Display 0: 1600x1200x32@60 04:39:08 INFO - 2016-02-19 04:39:08.604 screenresolution[2901:21167] starting screenresolution argv=screenresolution list 04:39:08 INFO - Available Modes on Display 0 04:39:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:39:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:39:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:39:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:39:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:39:08 INFO - Intel Iris: 04:39:08 INFO - Chipset Model: Intel Iris 04:39:08 INFO - Type: GPU 04:39:08 INFO - Bus: Built-In 04:39:08 INFO - VRAM (Dynamic, Max): 1536 MB 04:39:08 INFO - Vendor: Intel (0x8086) 04:39:08 INFO - Device ID: 0x0a2e 04:39:08 INFO - Revision ID: 0x0009 04:39:08 INFO - Displays: 04:39:08 INFO - Display: 04:39:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:39:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:39:08 INFO - Display Serial Number: 1600x1200 60 04:39:08 INFO - Main Display: Yes 04:39:08 INFO - Mirror: Off 04:39:08 INFO - Online: Yes 04:39:08 INFO - Rotation: Supported 04:39:08 INFO - Return code: 0 04:39:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:39:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:39:08 INFO - Python 2.7.3 04:39:08 INFO - Return code: 0 04:39:08 INFO - grabbing minidump binary from tooltool 04:39: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')]} 04:39:08 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 0x109c9ad30>, '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 0x109abedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c91b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:39:08 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:39:08 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:39:08 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:39:08 INFO - Return code: 0 04:39:08 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:39:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:39:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:39:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:39:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:39:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:39:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:39:10 INFO - Return code: 0 04:39:10 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/VzgcD2VaS4GCXDHY5AIo5Q/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0164', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:39:10 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/VzgcD2VaS4GCXDHY5AIo5Q/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0164 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:39:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kQ1dtTmyqU/Render', 04:39:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:10 INFO - 'HOME': '/Users/cltbld', 04:39:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:10 INFO - 'LOGNAME': 'cltbld', 04:39:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:39:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:39:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:10 INFO - 'MOZ_NO_REMOTE': '1', 04:39:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:39:10 INFO - 'NO_EM_RESTART': '1', 04:39:10 INFO - 'PAGER': '/bin/cat', 04:39:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:10 INFO - 'PWD': '/builds/slave/test', 04:39:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:39:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:10 INFO - 'SHELL': '/bin/bash', 04:39:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RPo9prGHSP/Listeners', 04:39:10 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 04:39:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:10 INFO - 'USER': 'cltbld', 04:39:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:10 INFO - 'XPC_FLAGS': '0x0', 04:39:10 INFO - 'XPC_SERVICE_NAME': '0', 04:39:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:10 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/VzgcD2VaS4GCXDHY5AIo5Q/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0164', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:39:10 INFO - mozversion application_buildid: 20160219025600 04:39:10 INFO - mozversion application_changeset: cc1448afa617045d5b00c2ed183ec5b5707ee1f8 04:39:10 INFO - mozversion application_display_name: Nightly 04:39:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:39:10 INFO - mozversion application_name: Firefox 04:39:10 INFO - mozversion application_remotingname: firefox 04:39:10 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:39:10 INFO - mozversion application_vendor: Mozilla 04:39:10 INFO - mozversion application_version: 47.0a1 04:39:10 INFO - mozversion platform_buildid: 20160219025600 04:39:10 INFO - mozversion platform_changeset: cc1448afa617045d5b00c2ed183ec5b5707ee1f8 04:39:10 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:39:10 INFO - mozversion platform_version: 47.0a1 04:39:10 INFO - using testdate: 1455885550 04:39:10 INFO - actual date: 1455885550 04:39:10 INFO - starting webserver on 'localhost:50436' 04:39:10 INFO - SUITE-START | Running 2 tests 04:39:10 INFO - TEST-START | dromaeo_css 04:39:10 INFO - operating with platform_type : mac_ 04:39:10 INFO - Initialising browser for dromaeo_css test... 04:39:10 INFO - TEST-INFO | started process 2919 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/tmp0fvRO4/profile http://localhost:50436/getInfo.html) 04:39:12 INFO - PROCESS | 2919 | __metrics Screen width/height:1600/1200 04:39:12 INFO - PROCESS | 2919 | colorDepth:24 04:39:12 INFO - PROCESS | 2919 | Browser inner width/height: 1024/689 04:39:12 INFO - PROCESS | 2919 | __metrics 04:39:12 INFO - PROCESS | 2919 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:39:12 INFO - PROCESS | 2919 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:39:13 INFO - TEST-INFO | 2919: exit 0 04:39:13 INFO - Browser initialized. 04:39:13 INFO - Running cycle 1/1 for dromaeo_css test... 04:39:13 INFO - TEST-INFO | started process 2922 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/tmp0fvRO4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:39:25 INFO - PROCESS | 2922 | RSS: Main: 244518912 04:39:25 INFO - PROCESS | 2922 | 04:40:16 INFO - PROCESS | 2922 | 1455885616438 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] 04:42:26 INFO - PROCESS | 2922 | Cycle 1(1): loaded http://localhost:50436/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50436/tests/dromaeo/cssquery-ext.html) 04:42:28 INFO - PROCESS | 2922 | RSS: Main: 374255616 04:42:28 INFO - PROCESS | 2922 | 04:45:30 INFO - PROCESS | 2922 | Cycle 1(1): loaded http://localhost:50436/tests/dromaeo/cssquery-ext.html (next: http://localhost:50436/tests/dromaeo/cssquery-jquery.html) 04:45:31 INFO - PROCESS | 2922 | RSS: Main: 382267392 04:45:31 INFO - PROCESS | 2922 | 04:48:33 INFO - PROCESS | 2922 | Cycle 1(1): loaded http://localhost:50436/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50436/tests/dromaeo/cssquery-mootools.html) 04:48:34 INFO - PROCESS | 2922 | RSS: Main: 377057280 04:48:34 INFO - PROCESS | 2922 | 04:51:36 INFO - PROCESS | 2922 | Cycle 1(1): loaded http://localhost:50436/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50436/tests/dromaeo/cssquery-prototype.html) 04:51:36 INFO - PROCESS | 2922 | RSS: Main: 337977344 04:51:36 INFO - PROCESS | 2922 | 04:54:40 INFO - PROCESS | 2922 | Cycle 1(1): loaded http://localhost:50436/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50436/tests/dromaeo/cssquery-yui.html) 04:54:40 INFO - PROCESS | 2922 | RSS: Main: 339079168 04:54:40 INFO - PROCESS | 2922 | 04:57:43 INFO - PROCESS | 2922 | Cycle 1(1): loaded http://localhost:50436/tests/dromaeo/cssquery-yui.html (next: http://localhost:50436/tests/dromaeo/cssquery-dojo.html) 04:57:43 INFO - PROCESS | 2922 | RSS: Main: 394059776 04:57:43 INFO - PROCESS | 2922 | 04:57:43 INFO - PROCESS | 2922 | __start_tp_report 04:57:43 INFO - PROCESS | 2922 | _x_x_mozilla_page_load 04:57:43 INFO - PROCESS | 2922 | _x_x_mozilla_page_load_details 04:57:43 INFO - PROCESS | 2922 | |i|pagename|runs| 04:57:43 INFO - PROCESS | 2922 | |0;dojo.html;3318.2533929865785;3394.5587073680435;3425.246445781928;3441.3977553928057;3451.3787518246704;5558.666480011202;5614.29821272341;5615;5619.662820230784;5663.490285874271;5601.131824567188;5670.0927851543765;5674.886502269963;5682.17608446775;5687.118496633018;5146.125158723026;5169.767360468769;5197.376314842224;5197.558207552363;5243.449437809032;5256.342957130359;5258.763355648985;5261.0267100586325;5269.8155564555245;5274.235235890794;5181.481851814826;5219;5233.4243233244315;5241.606879484035;5245.973770131144;5197.35033120858;5237.973810130963;5238.659487133325;5246.921296180561;5275.076861549252;5100.770465329069;5146.125158722989;5162.174052151638;5165.354330708661;5180.818671346485;5613.242212301368;5615.438456154393;5623.887522249573;5634.492895639371;5649.717514124319;6221.937780622181;6235.407636274592;6239.407256310643;6246.281677607088;6249.531285153632;6123.252118380239;6177;6244.567226512918;6248.031555108965;6274.937250627527;5744.856378590527;5761.48146666802;5763.6541807491685;5767.106098554731;5768.711564421762;5320.680759154463;6200.193974783249;6224.346443623445;6285.308616052231;6319.652419116901;6003.279606447254;6089.269287685506;6096.207493025879;6102.4507794298725;6105.725242364104;6210.863513925438;6254.030625253093;6254.499640028877;6256.593321434092;6268.623882567061;6062.514998800086;6140.4428991762525;6141.140240366352;6161.014237722033;6200.3799620038535;6195.16365290689;6204.81385558434;6219.222597175353;6231.283402408691;6246.843828904313;3833.846646134179;4782.971661092882;4891.26631005352;4891.706497610155;4912.926306105412;4333.523312435629;4362.498312694017;4363.672724545671;4368.497622773421;4410.0738844842945;5602.52378547828;5613.747381367848;5623.690697011703;5624.21261023457;5652.293463317085;5246.449122842123;6126.754929802847;6198.969005154945;6223.813285601439;6274.686265686697;5579.358373787067;5622.859428514238;5627.746751396197;5636.549076073904;5651.632643878134;5324.494173053554;5330.653507521999;5351.946480535223;5352.946470535323;5355.785768569213;6207.81376558704;6228.750849965951;6300.086487459293;6302.338254483305;6329.145565348619;6278.215223097113;6290.465310448663;6300.59046161998;6301.149344838388;6314;6279.937200627935;6293.716782744696;6298.496120310456;6308.243010838729;6309.179806625109;6055.455009049207;6105.9084113737445;6114.936124487681;6129.175413489998;6208.937910620836;6236.438720515175;6247.250329960434;6257.061440783918;6277.905831412441;6300.7479700811455;5898.705064746659;6059.454649081604;6059.454649081604;6060.575759696779;6074.3318234994995;5908.645481271137;6001;6012.549058820693;6075.210222671025;6110.26676798787;5877.588568800143;5877.970610146922;5881.911771323348;5883.176355310175;5915.438033386821;5952.255968003999;6063.636181829104;6068;6087.330393656783;6118.051701986199;5749.8562535936935;5899.17411562373;5900.793472228452;5912.438318359749;5912.822615321547 04:57:43 INFO - PROCESS | 2922 | |1;ext.html;465.3368949247322;505.9342285502884;521.862340098585;548.8188897663771;565.7114871415577;29863.40273194535;37827;38196;38430.61569384309;38535.22929541407;40965.795171024176;41347.58652413475;41445.58554414455;41485;41526.37710434346;9406.200472959807;9646.469444180568;9649.662261820838;9653.420794752337;9656;9427.717168484956;9555.474448905308;9586.904130958706;9592.760180995496;9661.56522956465;9670.854937175947;9737.318387712863;9751.804963900719;9754.46350450725;9762.463064531448;9625.903740962605;9706.90293097074;9717.46553939533;9727.124558789743;9737.902620973771;8634.61144248504;9599.32804703671;9767;9771.706848794547;9788.90211097887;40512.392314115015;40684.18631627351;40776.59223407787;40806.795966020276;40894.79552602218;3178.300773829754;3217.549543063973;3301.059198128522;3496.4405695088662;3650.4524321351746;28241.435171296664;28386.148415547566;29586.556201656993;29947.550786738215;31382.372352553048;2622.868856557184;2648.549746543073;2721.8230814996964;2762.6408566886375;2837.7446029857206;502419;503021;503443;503599;506581;61077.694611526655;62465.687671561354;71221.93167102497;72067;72983;71535;71611.28388716151;72149;72457.63771181216;72540.63729681424;16646.334146634243;16840;16842.663146736995;16855;16859.747103793452;11660.242084264495;11843.585474508523;11863.228890122115;11878.524859005716;12700.301483418501;22305.99623016968;22943.88528057349;23000.539989200122;23021.539569208857;23029.53940921172;8603.182697643713;8655.740327790176;9199.010321645492;9437.245020398352;9450.52747362629;912.8767616371838;950.3680052764834;971.9854202186973;1092.317301686446;1110.9833352499718;28523.42953140967;28923.56614650782;29009.709902901122;30064.54903176454;31009.224769380948;1029.5881647341123;1041.9322744021615;1055.1084333738133;1123.5955056179769;1140.1448913315014;14323.928380358031;14436.422543098159;14669.413223471154;14725.852741472449;15230.563109902583;648143;649027;652671;654127;655076;58459;58741.41258587359;58848;58941.11588326179;59068.81862362729;1401.927525443037;1420.3537390487304;1438.4461982136743;1442.9062110962543;1444.2778610694652;29275;29911;31185.688143118277;31229.37541249117;31919.882804101744;55333.72333138309;56492;56501.43498564962;56613.15080273882;56628.7168564171;492476;495391;496206.22762634355;496647;497549;34504.30991380108;43364;44367;45456;45480.545194548955;42782.78608606937;45514.77242613766;46501.3024804635;47156.7642161787;47904.2814357778;34846.825765871006;35040.29919401649;35746.28507429889;35872.46191307185;36756.08109797276;30949.535756963214;31287.374252515277;35970.10074748152;36468.480240753815;36906;30633.08100756981;31691.683083168875;34912;36876;37350.626493734715;25697.743022570285;32596.511052334707;32718.50922236121;32725.345493089528;33062.83468582738;24038.63942040836;24419.14532991337;24516.87741561281;24850.751492484844;24925.750742492342 04:57:43 INFO - PROCESS | 2922 | |2;jquery.html;362.7569528415961;368.64794121613846;371.8698455540561;372.0624027450823;378.08880597759406;15480.612984675388;16411;19218.615627687454;20214.494637634067;20793.896030519845;9507.572159252833;11942.940285298562;12044.518219271218;20261.594768104627;20735.481612959647;3958.4062390641348;5166.276721259017;5376.4085950545405;5378.542823859957;5378.731063446831;4114.7119701620895;5759.395263497336;6011.909821352683;6013.669248191348;6018.458338749511;5951.821445356646;6205.441510264075;6539.6730163491875;6540.738370465176;6547.410733034026;5663.235463212455;5913.733881975321;6361.968190159043;6547.312532184147;6548.1814773153355;5616.5787565932715;5627.2684551008515;5630.0991841305195;5631.690257035862;5631.943680563224;13388.665283367896;13426.462941482328;13449.193048417028;13996.510122145675;18918.81081189198;1973.3783858084657;2005.4384772263788;2013.2953466286829;2031.2585906144152;2036.2160568181357;9449.149576538075;9758.90241097587;10187.439690817002;10942.507587158598;14804.055167043565;1660.9501714948572;1765.9823401765946;1766.3641089207874;1779.3079360327372;1791.08654586162;71767.64116179438;100518.49740751322;103000;107856.99999999921;109653.45173274082;11076.058535024453;11407;11414.972652461318;11417.37204453763;11541.307521548566;13512.864871351161;13611.863881361258;13629.454821807214;13646.385912633956;13659.931700341633;8483.321334293365;8507.95746021266;8524.57377131141;8583.48499090044;8610.311175105977;8654.524001179869;8666.826663466696;8673.479591224546;8761.255293300013;8773.341999350074;4095.2833254180996;4207.747535147901;4213.852515161954;4427.180971520214;4495.842645507391;1506.5085565290503;1782.6612943540686;1831.276645724958;1836.4123480486116;1839.494139111755;401.0855250029936;404.51256236235264;414.7780937198584;897.1477096758106;903.3902116071625;11137.832932506019;11749.765004699859;11816.35010074437;16049.197540122947;20460.283890064075;918.8667643191833;949.2424506807735;976.9951150244345;991.9881720644902;1023.8054769593754;10379.079870224034;10707.781353690967;10712.678619641423;10787.772192630957;10954.178436617127;547930;548759;597702;627607;636386;113632.86367136388;116479;120894.39552802179;123476.76523234653;127103.72896271104;975.9024097590326;1018.0379541333517;1036.740814796301;1038.6676263595728;1044.7283706236433;18248.270069197082;18944.715829262295;18988;19003;19008.809911900706;41013.79493102516;45452.86367840831;48977.51022489872;49041.754791225816;49984.50015499944;52161.47838521566;58701;69895;72170.63914680603;73048;7550.8867366990635;7841;7883.921160788319;7911.84176316482;7919.920800792149;11086.667399978014;11451.828222576502;12817.295048772407;12977.805332919825;13121.540746073842;8723.345749068973;10657.413842238751;10800.891991079989;10878.020978112008;11109;10278;10486.213533984828;10774.138068954308;10790.244682872124;10803.513841876977;11249.437528123724;11310.151738619801;11395.601153959571;11400.030997365317;11669.299842009506;6583.30875258091;7711.498752581064;7719.844047583471;7765.92234077652;7833.804154895945;8318.958405208177;10978.231523793258;11020.559177632806;11260.436978151223;11269.422280880848 04:57:43 INFO - PROCESS | 2922 | |3;mootools.html;1529.1818876900857;1561.3832536148225;1780.1989104902798;1887.1979408751276;1922.365619345616;7698.692052317901;7885.842283154333;8463.4075614707;8678.739637810868;8691.174338437846;7769;7896.802579935505;7909.169537198583;8184.549849758261;8409.747707568768;2152.709384233132;2357.528494301138;2434.7686969737847;2473.6165894286414;2497.013679596558;2170.75036370817;2415.3478560788576;2451;2464.2853572463964;2468.1854987853967;2384.5707772600927;2457.778799908008;2458.2870967419426;2461.249318957717;2462.273629279358;2409.4578719788083;2411.650310704938;2422.212780846232;2454.619533972237;2456.2876765737915;2421.4309637235237;2438.890249938757;2441.377448750575;2448.865312407817;2466.9259922202364;8506.404551681384;8572.185642364027;8576.528290943996;8680;8700.34747393948;5347.491988261109;5469.644473109235;5489.3412790465;5497.670139791625;5497.780088796443;3497.8775742849134;3563.1092226943265;3574.267275208602;3653.963460365389;3718.4050551911564;1024.5184763161303;1054.8923630188349;1062.1874266186373;1084.5553323137476;1091.0507858163369;11911.583094591735;11922;11923.582674606434;11932.04543636507;11940.522379104912;4774.870566723983;4789.95210047902;4845.9030819383415;4859.878503037452;4872.634552408584;9985.60057597688;9996.700098997042;10001.649942252132;10034.69895903124;10143.137833284254;5389.83830485086;5395.325584301962;5403.054465468527;5409.080456322435;5409.404965453797;4845.127876982177;4885.828995985124;4892.633052521075;4893.314935908976;4900.093482705711;3636.072801435617;3752;3760.6803421708914;3763.717721170923;3799.164183879542;1116.7989761842946;1127.689885281554;1188.3107797477442;1193.2184419205435;1195.2529668956902;1289.8387701537308;1297.1698113207556;1299.0711641176415;1331.5605850069453;1333.6199183232732;7950.443468957234;8022.157673444321;8040.2361775631225;8057.113717491071;8069.0317161939765;1162.7848847962985;1171.2855158353398;1177.581958404771;1182.320165904591;1189.0606420927543;4838.854834354975;6134.263888333339;6280.811575652738;6282.277538083179;6299.023651334051;10075.244356673278;10636.946815265874;10730.302530335503;10736.677899663022;10736.838947415796;10247.743806404751;10489.160867130611;10597.25819192649;10610.946945265225;10612.25714200014;8234.711785087613;8259.132791056973;8356.874646880302;8359.164083591591;8390.538520381439;7657.34912532441;7829.569373684274;7850.136484986761;7857.960710196412;7965.880511792444;9316.673916412892;9337.873477547735;9474.857877131986;9489.383190092622;9596.90403095988;9625.951870240884;10001.199904007808;10002.299839011199;10042.849357259793;10052.296339256474;7053.612051337021;7448.590327532038;7554.093508778762;7571.167171611009;7575.280348366897;8021.8395632088195;8061.39539534549;8112.18878112184;8117.756467305991;8118.066422361504;6015.638661970037;7132.714691412285;7223.386012188813;7359.080114985627;7373.520721153108;5842.123681447647;7116;7141.928580714126;7149.7497587584185;7181.892271616034;6296.968515157395;7579.696812127674;7583.734569290048;7584.08990921093;7605.771826845204;6898.896516552356;6926.272741362084;6926.9307306926285;6938.306169383021;6943.618101004493;6922.688479018356;6966.268541803241;7082.681279342339;7097.325754053357;7102.964485177541 04:57:43 INFO - PROCESS | 2922 | |4;prototype.html;318.33626887938647;321.7442133503864;327.76073466369564;328.0290340591848;332.40831320249947;6405.103285540028;6415.326390728977;6475.061116138158;6483.254425741035;6483.416492515673;6029.366916473773;6211.813645590628;6237.189165408502;6243.313235544098;6383.2978372379;3444.8966531003985;4275.35869619558;4674.953250467503;4699.248120300753;4753.429588449391;3773.415120656303;4684.953150468486;4702;4709.222978208609;4743.549362810528;4652.836790802299;4693.671442998992;4702.435707715079;4704.647151463637;4717.834875779348;4545.886352841172;4680.602148817355;4688.906221875561;4705.435347758291;4713.787879545429;4013.25754735372;4027.8791636250958;4028.617281358266;4029.53660329063;4032.395140728914;6127.662978536178;6130.29501607312;6132.6933653317155;6137.846553836145;6149.600275982047;5225.268462415265;5409.43200963901;5414.377346605112;5420.34955805302;5424.864378390533;5842.941570584282;6767.763128290536;6774.220964589086;6778.423833974118;6788.76239331621;4422.601965823059;4434.246178149722;4434.49003364614;4435.356873253392;4445.466544014706;7029;7041.823954401181;7136.500444968854;7147.749828755968;7151.606661633608;3766.548014238309;4317.546657600907;4512.503624601291;4513.616342610915;4517.841875534341;4594.517575654575;4603.631709463302;4606.56237657422;4608.539146085364;4612.815487380534;5417;5446.2375267462585;5451.591130665216;5452.700101494456;5457.181422786613;6558.147440832661;6835.179778426621;6847.144106986627;6853.314668533207;6866.725330986805;1347.786991707471;1605.4862444017801;1617.7249867522548;1617.7896873406382;1622.294301978643;958.5590628310915;994.5325696922434;1008.85371621116;1045.210865796319;1045.968620941373;6245.094461303176;6429.38920802523;6448.161738973903;6574.737010519621;6591.274959754423;7267.745628902963;7269.963650181715;7285.817854553573;7285.854282914312;7289.307515785992;6314.810555683337;6515.967420162869;6535.803925882231;6553.344665533408;6559.934400655932;3772.000419888732;3824;3827.9617203827606;3828.349180639298;3828.674562662149;7548.358389536951;7577.848443031108;7588.317051465395;7590.962045189739;7603.0876294844975;7287.307705767944;7443.292887175709;7495.737649182362;7519.360854327334;7540.547567145989;7592.8481430372185;7595.202503737028;7621.275978782229;7630.923690763021;7635.541867487968;7275.017872587345;7285.672144753393;7289.5261807982315;7294.869295259244;7302.050733404623;6726.596404215763;6919.619420931897;6931.029655848084;6932.896006560007;6971.686274117778;5981.342052374148;7423.072115985502;7425.8143546411775;7430.653067955307;7444.367228785614;4494.8876278092;4561.654311978041;4564.520725323793;4569.451665800125;4587.0596527712405;6826.761063362758;7117.537360071578;7117.9678946553495;7122.964385178041;7127.10911136108;6871.828204294932;6879.518433709793;6882.8967565485555;6884.070650462324;6884.48366372514;6684.598924064571;6766.695498702472;6863.142107236596;6869.862602748017;6870.62211578368;5412.161115027177;6436.517261205335;6717.764878229238;6733.797986060426;6737.69680364375;6736.6968486417245;6777.220619628609;6781.966090169715;6782.457403407617;6798.898016529855;6569.605823650596;6734.831629209309;6735.865282694416;6748.93251067483;6755.628440435823 04:57:43 INFO - PROCESS | 2922 | |5;yui.html;686.3994005245411;721.0626185958255;732.7948174511139;745.8396444764376;753.4612751882403;12768.936155319221;17169.399071032516;17539.2107355169;17568.472945811613;17592.47222583323;15715.371385144581;15718.056916585012;15731.92134039331;15740;15871.841281587209;697.9336962988508;704.9989015597863;850.0479463001448;879.9472031678088;885.5926273913975;861.7156338408341;863.5293764898114;876.5617191404298;877.2411863737852;878.0999475537561;911.803962148138;926.106307413346;926.4256161180077;927.2581934452445;929.3355250995537;732.8570928668912;738.1732459645178;901.9729408117702;906.8231694819513;917.5183028909876;674.5952428542835;678.22343416788;681.6046692918096;682.3142741544765;684.6610927590824;15010.099394036393;15067.472638457712;15070.623234419227;15078.924605376902;15111.39554417822;12107.818382724266;12579.811302830465;12708.936455317664;12906.741865162738;13043.086983911035;8269.83460330796;10540.314879532882;11015.944920275348;11196.944015279953;11210.66368008961;4027.6363345913387;4034.4755181826467;4056.432099506042;4060.248853961997;4068.7965601719798;67337.31656708622;73947.26052739458;83725;83742;83944.58027709823;9520.143187113194;9553.665621703207;9685.515724213761;9726.610935562498;9896.307258491837;20423.591528169352;20546.69179962272;20578.794212057986;20600.793992060186;20627.4843128923;6176.320604733476;7459.776206713807;7493.70025198986;7587.241275872479;7628.427867909929;3936.173403585222;3960.683145348365;4034.8991275218355;4040.1717647882115;4053.250148722496;3515.6835884770494;3564.7861128332383;3566.6789988901123;3566.964330356715;3572.4284114541547;636.8758092171983;648.9221293444817;652.9216494020748;658.3285049249835;683.7777722240291;569.6610516742531;583.1981026089128;625.7622103600694;626.7806267806232;636.0491065856575;8279.296259817984;8546.444481108709;8595.185821718436;8712.433691810013;8908.420952638058;449.7369039112091;592.3661682000304;593.5103539579864;603.3544107804607;615.4061330815784;3580.3913334733156;3620.7465477416854;4037.0916543778003;4068.3083875741195;4115.300398932189;84229.15770842214;85640.57179714061;86776;86854.56572717096;86963;74161;74547;74920.62539687267;74930;74998.8750168748;65474.34525654778;66204;66337.6683116591;66674;66753.99999999903;8100.797480063045;8155.735860941563;8215.465994710325;8334.291585215324;8415.621297041771;46245;46551.30173047475;46608;46633.76683116562;46814.29778553393;51233;63493.682531587045;65971.68056638936;66454;68433.65783171052;8815.250703690002;10572.259941803999;10611.522481488197;10944.835827462435;11188.104951604015;11944.880551194377;12371.814422783846;12403.503859845867;12931.482740690268;12938.741225175632;10218.744531386477;11498.425078746197;11612.245204061708;11615.186936914335;11667.766644667228;11417.657470275904;11572.94213528927;11605.245659032136;11723.944844963995;12513.374331283581;11514.942425288154;11652.174777650001;11729.648110556696;11737.41312934367;12387.75224495523;8014.83970320602;9548.474833884204;9581.904180958101;9678.56446459925;10634.296801153987;7834;9189.172974432333;9357.438553686801;9562.95218523903;9688.46713430768 04:57:43 INFO - PROCESS | 2922 | __end_tp_report 04:57:43 INFO - PROCESS | 2922 | __start_cc_report 04:57:43 INFO - PROCESS | 2922 | _x_x_mozilla_cycle_collect,1104 04:57:43 INFO - PROCESS | 2922 | __end_cc_report 04:57:43 INFO - PROCESS | 2922 | __startTimestamp1455886663712__endTimestamp 04:57:43 INFO - PROCESS | 2922 | 04:57:43 INFO - PROCESS | 2922 | ------- Summary: start ------- 04:57:43 INFO - PROCESS | 2922 | Number of tests: 6 04:57:43 INFO - PROCESS | 2922 | 04:57:43 INFO - PROCESS | 2922 | [#0] dojo.html Cycles:165 Average:5700.43 Median:5898.71 stddev:644.12 (10.9%) stddev-sans-first:618.39 04:57:43 INFO - PROCESS | 2922 | Values: 3318.3 3394.6 3425.2 3441.4 3451.4 5558.7 5614.3 5615.0 5619.7 5663.5 5601.1 5670.1 5674.9 5682.2 5687.1 5146.1 5169.8 5197.4 5197.6 5243.4 5256.3 5258.8 5261.0 5269.8 5274.2 5181.5 5219.0 5233.4 5241.6 5246.0 5197.4 5238.0 5238.7 5246.9 5275.1 5100.8 5146.1 5162.2 5165.4 5180.8 5613.2 5615.4 5623.9 5634.5 5649.7 6221.9 6235.4 6239.4 6246.3 6249.5 6123.3 6177.0 6244.6 6248.0 6274.9 5744.9 5761.5 5763.7 5767.1 5768.7 5320.7 6200.2 6224.3 6285.3 6319.7 6003.3 6089.3 6096.2 6102.5 6105.7 6210.9 6254.0 6254.5 6256.6 6268.6 6062.5 6140.4 6141.1 6161.0 6200.4 6195.2 6204.8 6219.2 6231.3 6246.8 3833.8 4783.0 4891.3 4891.7 4912.9 4333.5 4362.5 4363.7 4368.5 4410.1 5602.5 5613.7 5623.7 5624.2 5652.3 5246.4 6126.8 6199.0 6223.8 6274.7 5579.4 5622.9 5627.7 5636.5 5651.6 5324.5 5330.7 5351.9 5352.9 5355.8 6207.8 6228.8 6300.1 6302.3 6329.1 6278.2 6290.5 6300.6 6301.1 6314.0 6279.9 6293.7 6298.5 6308.2 6309.2 6055.5 6105.9 6114.9 6129.2 6208.9 6236.4 6247.3 6257.1 6277.9 6300.7 5898.7 6059.5 6059.5 6060.6 6074.3 5908.6 6001.0 6012.5 6075.2 6110.3 5877.6 5878.0 5881.9 5883.2 5915.4 5952.3 6063.6 6068.0 6087.3 6118.1 5749.9 5899.2 5900.8 5912.4 5912.8 04:57:43 INFO - PROCESS | 2922 | 04:57:43 INFO - PROCESS | 2922 | [#1] ext.html Cycles:180 Average:69367.39 Median:40791.69 stddev:148166.95 (363.2%) stddev-sans-first:148492.29 04:57:43 INFO - PROCESS | 2922 | Values: 465.3 505.9 521.9 548.8 565.7 29863.4 37827.0 38196.0 38430.6 38535.2 40965.8 41347.6 41445.6 41485.0 41526.4 9406.2 9646.5 9649.7 9653.4 9656.0 9427.7 9555.5 9586.9 9592.8 9661.6 9670.9 9737.3 9751.8 9754.5 9762.5 9625.9 9706.9 9717.5 9727.1 9737.9 8634.6 9599.3 9767.0 9771.7 9788.9 40512.4 40684.2 40776.6 40806.8 40894.8 3178.3 3217.5 3301.1 3496.4 3650.5 28241.4 28386.1 29586.6 29947.6 31382.4 2622.9 2648.5 2721.8 2762.6 2837.7 502419.0 503021.0 503443.0 503599.0 506581.0 61077.7 62465.7 71221.9 72067.0 72983.0 71535.0 71611.3 72149.0 72457.6 72540.6 16646.3 16840.0 16842.7 16855.0 16859.7 11660.2 11843.6 11863.2 11878.5 12700.3 22306.0 22943.9 23000.5 23021.5 23029.5 8603.2 8655.7 9199.0 9437.2 9450.5 912.9 950.4 972.0 1092.3 1111.0 28523.4 28923.6 29009.7 30064.5 31009.2 1029.6 1041.9 1055.1 1123.6 1140.1 14323.9 14436.4 14669.4 14725.9 15230.6 648143.0 649027.0 652671.0 654127.0 655076.0 58459.0 58741.4 58848.0 58941.1 59068.8 1401.9 1420.4 1438.4 1442.9 1444.3 29275.0 29911.0 31185.7 31229.4 31919.9 55333.7 56492.0 56501.4 56613.2 56628.7 492476.0 495391.0 496206.2 496647.0 497549.0 34504.3 43364.0 44367.0 45456.0 45480.5 42782.8 45514.8 46501.3 47156.8 47904.3 34846.8 35040.3 35746.3 35872.5 36756.1 30949.5 31287.4 35970.1 36468.5 36906.0 30633.1 31691.7 34912.0 36876.0 37350.6 25697.7 32596.5 32718.5 32725.3 33062.8 24038.6 24419.1 24516.9 24850.8 24925.8 04:57:43 INFO - PROCESS | 2922 | 04:57:43 INFO - PROCESS | 2922 | [#2] jquery.html Cycles:180 Average:32775.79 Median:11248.25 stddev:98419.52 (875.0%) stddev-sans-first:98665.52 04:57:43 INFO - PROCESS | 2922 | Values: 362.8 368.6 371.9 372.1 378.1 15480.6 16411.0 19218.6 20214.5 20793.9 9507.6 11942.9 12044.5 20261.6 20735.5 3958.4 5166.3 5376.4 5378.5 5378.7 4114.7 5759.4 6011.9 6013.7 6018.5 5951.8 6205.4 6539.7 6540.7 6547.4 5663.2 5913.7 6362.0 6547.3 6548.2 5616.6 5627.3 5630.1 5631.7 5631.9 13388.7 13426.5 13449.2 13996.5 18918.8 1973.4 2005.4 2013.3 2031.3 2036.2 9449.1 9758.9 10187.4 10942.5 14804.1 1661.0 1766.0 1766.4 1779.3 1791.1 71767.6 100518.5 103000.0 107857.0 109653.5 11076.1 11407.0 11415.0 11417.4 11541.3 13512.9 13611.9 13629.5 13646.4 13659.9 8483.3 8508.0 8524.6 8583.5 8610.3 8654.5 8666.8 8673.5 8761.3 8773.3 4095.3 4207.7 4213.9 4427.2 4495.8 1506.5 1782.7 1831.3 1836.4 1839.5 401.1 404.5 414.8 897.1 903.4 11137.8 11749.8 11816.4 16049.2 20460.3 918.9 949.2 977.0 992.0 1023.8 10379.1 10707.8 10712.7 10787.8 10954.2 547930.0 548759.0 597702.0 627607.0 636386.0 113632.9 116479.0 120894.4 123476.8 127103.7 975.9 1018.0 1036.7 1038.7 1044.7 18248.3 18944.7 18988.0 19003.0 19008.8 41013.8 45452.9 48977.5 49041.8 49984.5 52161.5 58701.0 69895.0 72170.6 73048.0 7550.9 7841.0 7883.9 7911.8 7919.9 11086.7 11451.8 12817.3 12977.8 13121.5 8723.3 10657.4 10800.9 10878.0 11109.0 10278.0 10486.2 10774.1 10790.2 10803.5 11249.4 11310.2 11395.6 11400.0 11669.3 6583.3 7711.5 7719.8 7765.9 7833.8 8319.0 10978.2 11020.6 11260.4 11269.4 04:57:43 INFO - PROCESS | 2922 | 04:57:43 INFO - PROCESS | 2922 | [#3] mootools.html Cycles:180 Average:5963.95 Median:4892.97 stddev:3136.10 (64.1%) stddev-sans-first:3127.19 04:57:43 INFO - PROCESS | 2922 | Values: 1529.2 1561.4 1780.2 1887.2 1922.4 7698.7 7885.8 8463.4 8678.7 8691.2 7769.0 7896.8 7909.2 8184.5 8409.7 2152.7 2357.5 2434.8 2473.6 2497.0 2170.8 2415.3 2451.0 2464.3 2468.2 2384.6 2457.8 2458.3 2461.2 2462.3 2409.5 2411.7 2422.2 2454.6 2456.3 2421.4 2438.9 2441.4 2448.9 2466.9 8506.4 8572.2 8576.5 8680.0 8700.3 5347.5 5469.6 5489.3 5497.7 5497.8 3497.9 3563.1 3574.3 3654.0 3718.4 1024.5 1054.9 1062.2 1084.6 1091.1 11911.6 11922.0 11923.6 11932.0 11940.5 4774.9 4790.0 4845.9 4859.9 4872.6 9985.6 9996.7 10001.6 10034.7 10143.1 5389.8 5395.3 5403.1 5409.1 5409.4 4845.1 4885.8 4892.6 4893.3 4900.1 3636.1 3752.0 3760.7 3763.7 3799.2 1116.8 1127.7 1188.3 1193.2 1195.3 1289.8 1297.2 1299.1 1331.6 1333.6 7950.4 8022.2 8040.2 8057.1 8069.0 1162.8 1171.3 1177.6 1182.3 1189.1 4838.9 6134.3 6280.8 6282.3 6299.0 10075.2 10636.9 10730.3 10736.7 10736.8 10247.7 10489.2 10597.3 10610.9 10612.3 8234.7 8259.1 8356.9 8359.2 8390.5 7657.3 7829.6 7850.1 7858.0 7965.9 9316.7 9337.9 9474.9 9489.4 9596.9 9626.0 10001.2 10002.3 10042.8 10052.3 7053.6 7448.6 7554.1 7571.2 7575.3 8021.8 8061.4 8112.2 8117.8 8118.1 6015.6 7132.7 7223.4 7359.1 7373.5 5842.1 7116.0 7141.9 7149.7 7181.9 6297.0 7579.7 7583.7 7584.1 7605.8 6898.9 6926.3 6926.9 6938.3 6943.6 6922.7 6966.3 7082.7 7097.3 7103.0 04:57:43 INFO - PROCESS | 2922 | 04:57:43 INFO - PROCESS | 2922 | [#4] prototype.html Cycles:180 Average:5608.12 Median:6432.95 stddev:1822.72 (28.3%) stddev-sans-first:1784.06 04:57:43 INFO - PROCESS | 2922 | Values: 318.3 321.7 327.8 328.0 332.4 6405.1 6415.3 6475.1 6483.3 6483.4 6029.4 6211.8 6237.2 6243.3 6383.3 3444.9 4275.4 4675.0 4699.2 4753.4 3773.4 4685.0 4702.0 4709.2 4743.5 4652.8 4693.7 4702.4 4704.6 4717.8 4545.9 4680.6 4688.9 4705.4 4713.8 4013.3 4027.9 4028.6 4029.5 4032.4 6127.7 6130.3 6132.7 6137.8 6149.6 5225.3 5409.4 5414.4 5420.3 5424.9 5842.9 6767.8 6774.2 6778.4 6788.8 4422.6 4434.2 4434.5 4435.4 4445.5 7029.0 7041.8 7136.5 7147.7 7151.6 3766.5 4317.5 4512.5 4513.6 4517.8 4594.5 4603.6 4606.6 4608.5 4612.8 5417.0 5446.2 5451.6 5452.7 5457.2 6558.1 6835.2 6847.1 6853.3 6866.7 1347.8 1605.5 1617.7 1617.8 1622.3 958.6 994.5 1008.9 1045.2 1046.0 6245.1 6429.4 6448.2 6574.7 6591.3 7267.7 7270.0 7285.8 7285.9 7289.3 6314.8 6516.0 6535.8 6553.3 6559.9 3772.0 3824.0 3828.0 3828.3 3828.7 7548.4 7577.8 7588.3 7591.0 7603.1 7287.3 7443.3 7495.7 7519.4 7540.5 7592.8 7595.2 7621.3 7630.9 7635.5 7275.0 7285.7 7289.5 7294.9 7302.1 6726.6 6919.6 6931.0 6932.9 6971.7 5981.3 7423.1 7425.8 7430.7 7444.4 4494.9 4561.7 4564.5 4569.5 4587.1 6826.8 7117.5 7118.0 7123.0 7127.1 6871.8 6879.5 6882.9 6884.1 6884.5 6684.6 6766.7 6863.1 6869.9 6870.6 5412.2 6436.5 6717.8 6733.8 6737.7 6736.7 6777.2 6782.0 6782.5 6798.9 6569.6 6734.8 6735.9 6748.9 6755.6 04:57:43 INFO - PROCESS | 2922 | 04:57:43 INFO - PROCESS | 2922 | [#5] yui.html Cycles:180 Average:17743.75 Median:32064.87 stddev:24281.28 (75.7%) stddev-sans-first:24315.62 04:57:43 INFO - PROCESS | 2922 | Values: 686.4 721.1 732.8 745.8 753.5 12768.9 17169.4 17539.2 17568.5 17592.5 15715.4 15718.1 15731.9 15740.0 15871.8 697.9 705.0 850.0 879.9 885.6 861.7 863.5 876.6 877.2 878.1 911.8 926.1 926.4 927.3 929.3 732.9 738.2 902.0 906.8 917.5 674.6 678.2 681.6 682.3 684.7 15010.1 15067.5 15070.6 15078.9 15111.4 12107.8 12579.8 12708.9 12906.7 13043.1 8269.8 10540.3 11015.9 11196.9 11210.7 4027.6 4034.5 4056.4 4060.2 4068.8 67337.3 73947.3 83725.0 83742.0 83944.6 9520.1 9553.7 9685.5 9726.6 9896.3 20423.6 20546.7 20578.8 20600.8 20627.5 6176.3 7459.8 7493.7 7587.2 7628.4 3936.2 3960.7 4034.9 4040.2 4053.3 3515.7 3564.8 3566.7 3567.0 3572.4 636.9 648.9 652.9 658.3 683.8 569.7 583.2 625.8 626.8 636.0 8279.3 8546.4 8595.2 8712.4 8908.4 449.7 592.4 593.5 603.4 615.4 3580.4 3620.7 4037.1 4068.3 4115.3 84229.2 85640.6 86776.0 86854.6 86963.0 74161.0 74547.0 74920.6 74930.0 74998.9 65474.3 66204.0 66337.7 66674.0 66754.0 8100.8 8155.7 8215.5 8334.3 8415.6 46245.0 46551.3 46608.0 46633.8 46814.3 51233.0 63493.7 65971.7 66454.0 68433.7 8815.3 10572.3 10611.5 10944.8 11188.1 11944.9 12371.8 12403.5 12931.5 12938.7 10218.7 11498.4 11612.2 11615.2 11667.8 11417.7 11572.9 11605.2 11723.9 12513.4 11514.9 11652.2 11729.6 11737.4 12387.8 8014.8 9548.5 9581.9 9678.6 10634.3 7834.0 9189.2 9357.4 9563.0 9688.5 04:57:43 INFO - PROCESS | 2922 | -------- Summary: end -------- 04:57:43 INFO - PROCESS | 2922 | 04:57:44 INFO - TEST-INFO | 2922: exit 0 04:57:44 INFO - TEST-OK | dromaeo_css | took 1113817ms 04:57:44 INFO - TEST-START | kraken 04:57:44 INFO - operating with platform_type : mac_ 04:57:44 INFO - Initialising browser for kraken test... 04:57:44 INFO - TEST-INFO | started process 2928 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/tmpnXi4JX/profile http://localhost:50436/getInfo.html) 04:57:46 INFO - PROCESS | 2928 | __metrics Screen width/height:1600/1200 04:57:46 INFO - PROCESS | 2928 | colorDepth:24 04:57:46 INFO - PROCESS | 2928 | Browser inner width/height: 1024/689 04:57:46 INFO - PROCESS | 2928 | __metrics 04:57:46 INFO - PROCESS | 2928 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:57:46 INFO - PROCESS | 2928 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:57:47 INFO - TEST-INFO | 2928: exit 0 04:57:47 INFO - Browser initialized. 04:57:47 INFO - Running cycle 1/1 for kraken test... 04:57:47 INFO - TEST-INFO | started process 2930 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/tmpnXi4JX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:57:59 INFO - PROCESS | 2930 | RSS: Main: 242749440 04:57:59 INFO - PROCESS | 2930 | 04:58:01 INFO - PROCESS | 2930 | Cycle 1(1): loaded http://localhost:50436/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50436/tests/kraken/driver.html?testName=audio-beat-detection) 04:58:02 INFO - PROCESS | 2930 | RSS: Main: 291364864 04:58:02 INFO - PROCESS | 2930 | 04:58:05 INFO - PROCESS | 2930 | Cycle 1(1): loaded http://localhost:50436/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50436/tests/kraken/driver.html?testName=audio-dft) 04:58:05 INFO - PROCESS | 2930 | RSS: Main: 300421120 04:58:05 INFO - PROCESS | 2930 | 04:58:09 INFO - PROCESS | 2930 | Cycle 1(1): loaded http://localhost:50436/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50436/tests/kraken/driver.html?testName=audio-fft) 04:58:09 INFO - PROCESS | 2930 | RSS: Main: 284581888 04:58:09 INFO - PROCESS | 2930 | 04:58:11 INFO - PROCESS | 2930 | Cycle 1(1): loaded http://localhost:50436/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50436/tests/kraken/driver.html?testName=audio-oscillator) 04:58:12 INFO - PROCESS | 2930 | RSS: Main: 288473088 04:58:12 INFO - PROCESS | 2930 | 04:58:14 INFO - PROCESS | 2930 | Cycle 1(1): loaded http://localhost:50436/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50436/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:58:15 INFO - PROCESS | 2930 | RSS: Main: 289640448 04:58:15 INFO - PROCESS | 2930 | 04:58:17 INFO - PROCESS | 2930 | Cycle 1(1): loaded http://localhost:50436/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50436/tests/kraken/driver.html?testName=imaging-darkroom) 04:58:18 INFO - PROCESS | 2930 | RSS: Main: 288522240 04:58:18 INFO - PROCESS | 2930 | 04:58:21 INFO - PROCESS | 2930 | Cycle 1(1): loaded http://localhost:50436/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50436/tests/kraken/driver.html?testName=imaging-desaturate) 04:58:21 INFO - PROCESS | 2930 | RSS: Main: 289742848 04:58:21 INFO - PROCESS | 2930 | 04:58:24 INFO - PROCESS | 2930 | Cycle 1(1): loaded http://localhost:50436/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50436/tests/kraken/driver.html?testName=json-parse-financial) 04:58:25 INFO - PROCESS | 2930 | RSS: Main: 290779136 04:58:25 INFO - PROCESS | 2930 | 04:58:26 INFO - PROCESS | 2930 | Cycle 1(1): loaded http://localhost:50436/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50436/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:58:27 INFO - PROCESS | 2930 | RSS: Main: 325103616 04:58:27 INFO - PROCESS | 2930 | 04:58:29 INFO - PROCESS | 2930 | Cycle 1(1): loaded http://localhost:50436/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50436/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:58:29 INFO - PROCESS | 2930 | RSS: Main: 323936256 04:58:29 INFO - PROCESS | 2930 | 04:58:31 INFO - PROCESS | 2930 | Cycle 1(1): loaded http://localhost:50436/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50436/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:58:32 INFO - PROCESS | 2930 | RSS: Main: 332492800 04:58:32 INFO - PROCESS | 2930 | 04:58:34 INFO - PROCESS | 2930 | Cycle 1(1): loaded http://localhost:50436/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50436/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:58:35 INFO - PROCESS | 2930 | RSS: Main: 332808192 04:58:35 INFO - PROCESS | 2930 | 04:58:38 INFO - PROCESS | 2930 | Cycle 1(1): loaded http://localhost:50436/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50436/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:58:38 INFO - PROCESS | 2930 | RSS: Main: 332353536 04:58:38 INFO - PROCESS | 2930 | 04:58:40 INFO - PROCESS | 2930 | Cycle 1(1): loaded http://localhost:50436/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50436/tests/kraken/driver.html?testName=ai-astar) 04:58:40 INFO - PROCESS | 2930 | RSS: Main: 392855552 04:58:40 INFO - PROCESS | 2930 | 04:58:40 INFO - PROCESS | 2930 | __start_tp_report 04:58:40 INFO - PROCESS | 2930 | _x_x_mozilla_page_load 04:58:40 INFO - PROCESS | 2930 | _x_x_mozilla_page_load_details 04:58:40 INFO - PROCESS | 2930 | |i|pagename|runs| 04:58:40 INFO - PROCESS | 2930 | |0;ai-astar;112;106;112;110;111;112;115;111;111;109 04:58:40 INFO - PROCESS | 2930 | |1;audio-beat-detection;160;121;147;160;121;144;143;119;162;132 04:58:40 INFO - PROCESS | 2930 | |2;audio-dft;192;258;219;182;186;185;184;183;179;184 04:58:40 INFO - PROCESS | 2930 | |3;audio-fft;78;76;85;79;55;58;58;82;81;65 04:58:40 INFO - PROCESS | 2930 | |4;audio-oscillator;92;94;126;85;98;130;140;79;80;112 04:58:40 INFO - PROCESS | 2930 | |5;imaging-gaussian-blur;84;90;123;140;85;90;83;91;84;91 04:58:40 INFO - PROCESS | 2930 | |6;imaging-darkroom;94;94;94;94;94;93;94;93;94;94 04:58:40 INFO - PROCESS | 2930 | |7;imaging-desaturate;85;95;126;86;81;85;93;84;87;84 04:58:40 INFO - PROCESS | 2930 | |8;json-parse-financial;55;55;54;53;53;53;53;64;51;53 04:58:40 INFO - PROCESS | 2930 | |9;json-stringify-tinderbox;63;62;78;74;70;68;68;68;69;70 04:58:40 INFO - PROCESS | 2930 | |10;stanford-crypto-aes;84;84;82;83;83;83;81;81;84;83 04:58:40 INFO - PROCESS | 2930 | |11;stanford-crypto-ccm;124;125;126;124;121;123;125;122;123;126 04:58:40 INFO - PROCESS | 2930 | |12;stanford-crypto-pbkdf2;141;128;140;137;140;126;139;138;138;136 04:58:40 INFO - PROCESS | 2930 | |13;stanford-crypto-sha256-iterative;66;66;65;68;67;67;67;67;67;66 04:58:40 INFO - PROCESS | 2930 | __end_tp_report 04:58:40 INFO - PROCESS | 2930 | __start_cc_report 04:58:40 INFO - PROCESS | 2930 | _x_x_mozilla_cycle_collect,1185 04:58:40 INFO - PROCESS | 2930 | __end_cc_report 04:58:40 INFO - PROCESS | 2930 | __startTimestamp1455886720563__endTimestamp 04:58:40 INFO - PROCESS | 2930 | 04:58:40 INFO - PROCESS | 2930 | ------- Summary: start ------- 04:58:40 INFO - PROCESS | 2930 | Number of tests: 14 04:58:40 INFO - PROCESS | 2930 | 04:58:40 INFO - PROCESS | 2930 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.50 stddev:2.33 (2.1%) stddev-sans-first:2.44 04:58:40 INFO - PROCESS | 2930 | Values: 112.0 106.0 112.0 110.0 111.0 112.0 115.0 111.0 111.0 109.0 04:58:40 INFO - PROCESS | 2930 | 04:58:40 INFO - PROCESS | 2930 | [#1] audio-beat-detection Cycles:10 Average:140.90 Median:145.50 stddev:16.92 (11.6%) stddev-sans-first:16.48 04:58:40 INFO - PROCESS | 2930 | Values: 160.0 121.0 147.0 160.0 121.0 144.0 143.0 119.0 162.0 132.0 04:58:40 INFO - PROCESS | 2930 | 04:58:40 INFO - PROCESS | 2930 | [#2] audio-dft Cycles:10 Average:195.20 Median:185.50 stddev:24.82 (13.4%) stddev-sans-first:26.30 04:58:40 INFO - PROCESS | 2930 | Values: 192.0 258.0 219.0 182.0 186.0 185.0 184.0 183.0 179.0 184.0 04:58:40 INFO - PROCESS | 2930 | 04:58:40 INFO - PROCESS | 2930 | [#3] audio-fft Cycles:10 Average:71.70 Median:78.50 stddev:11.45 (14.6%) stddev-sans-first:11.92 04:58:40 INFO - PROCESS | 2930 | Values: 78.0 76.0 85.0 79.0 55.0 58.0 58.0 82.0 81.0 65.0 04:58:40 INFO - PROCESS | 2930 | 04:58:40 INFO - PROCESS | 2930 | [#4] audio-oscillator Cycles:10 Average:103.60 Median:82.50 stddev:22.01 (26.7%) stddev-sans-first:22.94 04:58:40 INFO - PROCESS | 2930 | Values: 92.0 94.0 126.0 85.0 98.0 130.0 140.0 79.0 80.0 112.0 04:58:40 INFO - PROCESS | 2930 | 04:58:40 INFO - PROCESS | 2930 | [#5] imaging-gaussian-blur Cycles:10 Average:96.10 Median:87.50 stddev:19.34 (22.1%) stddev-sans-first:20.01 04:58:40 INFO - PROCESS | 2930 | Values: 84.0 90.0 123.0 140.0 85.0 90.0 83.0 91.0 84.0 91.0 04:58:40 INFO - PROCESS | 2930 | 04:58:40 INFO - PROCESS | 2930 | [#6] imaging-darkroom Cycles:10 Average:93.80 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:58:40 INFO - PROCESS | 2930 | Values: 94.0 94.0 94.0 94.0 94.0 93.0 94.0 93.0 94.0 94.0 04:58:40 INFO - PROCESS | 2930 | 04:58:40 INFO - PROCESS | 2930 | [#7] imaging-desaturate Cycles:10 Average:90.60 Median:85.50 stddev:13.14 (15.4%) stddev-sans-first:13.78 04:58:40 INFO - PROCESS | 2930 | Values: 85.0 95.0 126.0 86.0 81.0 85.0 93.0 84.0 87.0 84.0 04:58:40 INFO - PROCESS | 2930 | 04:58:40 INFO - PROCESS | 2930 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:53.50 stddev:3.57 (6.7%) stddev-sans-first:3.77 04:58:40 INFO - PROCESS | 2930 | Values: 55.0 55.0 54.0 53.0 53.0 53.0 53.0 64.0 51.0 53.0 04:58:40 INFO - PROCESS | 2930 | 04:58:40 INFO - PROCESS | 2930 | [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:69.50 stddev:4.67 (6.7%) stddev-sans-first:4.42 04:58:40 INFO - PROCESS | 2930 | Values: 63.0 62.0 78.0 74.0 70.0 68.0 68.0 68.0 69.0 70.0 04:58:40 INFO - PROCESS | 2930 | 04:58:40 INFO - PROCESS | 2930 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:83.00 stddev:1.14 (1.4%) stddev-sans-first:1.12 04:58:40 INFO - PROCESS | 2930 | Values: 84.0 84.0 82.0 83.0 83.0 83.0 81.0 81.0 84.0 83.0 04:58:40 INFO - PROCESS | 2930 | 04:58:40 INFO - PROCESS | 2930 | [#11] stanford-crypto-ccm Cycles:10 Average:123.90 Median:124.50 stddev:1.66 (1.3%) stddev-sans-first:1.76 04:58:40 INFO - PROCESS | 2930 | Values: 124.0 125.0 126.0 124.0 121.0 123.0 125.0 122.0 123.0 126.0 04:58:40 INFO - PROCESS | 2930 | 04:58:40 INFO - PROCESS | 2930 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.30 Median:138.50 stddev:5.14 (3.7%) stddev-sans-first:5.17 04:58:40 INFO - PROCESS | 2930 | Values: 141.0 128.0 140.0 137.0 140.0 126.0 139.0 138.0 138.0 136.0 04:58:40 INFO - PROCESS | 2930 | 04:58:40 INFO - PROCESS | 2930 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:0.84 (1.3%) stddev-sans-first:0.87 04:58:40 INFO - PROCESS | 2930 | Values: 66.0 66.0 65.0 68.0 67.0 67.0 67.0 67.0 67.0 66.0 04:58:40 INFO - PROCESS | 2930 | -------- Summary: end -------- 04:58:40 INFO - PROCESS | 2930 | 04:58:41 INFO - TEST-INFO | 2930: exit 0 04:58:41 INFO - TEST-OK | kraken | took 57190ms 04:58:41 INFO - SUITE-END | took 1171s 04:58:41 INFO - Completed test suite (00:19:31) 04:58:41 INFO - Working with test: dromaeo_css 04:58:41 INFO - Generating results file: dromaeo_css 04:58:41 INFO - Working with test: kraken 04:58:41 INFO - Generating results file: kraken 04:58:41 INFO - javascript benchmark 04:58:41 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:58:41 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 04:58:41 INFO - process_Request line: dromaeo_css 7436.85 graph.html#tests=[[72,64,59]] 04:58:41 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:58:41 INFO - process_Request line: kraken 1435.80 graph.html#tests=[[232,64,59]] 04:58:41 INFO - RETURN: dromaeo_css: 7436.85 04:58:41 INFO - RETURN: kraken: 1435.80 04:58:41 INFO - javascript benchmark 04:58:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3318.2533929865785, 3394.5587073680435, 3425.246445781928, 3441.3977553928057, 3451.3787518246704, 5558.666480011202, 5614.29821272341, 5615.0, 5619.662820230784, 5663.490285874271, 5601.131824567188, 5670.0927851543765, 5674.886502269963, 5682.17608446775, 5687.118496633018, 5146.125158723026, 5169.767360468769, 5197.376314842224, 5197.558207552363, 5243.449437809032, 5256.342957130359, 5258.763355648985, 5261.0267100586325, 5269.8155564555245, 5274.235235890794, 5181.481851814826, 5219.0, 5233.4243233244315, 5241.606879484035, 5245.973770131144, 5197.35033120858, 5237.973810130963, 5238.659487133325, 5246.921296180561, 5275.076861549252, 5100.770465329069, 5146.125158722989, 5162.174052151638, 5165.354330708661, 5180.818671346485, 5613.242212301368, 5615.438456154393, 5623.887522249573, 5634.492895639371, 5649.717514124319, 6221.937780622181, 6235.407636274592, 6239.407256310643, 6246.281677607088, 6249.531285153632, 6123.252118380239, 6177.0, 6244.567226512918, 6248.031555108965, 6274.937250627527, 5744.856378590527, 5761.48146666802, 5763.6541807491685, 5767.106098554731, 5768.711564421762, 5320.680759154463, 6200.193974783249, 6224.346443623445, 6285.308616052231, 6319.652419116901, 6003.279606447254, 6089.269287685506, 6096.207493025879, 6102.4507794298725, 6105.725242364104, 6210.863513925438, 6254.030625253093, 6254.499640028877, 6256.593321434092, 6268.623882567061, 6062.514998800086, 6140.4428991762525, 6141.140240366352, 6161.014237722033, 6200.3799620038535, 6195.16365290689, 6204.81385558434, 6219.222597175353, 6231.283402408691, 6246.843828904313, 3833.846646134179, 4782.971661092882, 4891.26631005352, 4891.706497610155, 4912.926306105412, 4333.523312435629, 4362.498312694017, 4363.672724545671, 4368.497622773421, 4410.0738844842945, 5602.52378547828, 5613.747381367848, 5623.690697011703, 5624.21261023457, 5652.293463317085, 5246.449122842123, 6126.754929802847, 6198.969005154945, 6223.813285601439, 6274.686265686697, 5579.358373787067, 5622.859428514238, 5627.746751396197, 5636.549076073904, 5651.632643878134, 5324.494173053554, 5330.653507521999, 5351.946480535223, 5352.946470535323, 5355.785768569213, 6207.81376558704, 6228.750849965951, 6300.086487459293, 6302.338254483305, 6329.145565348619, 6278.215223097113, 6290.465310448663, 6300.59046161998, 6301.149344838388, 6314.0, 6279.937200627935, 6293.716782744696, 6298.496120310456, 6308.243010838729, 6309.179806625109, 6055.455009049207, 6105.9084113737445, 6114.936124487681, 6129.175413489998, 6208.937910620836, 6236.438720515175, 6247.250329960434, 6257.061440783918, 6277.905831412441, 6300.7479700811455, 5898.705064746659, 6059.454649081604, 6059.454649081604, 6060.575759696779, 6074.3318234994995, 5908.645481271137, 6001.0, 6012.549058820693, 6075.210222671025, 6110.26676798787, 5877.588568800143, 5877.970610146922, 5881.911771323348, 5883.176355310175, 5915.438033386821, 5952.255968003999, 6063.636181829104, 6068.0, 6087.330393656783, 6118.051701986199, 5749.8562535936935, 5899.17411562373, 5900.793472228452, 5912.438318359749, 5912.822615321547], "unit": "score", "name": "dojo.html", "value": 5659.334684620099}, {"lowerIsBetter": false, "replicates": [465.3368949247322, 505.9342285502884, 521.862340098585, 548.8188897663771, 565.7114871415577, 29863.40273194535, 37827.0, 38196.0, 38430.61569384309, 38535.22929541407, 40965.795171024176, 41347.58652413475, 41445.58554414455, 41485.0, 41526.37710434346, 9406.200472959807, 9646.469444180568, 9649.662261820838, 9653.420794752337, 9656.0, 9427.717168484956, 9555.474448905308, 9586.904130958706, 9592.760180995496, 9661.56522956465, 9670.854937175947, 9737.318387712863, 9751.804963900719, 9754.46350450725, 9762.463064531448, 9625.903740962605, 9706.90293097074, 9717.46553939533, 9727.124558789743, 9737.902620973771, 8634.61144248504, 9599.32804703671, 9767.0, 9771.706848794547, 9788.90211097887, 40512.392314115015, 40684.18631627351, 40776.59223407787, 40806.795966020276, 40894.79552602218, 3178.300773829754, 3217.549543063973, 3301.059198128522, 3496.4405695088662, 3650.4524321351746, 28241.435171296664, 28386.148415547566, 29586.556201656993, 29947.550786738215, 31382.372352553048, 2622.868856557184, 2648.549746543073, 2721.8230814996964, 2762.6408566886375, 2837.7446029857206, 502419.0, 503021.0, 503443.0, 503599.0, 506581.0, 61077.694611526655, 62465.687671561354, 71221.93167102497, 72067.0, 72983.0, 71535.0, 71611.28388716151, 72149.0, 72457.63771181216, 72540.63729681424, 16646.334146634243, 16840.0, 16842.663146736995, 16855.0, 16859.747103793452, 11660.242084264495, 11843.585474508523, 11863.228890122115, 11878.524859005716, 12700.301483418501, 22305.99623016968, 22943.88528057349, 23000.539989200122, 23021.539569208857, 23029.53940921172, 8603.182697643713, 8655.740327790176, 9199.010321645492, 9437.245020398352, 9450.52747362629, 912.8767616371838, 950.3680052764834, 971.9854202186973, 1092.317301686446, 1110.9833352499718, 28523.42953140967, 28923.56614650782, 29009.709902901122, 30064.54903176454, 31009.224769380948, 1029.5881647341123, 1041.9322744021615, 1055.1084333738133, 1123.5955056179769, 1140.1448913315014, 14323.928380358031, 14436.422543098159, 14669.413223471154, 14725.852741472449, 15230.563109902583, 648143.0, 649027.0, 652671.0, 654127.0, 655076.0, 58459.0, 58741.41258587359, 58848.0, 58941.11588326179, 59068.81862362729, 1401.927525443037, 1420.3537390487304, 1438.4461982136743, 1442.9062110962543, 1444.2778610694652, 29275.0, 29911.0, 31185.688143118277, 31229.37541249117, 31919.882804101744, 55333.72333138309, 56492.0, 56501.43498564962, 56613.15080273882, 56628.7168564171, 492476.0, 495391.0, 496206.22762634355, 496647.0, 497549.0, 34504.30991380108, 43364.0, 44367.0, 45456.0, 45480.545194548955, 42782.78608606937, 45514.77242613766, 46501.3024804635, 47156.7642161787, 47904.2814357778, 34846.825765871006, 35040.29919401649, 35746.28507429889, 35872.46191307185, 36756.08109797276, 30949.535756963214, 31287.374252515277, 35970.10074748152, 36468.480240753815, 36906.0, 30633.08100756981, 31691.683083168875, 34912.0, 36876.0, 37350.626493734715, 25697.743022570285, 32596.511052334707, 32718.50922236121, 32725.345493089528, 33062.83468582738, 24038.63942040836, 24419.14532991337, 24516.87741561281, 24850.751492484844, 24925.750742492342], "unit": "score", "name": "ext.html", "value": 20230.65141920627}, {"lowerIsBetter": false, "replicates": [362.7569528415961, 368.64794121613846, 371.8698455540561, 372.0624027450823, 378.08880597759406, 15480.612984675388, 16411.0, 19218.615627687454, 20214.494637634067, 20793.896030519845, 9507.572159252833, 11942.940285298562, 12044.518219271218, 20261.594768104627, 20735.481612959647, 3958.4062390641348, 5166.276721259017, 5376.4085950545405, 5378.542823859957, 5378.731063446831, 4114.7119701620895, 5759.395263497336, 6011.909821352683, 6013.669248191348, 6018.458338749511, 5951.821445356646, 6205.441510264075, 6539.6730163491875, 6540.738370465176, 6547.410733034026, 5663.235463212455, 5913.733881975321, 6361.968190159043, 6547.312532184147, 6548.1814773153355, 5616.5787565932715, 5627.2684551008515, 5630.0991841305195, 5631.690257035862, 5631.943680563224, 13388.665283367896, 13426.462941482328, 13449.193048417028, 13996.510122145675, 18918.81081189198, 1973.3783858084657, 2005.4384772263788, 2013.2953466286829, 2031.2585906144152, 2036.2160568181357, 9449.149576538075, 9758.90241097587, 10187.439690817002, 10942.507587158598, 14804.055167043565, 1660.9501714948572, 1765.9823401765946, 1766.3641089207874, 1779.3079360327372, 1791.08654586162, 71767.64116179438, 100518.49740751322, 103000.0, 107856.99999999921, 109653.45173274082, 11076.058535024453, 11407.0, 11414.972652461318, 11417.37204453763, 11541.307521548566, 13512.864871351161, 13611.863881361258, 13629.454821807214, 13646.385912633956, 13659.931700341633, 8483.321334293365, 8507.95746021266, 8524.57377131141, 8583.48499090044, 8610.311175105977, 8654.524001179869, 8666.826663466696, 8673.479591224546, 8761.255293300013, 8773.341999350074, 4095.2833254180996, 4207.747535147901, 4213.852515161954, 4427.180971520214, 4495.842645507391, 1506.5085565290503, 1782.6612943540686, 1831.276645724958, 1836.4123480486116, 1839.494139111755, 401.0855250029936, 404.51256236235264, 414.7780937198584, 897.1477096758106, 903.3902116071625, 11137.832932506019, 11749.765004699859, 11816.35010074437, 16049.197540122947, 20460.283890064075, 918.8667643191833, 949.2424506807735, 976.9951150244345, 991.9881720644902, 1023.8054769593754, 10379.079870224034, 10707.781353690967, 10712.678619641423, 10787.772192630957, 10954.178436617127, 547930.0, 548759.0, 597702.0, 627607.0, 636386.0, 113632.86367136388, 116479.0, 120894.39552802179, 123476.76523234653, 127103.72896271104, 975.9024097590326, 1018.0379541333517, 1036.740814796301, 1038.6676263595728, 1044.7283706236433, 18248.270069197082, 18944.715829262295, 18988.0, 19003.0, 19008.809911900706, 41013.79493102516, 45452.86367840831, 48977.51022489872, 49041.754791225816, 49984.50015499944, 52161.47838521566, 58701.0, 69895.0, 72170.63914680603, 73048.0, 7550.8867366990635, 7841.0, 7883.921160788319, 7911.84176316482, 7919.920800792149, 11086.667399978014, 11451.828222576502, 12817.295048772407, 12977.805332919825, 13121.540746073842, 8723.345749068973, 10657.413842238751, 10800.891991079989, 10878.020978112008, 11109.0, 10278.0, 10486.213533984828, 10774.138068954308, 10790.244682872124, 10803.513841876977, 11249.437528123724, 11310.151738619801, 11395.601153959571, 11400.030997365317, 11669.299842009506, 6583.30875258091, 7711.498752581064, 7719.844047583471, 7765.92234077652, 7833.804154895945, 8318.958405208177, 10978.231523793258, 11020.559177632806, 11260.436978151223, 11269.422280880848], "unit": "score", "name": "jquery.html", "value": 8830.191607979139}, {"lowerIsBetter": false, "replicates": [1529.1818876900857, 1561.3832536148225, 1780.1989104902798, 1887.1979408751276, 1922.365619345616, 7698.692052317901, 7885.842283154333, 8463.4075614707, 8678.739637810868, 8691.174338437846, 7769.0, 7896.802579935505, 7909.169537198583, 8184.549849758261, 8409.747707568768, 2152.709384233132, 2357.528494301138, 2434.7686969737847, 2473.6165894286414, 2497.013679596558, 2170.75036370817, 2415.3478560788576, 2451.0, 2464.2853572463964, 2468.1854987853967, 2384.5707772600927, 2457.778799908008, 2458.2870967419426, 2461.249318957717, 2462.273629279358, 2409.4578719788083, 2411.650310704938, 2422.212780846232, 2454.619533972237, 2456.2876765737915, 2421.4309637235237, 2438.890249938757, 2441.377448750575, 2448.865312407817, 2466.9259922202364, 8506.404551681384, 8572.185642364027, 8576.528290943996, 8680.0, 8700.34747393948, 5347.491988261109, 5469.644473109235, 5489.3412790465, 5497.670139791625, 5497.780088796443, 3497.8775742849134, 3563.1092226943265, 3574.267275208602, 3653.963460365389, 3718.4050551911564, 1024.5184763161303, 1054.8923630188349, 1062.1874266186373, 1084.5553323137476, 1091.0507858163369, 11911.583094591735, 11922.0, 11923.582674606434, 11932.04543636507, 11940.522379104912, 4774.870566723983, 4789.95210047902, 4845.9030819383415, 4859.878503037452, 4872.634552408584, 9985.60057597688, 9996.700098997042, 10001.649942252132, 10034.69895903124, 10143.137833284254, 5389.83830485086, 5395.325584301962, 5403.054465468527, 5409.080456322435, 5409.404965453797, 4845.127876982177, 4885.828995985124, 4892.633052521075, 4893.314935908976, 4900.093482705711, 3636.072801435617, 3752.0, 3760.6803421708914, 3763.717721170923, 3799.164183879542, 1116.7989761842946, 1127.689885281554, 1188.3107797477442, 1193.2184419205435, 1195.2529668956902, 1289.8387701537308, 1297.1698113207556, 1299.0711641176415, 1331.5605850069453, 1333.6199183232732, 7950.443468957234, 8022.157673444321, 8040.2361775631225, 8057.113717491071, 8069.0317161939765, 1162.7848847962985, 1171.2855158353398, 1177.581958404771, 1182.320165904591, 1189.0606420927543, 4838.854834354975, 6134.263888333339, 6280.811575652738, 6282.277538083179, 6299.023651334051, 10075.244356673278, 10636.946815265874, 10730.302530335503, 10736.677899663022, 10736.838947415796, 10247.743806404751, 10489.160867130611, 10597.25819192649, 10610.946945265225, 10612.25714200014, 8234.711785087613, 8259.132791056973, 8356.874646880302, 8359.164083591591, 8390.538520381439, 7657.34912532441, 7829.569373684274, 7850.136484986761, 7857.960710196412, 7965.880511792444, 9316.673916412892, 9337.873477547735, 9474.857877131986, 9489.383190092622, 9596.90403095988, 9625.951870240884, 10001.199904007808, 10002.299839011199, 10042.849357259793, 10052.296339256474, 7053.612051337021, 7448.590327532038, 7554.093508778762, 7571.167171611009, 7575.280348366897, 8021.8395632088195, 8061.39539534549, 8112.18878112184, 8117.756467305991, 8118.066422361504, 6015.638661970037, 7132.714691412285, 7223.386012188813, 7359.080114985627, 7373.520721153108, 5842.123681447647, 7116.0, 7141.928580714126, 7149.7497587584185, 7181.892271616034, 6296.968515157395, 7579.696812127674, 7583.734569290048, 7584.08990921093, 7605.771826845204, 6898.896516552356, 6926.272741362084, 6926.9307306926285, 6938.306169383021, 6943.618101004493, 6922.688479018356, 6966.268541803241, 7082.681279342339, 7097.325754053357, 7102.964485177541], "unit": "score", "name": "mootools.html", "value": 4878.219341611924}, {"lowerIsBetter": false, "replicates": [318.33626887938647, 321.7442133503864, 327.76073466369564, 328.0290340591848, 332.40831320249947, 6405.103285540028, 6415.326390728977, 6475.061116138158, 6483.254425741035, 6483.416492515673, 6029.366916473773, 6211.813645590628, 6237.189165408502, 6243.313235544098, 6383.2978372379, 3444.8966531003985, 4275.35869619558, 4674.953250467503, 4699.248120300753, 4753.429588449391, 3773.415120656303, 4684.953150468486, 4702.0, 4709.222978208609, 4743.549362810528, 4652.836790802299, 4693.671442998992, 4702.435707715079, 4704.647151463637, 4717.834875779348, 4545.886352841172, 4680.602148817355, 4688.906221875561, 4705.435347758291, 4713.787879545429, 4013.25754735372, 4027.8791636250958, 4028.617281358266, 4029.53660329063, 4032.395140728914, 6127.662978536178, 6130.29501607312, 6132.6933653317155, 6137.846553836145, 6149.600275982047, 5225.268462415265, 5409.43200963901, 5414.377346605112, 5420.34955805302, 5424.864378390533, 5842.941570584282, 6767.763128290536, 6774.220964589086, 6778.423833974118, 6788.76239331621, 4422.601965823059, 4434.246178149722, 4434.49003364614, 4435.356873253392, 4445.466544014706, 7029.0, 7041.823954401181, 7136.500444968854, 7147.749828755968, 7151.606661633608, 3766.548014238309, 4317.546657600907, 4512.503624601291, 4513.616342610915, 4517.841875534341, 4594.517575654575, 4603.631709463302, 4606.56237657422, 4608.539146085364, 4612.815487380534, 5417.0, 5446.2375267462585, 5451.591130665216, 5452.700101494456, 5457.181422786613, 6558.147440832661, 6835.179778426621, 6847.144106986627, 6853.314668533207, 6866.725330986805, 1347.786991707471, 1605.4862444017801, 1617.7249867522548, 1617.7896873406382, 1622.294301978643, 958.5590628310915, 994.5325696922434, 1008.85371621116, 1045.210865796319, 1045.968620941373, 6245.094461303176, 6429.38920802523, 6448.161738973903, 6574.737010519621, 6591.274959754423, 7267.745628902963, 7269.963650181715, 7285.817854553573, 7285.854282914312, 7289.307515785992, 6314.810555683337, 6515.967420162869, 6535.803925882231, 6553.344665533408, 6559.934400655932, 3772.000419888732, 3824.0, 3827.9617203827606, 3828.349180639298, 3828.674562662149, 7548.358389536951, 7577.848443031108, 7588.317051465395, 7590.962045189739, 7603.0876294844975, 7287.307705767944, 7443.292887175709, 7495.737649182362, 7519.360854327334, 7540.547567145989, 7592.8481430372185, 7595.202503737028, 7621.275978782229, 7630.923690763021, 7635.541867487968, 7275.017872587345, 7285.672144753393, 7289.5261807982315, 7294.869295259244, 7302.050733404623, 6726.596404215763, 6919.619420931897, 6931.029655848084, 6932.896006560007, 6971.686274117778, 5981.342052374148, 7423.072115985502, 7425.8143546411775, 7430.653067955307, 7444.367228785614, 4494.8876278092, 4561.654311978041, 4564.520725323793, 4569.451665800125, 4587.0596527712405, 6826.761063362758, 7117.537360071578, 7117.9678946553495, 7122.964385178041, 7127.10911136108, 6871.828204294932, 6879.518433709793, 6882.8967565485555, 6884.070650462324, 6884.48366372514, 6684.598924064571, 6766.695498702472, 6863.142107236596, 6869.862602748017, 6870.62211578368, 5412.161115027177, 6436.517261205335, 6717.764878229238, 6733.797986060426, 6737.69680364375, 6736.6968486417245, 6777.220619628609, 6781.966090169715, 6782.457403407617, 6798.898016529855, 6569.605823650596, 6734.831629209309, 6735.865282694416, 6748.93251067483, 6755.628440435823], "unit": "score", "name": "prototype.html", "value": 4998.596893371179}, {"lowerIsBetter": false, "replicates": [686.3994005245411, 721.0626185958255, 732.7948174511139, 745.8396444764376, 753.4612751882403, 12768.936155319221, 17169.399071032516, 17539.2107355169, 17568.472945811613, 17592.47222583323, 15715.371385144581, 15718.056916585012, 15731.92134039331, 15740.0, 15871.841281587209, 697.9336962988508, 704.9989015597863, 850.0479463001448, 879.9472031678088, 885.5926273913975, 861.7156338408341, 863.5293764898114, 876.5617191404298, 877.2411863737852, 878.0999475537561, 911.803962148138, 926.106307413346, 926.4256161180077, 927.2581934452445, 929.3355250995537, 732.8570928668912, 738.1732459645178, 901.9729408117702, 906.8231694819513, 917.5183028909876, 674.5952428542835, 678.22343416788, 681.6046692918096, 682.3142741544765, 684.6610927590824, 15010.099394036393, 15067.472638457712, 15070.623234419227, 15078.924605376902, 15111.39554417822, 12107.818382724266, 12579.811302830465, 12708.936455317664, 12906.741865162738, 13043.086983911035, 8269.83460330796, 10540.314879532882, 11015.944920275348, 11196.944015279953, 11210.66368008961, 4027.6363345913387, 4034.4755181826467, 4056.432099506042, 4060.248853961997, 4068.7965601719798, 67337.31656708622, 73947.26052739458, 83725.0, 83742.0, 83944.58027709823, 9520.143187113194, 9553.665621703207, 9685.515724213761, 9726.610935562498, 9896.307258491837, 20423.591528169352, 20546.69179962272, 20578.794212057986, 20600.793992060186, 20627.4843128923, 6176.320604733476, 7459.776206713807, 7493.70025198986, 7587.241275872479, 7628.427867909929, 3936.173403585222, 3960.683145348365, 4034.8991275218355, 4040.1717647882115, 4053.250148722496, 3515.6835884770494, 3564.7861128332383, 3566.6789988901123, 3566.964330356715, 3572.4284114541547, 636.8758092171983, 648.9221293444817, 652.9216494020748, 658.3285049249835, 683.7777722240291, 569.6610516742531, 583.1981026089128, 625.7622103600694, 626.7806267806232, 636.0491065856575, 8279.296259817984, 8546.444481108709, 8595.185821718436, 8712.433691810013, 8908.420952638058, 449.7369039112091, 592.3661682000304, 593.5103539579864, 603.3544107804607, 615.4061330815784, 3580.3913334733156, 3620.7465477416854, 4037.0916543778003, 4068.3083875741195, 4115.300398932189, 84229.15770842214, 85640.57179714061, 86776.0, 86854.56572717096, 86963.0, 74161.0, 74547.0, 74920.62539687267, 74930.0, 74998.8750168748, 65474.34525654778, 66204.0, 66337.6683116591, 66674.0, 66753.99999999903, 8100.797480063045, 8155.735860941563, 8215.465994710325, 8334.291585215324, 8415.621297041771, 46245.0, 46551.30173047475, 46608.0, 46633.76683116562, 46814.29778553393, 51233.0, 63493.682531587045, 65971.68056638936, 66454.0, 68433.65783171052, 8815.250703690002, 10572.259941803999, 10611.522481488197, 10944.835827462435, 11188.104951604015, 11944.880551194377, 12371.814422783846, 12403.503859845867, 12931.482740690268, 12938.741225175632, 10218.744531386477, 11498.425078746197, 11612.245204061708, 11615.186936914335, 11667.766644667228, 11417.657470275904, 11572.94213528927, 11605.245659032136, 11723.944844963995, 12513.374331283581, 11514.942425288154, 11652.174777650001, 11729.648110556696, 11737.41312934367, 12387.75224495523, 8014.83970320602, 9548.474833884204, 9581.904180958101, 9678.56446459925, 10634.296801153987, 7834.0, 9189.172974432333, 9357.438553686801, 9562.95218523903, 9688.46713430768], "unit": "score", "name": "yui.html", "value": 6861.883674900338}], "name": "dromaeo_css", "value": 7436.850649716043}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 106.0, 112.0, 110.0, 111.0, 112.0, 115.0, 111.0, 111.0, 109.0], "unit": "score", "name": "ai-astar", "value": 110.9}, {"lowerIsBetter": true, "replicates": [160.0, 121.0, 147.0, 160.0, 121.0, 144.0, 143.0, 119.0, 162.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 140.9}, {"lowerIsBetter": true, "replicates": [192.0, 258.0, 219.0, 182.0, 186.0, 185.0, 184.0, 183.0, 179.0, 184.0], "unit": "score", "name": "audio-dft", "value": 195.2}, {"lowerIsBetter": true, "replicates": [78.0, 76.0, 85.0, 79.0, 55.0, 58.0, 58.0, 82.0, 81.0, 65.0], "unit": "score", "name": "audio-fft", "value": 71.7}, {"lowerIsBetter": true, "replicates": [92.0, 94.0, 126.0, 85.0, 98.0, 130.0, 140.0, 79.0, 80.0, 112.0], "unit": "score", "name": "audio-oscillator", "value": 103.6}, {"lowerIsBetter": true, "replicates": [84.0, 90.0, 123.0, 140.0, 85.0, 90.0, 83.0, 91.0, 84.0, 91.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 96.1}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 93.0, 94.0, 93.0, 94.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 93.8}, {"lowerIsBetter": true, "replicates": [85.0, 95.0, 126.0, 86.0, 81.0, 85.0, 93.0, 84.0, 87.0, 84.0], "unit": "score", "name": "imaging-desaturate", "value": 90.6}, {"lowerIsBetter": true, "replicates": [55.0, 55.0, 54.0, 53.0, 53.0, 53.0, 53.0, 64.0, 51.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 54.4}, {"lowerIsBetter": true, "replicates": [63.0, 62.0, 78.0, 74.0, 70.0, 68.0, 68.0, 68.0, 69.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.0}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 82.0, 83.0, 83.0, 83.0, 81.0, 81.0, 84.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.8}, {"lowerIsBetter": true, "replicates": [124.0, 125.0, 126.0, 124.0, 121.0, 123.0, 125.0, 122.0, 123.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.9}, {"lowerIsBetter": true, "replicates": [141.0, 128.0, 140.0, 137.0, 140.0, 126.0, 139.0, 138.0, 138.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.3}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 65.0, 68.0, 67.0, 67.0, 67.0, 67.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.6}], "name": "kraken", "value": 1435.8}]} 04:58:41 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1435.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7436.85"}}} 04:58:41 INFO - Return code: 0 04:58:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:58:41 INFO - # TBPL SUCCESS # 04:58:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:58:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:58:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:58:41 INFO - 2016-02-19 04:58:41.933 screenresolution[2934:23159] starting screenresolution argv=screenresolution get 04:58:41 INFO - 2016-02-19 04:58:41.935 screenresolution[2934:23159] Display 0: 1600x1200x32@60 04:58:41 INFO - 2016-02-19 04:58:41.942 screenresolution[2935:23161] starting screenresolution argv=screenresolution list 04:58:41 INFO - Available Modes on Display 0 04:58:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:58:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:58:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:58:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:58:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:58:42 INFO - Intel Iris: 04:58:42 INFO - Chipset Model: Intel Iris 04:58:42 INFO - Type: GPU 04:58:42 INFO - Bus: Built-In 04:58:42 INFO - VRAM (Dynamic, Max): 1536 MB 04:58:42 INFO - Vendor: Intel (0x8086) 04:58:42 INFO - Device ID: 0x0a2e 04:58:42 INFO - Revision ID: 0x0009 04:58:42 INFO - Displays: 04:58:42 INFO - Display: 04:58:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:58:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:58:42 INFO - Display Serial Number: 1600x1200 60 04:58:42 INFO - Main Display: Yes 04:58:42 INFO - Mirror: Off 04:58:42 INFO - Online: Yes 04:58:42 INFO - Rotation: Supported 04:58:42 INFO - Return code: 0 04:58:42 INFO - Running post-action listener: _resource_record_post_action 04:58:42 INFO - Running post-run listener: _resource_record_post_run 04:58:43 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 827392; Write bytes: 707443200; Read time: 11; Write time: 1950 04:58:43 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 385022464; Write bytes: 379758080; Read time: 30288; Write time: 665 04:58:43 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 827392; Write bytes: 300127232; Read time: 11; Write time: 1228 04:58:43 INFO - Running post-run listener: _upload_blobber_files 04:58:43 INFO - Blob upload gear active. 04:58:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:58:43 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 04:58:43 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'] 04:58:43 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 04:58:43 INFO - (blobuploader) - INFO - Open directory for files ... 04:58:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:58:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:58:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:58:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:58:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:58:44 INFO - (blobuploader) - INFO - Done attempting. 04:58:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:58:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:58:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:58:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:58:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:58:45 INFO - (blobuploader) - INFO - Done attempting. 04:58:45 INFO - (blobuploader) - INFO - Iteration through files over. 04:58:45 INFO - Return code: 0 04:58:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:58:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:58:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7eacf5b84f40555b030fbd15b48e9540f8342ac008b13693af09e166cabb545928e1d889a6de605944d5ef31606689145883df22d8fe74b0ded405c5bb7556ed", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c280d7dd70c85eafea41b61c08612baf210b7163e21a9407c3debf5d355e191cc6076a59742253c86680a133b8879dbfd27c0066efd0604ad9be764e3d3ceb4b"} 04:58:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:58:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:58:45 INFO - Contents: 04:58:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7eacf5b84f40555b030fbd15b48e9540f8342ac008b13693af09e166cabb545928e1d889a6de605944d5ef31606689145883df22d8fe74b0ded405c5bb7556ed", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c280d7dd70c85eafea41b61c08612baf210b7163e21a9407c3debf5d355e191cc6076a59742253c86680a133b8879dbfd27c0066efd0604ad9be764e3d3ceb4b"} 04:58:45 INFO - Running post-run listener: copy_logs_to_upload_dir 04:58:45 INFO - Copying logs to upload dir... 04:58:45 INFO - mkdir: /builds/slave/test/build/upload/logs 04:58:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.496096 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-02-19 04:58:45.895967) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-19 04:58:45.899722) ========= 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.kQ1dtTmyqU/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.RPo9prGHSP/Listeners TMPDIR=/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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/7eacf5b84f40555b030fbd15b48e9540f8342ac008b13693af09e166cabb545928e1d889a6de605944d5ef31606689145883df22d8fe74b0ded405c5bb7556ed", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c280d7dd70c85eafea41b61c08612baf210b7163e21a9407c3debf5d355e191cc6076a59742253c86680a133b8879dbfd27c0066efd0604ad9be764e3d3ceb4b"} build_url:https://queue.taskcluster.net/v1/task/VzgcD2VaS4GCXDHY5AIo5Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011445 build_url: 'https://queue.taskcluster.net/v1/task/VzgcD2VaS4GCXDHY5AIo5Q/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/7eacf5b84f40555b030fbd15b48e9540f8342ac008b13693af09e166cabb545928e1d889a6de605944d5ef31606689145883df22d8fe74b0ded405c5bb7556ed", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c280d7dd70c85eafea41b61c08612baf210b7163e21a9407c3debf5d355e191cc6076a59742253c86680a133b8879dbfd27c0066efd0604ad9be764e3d3ceb4b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-19 04:58:45.927536) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 04:58:45.927887) ========= 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.kQ1dtTmyqU/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.RPo9prGHSP/Listeners TMPDIR=/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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.005380 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 04:58:45.977245) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-19 04:58:45.977596) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-19 04:58:45.978056) ========= ========= Total master_lag: 0.27 =========