builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0023 starttime: 1460216231.03 results: success (0) buildid: 20160409071138 builduid: beba85abe1f44e4fb098d4d838075480 revision: d62963756d9a9d19cbbb5d8f3dd3c7cfa8fdef88 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-09 08:37:11.030750) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-09 08:37:11.031147) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-09 08:37:11.031427) ========= 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.tLjDsv5zZ1/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.OZDFNAqmja/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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.005570 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-09 08:37:11.068638) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-09 08:37:11.068925) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-09 08:37:11.114482) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 08:37:11.115023) ========= 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.tLjDsv5zZ1/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.OZDFNAqmja/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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.005928 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 08:37:11.168081) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-09 08:37:11.168365) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-09 08:37:11.168698) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 08:37:11.168982) ========= 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.tLjDsv5zZ1/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.OZDFNAqmja/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-09 08:37:11-- 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% 143M=0s 2016-04-09 08:37:11 (143 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.547164 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 08:37:11.732737) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 08:37:11.733036) ========= 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.tLjDsv5zZ1/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.OZDFNAqmja/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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.026132 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 08:37:11.791944) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-09 08:37:11.792483) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d62963756d9a9d19cbbb5d8f3dd3c7cfa8fdef88 --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 d62963756d9a9d19cbbb5d8f3dd3c7cfa8fdef88 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tLjDsv5zZ1/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.OZDFNAqmja/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-09 08:37:11,877 truncating revision to first 12 chars 2016-04-09 08:37:11,877 Setting DEBUG logging. 2016-04-09 08:37:11,878 attempt 1/10 2016-04-09 08:37:11,878 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d62963756d9a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-09 08:37:12,614 unpacking tar archive at: fx-team-d62963756d9a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.986455 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-09 08:37:12.796450) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-09 08:37:12.796776) ========= echo d62963756d9a9d19cbbb5d8f3dd3c7cfa8fdef88 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'd62963756d9a9d19cbbb5d8f3dd3c7cfa8fdef88'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tLjDsv5zZ1/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.OZDFNAqmja/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 d62963756d9a9d19cbbb5d8f3dd3c7cfa8fdef88 program finished with exit code 0 elapsedTime=0.004902 script_repo_revision: 'd62963756d9a9d19cbbb5d8f3dd3c7cfa8fdef88' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-09 08:37:12.847168) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-09 08:37:12.847452) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-09 08:37:12.861017) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 35 secs) (at 2016-04-09 08:37:12.861479) ========= /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.tLjDsv5zZ1/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.OZDFNAqmja/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 08:37:13 INFO - MultiFileLogger online at 20160409 08:37:13 in /builds/slave/test 08:37:13 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 08:37:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:37:13 INFO - {'append_to_log': False, 08:37:13 INFO - 'base_work_dir': '/builds/slave/test', 08:37:13 INFO - 'blob_upload_branch': 'Fx-Team', 08:37:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:37:13 INFO - 'branch': 'Fx-Team', 08:37:13 INFO - 'buildbot_json_path': 'buildprops.json', 08:37:13 INFO - 'config_files': ('talos/mac_config.py',), 08:37:13 INFO - 'default_actions': ('clobber', 08:37:13 INFO - 'read-buildbot-config', 08:37:13 INFO - 'download-and-extract', 08:37:13 INFO - 'populate-webroot', 08:37:13 INFO - 'create-virtualenv', 08:37:13 INFO - 'install', 08:37:13 INFO - 'run-tests'), 08:37:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:37:13 INFO - 'download_minidump_stackwalk': True, 08:37:13 INFO - 'download_symbols': 'ondemand', 08:37:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:37:13 INFO - 'tooltool.py': '/tools/tooltool.py', 08:37:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:37:13 INFO - '/tools/misc-python/virtualenv.py')}, 08:37:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:37:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:37:13 INFO - 'installer_path': 'installer.exe', 08:37:13 INFO - 'log_level': 'info', 08:37:13 INFO - 'log_name': 'talos', 08:37:13 INFO - 'log_to_console': True, 08:37:13 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:37:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:37:13 INFO - 'opt_config_files': (), 08:37:13 INFO - 'pip_index': False, 08:37:13 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:37:13 INFO - 'cmd': ('bash', 08:37:13 INFO - '-c', 08:37:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:37:13 INFO - 'enabled': True, 08:37:13 INFO - 'halt_on_failure': False, 08:37:13 INFO - 'name': 'check_screen_resolution'},), 08:37:13 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:37:13 INFO - 'cmd': ('bash', 08:37:13 INFO - '-c', 08:37:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:37:13 INFO - 'enabled': True, 08:37:13 INFO - 'halt_on_failure': False, 08:37:13 INFO - 'name': 'check_screen_resolution'},), 08:37:13 INFO - 'run_cmd_checks_enabled': True, 08:37:13 INFO - 'sps_profile': False, 08:37:13 INFO - 'sps_profile_interval': 0, 08:37:13 INFO - 'suite': 'dromaeojs', 08:37:13 INFO - 'system_bits': '32', 08:37:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:37:13 INFO - 'title': 't-yosemite-r7-0023', 08:37:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:37:13 INFO - 'use_talos_json': True, 08:37:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:37:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:37:13 INFO - 'work_dir': 'build'} 08:37:13 INFO - ##### 08:37:13 INFO - ##### Running clobber step. 08:37:13 INFO - ##### 08:37:13 INFO - Running pre-action listener: _resource_record_pre_action 08:37:13 INFO - Running main action method: clobber 08:37:13 INFO - rmtree: /builds/slave/test/build 08:37:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:37:14 INFO - Running post-action listener: _resource_record_post_action 08:37:14 INFO - ##### 08:37:14 INFO - ##### Running read-buildbot-config step. 08:37:14 INFO - ##### 08:37:14 INFO - Running pre-action listener: _resource_record_pre_action 08:37:14 INFO - Running main action method: read_buildbot_config 08:37:14 INFO - Using buildbot properties: 08:37:14 INFO - { 08:37:14 INFO - "project": "", 08:37:14 INFO - "product": "firefox", 08:37:14 INFO - "script_repo_revision": "production", 08:37:14 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 08:37:14 INFO - "repository": "", 08:37:14 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 08:37:14 INFO - "buildid": "20160409071138", 08:37:14 INFO - "pgo_build": "False", 08:37:14 INFO - "basedir": "/builds/slave/test", 08:37:14 INFO - "buildnumber": 596, 08:37:14 INFO - "slavename": "t-yosemite-r7-0023", 08:37:14 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 08:37:14 INFO - "platform": "yosemite_r7", 08:37:14 INFO - "scheduler": "tests-fx-team-macosx64-talos", 08:37:14 INFO - "branch": "fx-team", 08:37:14 INFO - "repo_path": "integration/fx-team", 08:37:14 INFO - "revision": "d62963756d9a9d19cbbb5d8f3dd3c7cfa8fdef88", 08:37:14 INFO - "stage_platform": "macosx64", 08:37:14 INFO - "builduid": "beba85abe1f44e4fb098d4d838075480", 08:37:14 INFO - "slavebuilddir": "test" 08:37:14 INFO - } 08:37:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/D3QUcp0iQOe4jGHfeagZ2w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 08:37:14 INFO - Running post-action listener: _resource_record_post_action 08:37:14 INFO - ##### 08:37:14 INFO - ##### Running download-and-extract step. 08:37:14 INFO - ##### 08:37:14 INFO - Running pre-action listener: _resource_record_pre_action 08:37:14 INFO - Running main action method: download_and_extract 08:37:14 INFO - mkdir: /builds/slave/test/build/tests 08:37:14 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')]} 08:37:14 INFO - https://queue.taskcluster.net/v1/task/D3QUcp0iQOe4jGHfeagZ2w/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 08:37:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D3QUcp0iQOe4jGHfeagZ2w/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 08:37:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D3QUcp0iQOe4jGHfeagZ2w/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 08:37:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D3QUcp0iQOe4jGHfeagZ2w/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 08:37:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D3QUcp0iQOe4jGHfeagZ2w/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 08:37:20 INFO - Downloaded 1199 bytes. 08:37:20 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 08:37:20 INFO - Using the following test package requirements: 08:37:20 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 08:37:20 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:37:20 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 08:37:20 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:37:20 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 08:37:20 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:37:20 INFO - u'jsshell-mac.zip'], 08:37:20 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:37:20 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 08:37:20 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 08:37:20 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:37:20 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 08:37:20 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:37:20 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 08:37:20 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:37:20 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 08:37:20 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:37:20 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 08:37:20 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:37: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')]} 08:37:20 INFO - https://queue.taskcluster.net/v1/task/D3QUcp0iQOe4jGHfeagZ2w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:37:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D3QUcp0iQOe4jGHfeagZ2w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 08:37:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D3QUcp0iQOe4jGHfeagZ2w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 08:37:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D3QUcp0iQOe4jGHfeagZ2w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 08:37:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D3QUcp0iQOe4jGHfeagZ2w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:37:36 INFO - Downloaded 18014558 bytes. 08:37:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:37:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 08:37:39 INFO - Return code: 0 08:37:39 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 08:37:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:37:39 INFO - https://queue.taskcluster.net/v1/task/D3QUcp0iQOe4jGHfeagZ2w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:37:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D3QUcp0iQOe4jGHfeagZ2w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 08:37:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D3QUcp0iQOe4jGHfeagZ2w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 08:37:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D3QUcp0iQOe4jGHfeagZ2w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 08:37:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D3QUcp0iQOe4jGHfeagZ2w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:37:49 INFO - Downloaded 18014558 bytes. 08:37:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:37:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 08:37:53 INFO - Return code: 0 08:37:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:37:53 INFO - https://queue.taskcluster.net/v1/task/D3QUcp0iQOe4jGHfeagZ2w/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:37:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D3QUcp0iQOe4jGHfeagZ2w/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 08:37:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D3QUcp0iQOe4jGHfeagZ2w/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 08:37:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D3QUcp0iQOe4jGHfeagZ2w/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 08:37:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D3QUcp0iQOe4jGHfeagZ2w/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:37:54 INFO - Downloaded 10841097 bytes. 08:37:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:37:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 08:37:54 INFO - Return code: 0 08:37:54 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')]} 08:37:54 INFO - https://queue.taskcluster.net/v1/task/D3QUcp0iQOe4jGHfeagZ2w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 08:37:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D3QUcp0iQOe4jGHfeagZ2w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 08:37:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D3QUcp0iQOe4jGHfeagZ2w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 08:37:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D3QUcp0iQOe4jGHfeagZ2w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 08:37:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D3QUcp0iQOe4jGHfeagZ2w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 08:38:01 INFO - Downloaded 108760310 bytes. 08:38:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D3QUcp0iQOe4jGHfeagZ2w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 08:38:01 INFO - mkdir: /builds/slave/test/properties 08:38:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:38:01 INFO - Writing to file /builds/slave/test/properties/build_url 08:38:01 INFO - Contents: 08:38:01 INFO - build_url:https://queue.taskcluster.net/v1/task/D3QUcp0iQOe4jGHfeagZ2w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 08:38:02 INFO - Running post-action listener: _resource_record_post_action 08:38:02 INFO - Running post-action listener: set_extra_try_arguments 08:38:02 INFO - ##### 08:38:02 INFO - ##### Running populate-webroot step. 08:38:02 INFO - ##### 08:38:02 INFO - Running pre-action listener: _resource_record_pre_action 08:38:02 INFO - Running main action method: populate_webroot 08:38:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:38:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:38:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:38:02 INFO - '--tppagecycles', 08:38:02 INFO - '7'], 08:38:02 INFO - 'tests': ['tsvgm']}}, 08:38:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:38:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:38:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:38:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:38:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:38:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:38:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:38:02 INFO - 'talos_options': ['--disable-e10s'], 08:38:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:38:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:38:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:38:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:38:02 INFO - 'talos_options': ['--disable-e10s'], 08:38:02 INFO - 'tests': ['damp', 'tps']}, 08:38:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:38:02 INFO - 'tests': ['damp', 'tps']}, 08:38:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:38:02 INFO - 'tests': ['dromaeo_dom']}, 08:38:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:38:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:38:02 INFO - 'tests': ['a11yr', 08:38:02 INFO - 'ts_paint', 08:38:02 INFO - 'tpaint', 08:38:02 INFO - 'sessionrestore', 08:38:02 INFO - 'sessionrestore_no_auto_restore', 08:38:02 INFO - 'tabpaint']}, 08:38:02 INFO - 'other-e10s': {'tests': ['a11yr', 08:38:02 INFO - 'ts_paint', 08:38:02 INFO - 'tpaint', 08:38:02 INFO - 'sessionrestore', 08:38:02 INFO - 'sessionrestore_no_auto_restore', 08:38:02 INFO - 'tabpaint']}, 08:38:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:38:02 INFO - 'ts_paint', 08:38:02 INFO - 'tpaint', 08:38:02 INFO - 'sessionrestore', 08:38:02 INFO - 'sessionrestore_no_auto_restore', 08:38:02 INFO - 'tabpaint']}, 08:38:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:38:02 INFO - 'ts_paint', 08:38:02 INFO - 'tpaint', 08:38:02 INFO - 'sessionrestore', 08:38:02 INFO - 'sessionrestore_no_auto_restore', 08:38:02 INFO - 'tabpaint']}, 08:38:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:38:02 INFO - 'tests': ['a11yr', 08:38:02 INFO - 'ts_paint', 08:38:02 INFO - 'tpaint', 08:38:02 INFO - 'sessionrestore', 08:38:02 INFO - 'sessionrestore_no_auto_restore', 08:38:02 INFO - 'tabpaint']}, 08:38:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:38:02 INFO - 'tests': ['a11yr', 08:38:02 INFO - 'ts_paint', 08:38:02 INFO - 'tpaint', 08:38:02 INFO - 'sessionrestore', 08:38:02 INFO - 'sessionrestore_no_auto_restore', 08:38:02 INFO - 'tabpaint']}, 08:38:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:38:02 INFO - 'tests': ['tsvgx', 08:38:02 INFO - 'tsvgr_opacity', 08:38:02 INFO - 'tart', 08:38:02 INFO - 'tscrollx', 08:38:02 INFO - 'cart']}, 08:38:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:38:02 INFO - 'tsvgr_opacity', 08:38:02 INFO - 'tart', 08:38:02 INFO - 'tscrollx', 08:38:02 INFO - 'cart']}, 08:38:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:38:02 INFO - 'talos_options': ['--disable-e10s'], 08:38:02 INFO - 'tests': ['tp5o']}, 08:38:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:38:02 INFO - 'tests': ['tp5o']}, 08:38:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:38:02 INFO - 'talos_options': ['--disable-e10s', 08:38:02 INFO - '--xperf_path', 08:38:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:38:02 INFO - 'tests': ['tp5n']}, 08:38:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:38:02 INFO - 'talos_options': ['--xperf_path', 08:38:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:38:02 INFO - 'tests': ['tp5n']}}, 08:38:02 INFO - 'talos.zip': {'path': '', 08:38:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:38:02 INFO - Running post-action listener: _resource_record_post_action 08:38:02 INFO - ##### 08:38:02 INFO - ##### Running create-virtualenv step. 08:38:02 INFO - ##### 08:38:02 INFO - Running pre-action listener: _resource_record_pre_action 08:38:02 INFO - Running main action method: create_virtualenv 08:38:02 INFO - Creating virtualenv /builds/slave/test/build/venv 08:38:02 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 08:38:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:38:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:38:02 INFO - Using real prefix '/tools/python27' 08:38:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:38:03 INFO - Installing distribute.............................................................................................................................................................................................done. 08:38:06 INFO - Installing pip.................done. 08:38:06 INFO - Return code: 0 08:38:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:38:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c5c8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5d8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2e1d97170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c467e00>, '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 0x10c290db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c462b20>, '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.tLjDsv5zZ1/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.OZDFNAqmja/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 08:38:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:38:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:38:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tLjDsv5zZ1/Render', 08:38:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:38:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:38:06 INFO - 'HOME': '/Users/cltbld', 08:38:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:38:06 INFO - 'LOGNAME': 'cltbld', 08:38:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:06 INFO - 'MOZ_NO_REMOTE': '1', 08:38:06 INFO - 'NO_EM_RESTART': '1', 08:38:06 INFO - 'PAGER': '/bin/cat', 08:38:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:38:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:06 INFO - 'PWD': '/builds/slave/test', 08:38:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:38:06 INFO - 'SHELL': '/bin/bash', 08:38:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OZDFNAqmja/Listeners', 08:38:06 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 08:38:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:38:06 INFO - 'USER': 'cltbld', 08:38:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:38:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:38:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:06 INFO - 'XPC_FLAGS': '0x0', 08:38:06 INFO - 'XPC_SERVICE_NAME': '0', 08:38:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:38:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:06 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 08:38:06 INFO - Cleaning up... 08:38:06 INFO - Return code: 0 08:38:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:38:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c5c8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5d8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2e1d97170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c467e00>, '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 0x10c290db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c462b20>, '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.tLjDsv5zZ1/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.OZDFNAqmja/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 08:38:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 08:38:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:38:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tLjDsv5zZ1/Render', 08:38:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:38:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:38:06 INFO - 'HOME': '/Users/cltbld', 08:38:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:38:06 INFO - 'LOGNAME': 'cltbld', 08:38:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:06 INFO - 'MOZ_NO_REMOTE': '1', 08:38:06 INFO - 'NO_EM_RESTART': '1', 08:38:06 INFO - 'PAGER': '/bin/cat', 08:38:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:38:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:06 INFO - 'PWD': '/builds/slave/test', 08:38:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:38:06 INFO - 'SHELL': '/bin/bash', 08:38:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OZDFNAqmja/Listeners', 08:38:06 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 08:38:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:38:06 INFO - 'USER': 'cltbld', 08:38:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:38:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:38:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:06 INFO - 'XPC_FLAGS': '0x0', 08:38:06 INFO - 'XPC_SERVICE_NAME': '0', 08:38:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:38:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:06 INFO - Downloading/unpacking psutil>=0.7.1 08:38:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:38:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:38:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:38:09 INFO - Installing collected packages: psutil 08:38:09 INFO - Running setup.py install for psutil 08:38:09 INFO - building 'psutil._psutil_osx' extension 08:38:09 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 08:38:10 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 08:38:10 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 08:38:10 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 08:38:10 INFO - building 'psutil._psutil_posix' extension 08:38:10 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 08:38:10 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:38:10 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:38:10 INFO - ^ 08:38:10 INFO - 1 warning generated. 08:38:10 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 08:38:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:38:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:38:10 INFO - Successfully installed psutil 08:38:10 INFO - Cleaning up... 08:38:10 INFO - Return code: 0 08:38:10 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:38:10 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')]} 08:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:10 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')]} 08:38:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:10 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 0x10c5c8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5d8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2e1d97170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c467e00>, '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 0x10c290db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c462b20>, '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.tLjDsv5zZ1/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.OZDFNAqmja/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 08:38:10 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 08:38:10 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 08:38:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tLjDsv5zZ1/Render', 08:38:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:38:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:38:10 INFO - 'HOME': '/Users/cltbld', 08:38:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:38:10 INFO - 'LOGNAME': 'cltbld', 08:38:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:10 INFO - 'MOZ_NO_REMOTE': '1', 08:38:10 INFO - 'NO_EM_RESTART': '1', 08:38:10 INFO - 'PAGER': '/bin/cat', 08:38:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:38:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:10 INFO - 'PWD': '/builds/slave/test', 08:38:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:38:10 INFO - 'SHELL': '/bin/bash', 08:38:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OZDFNAqmja/Listeners', 08:38:10 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 08:38:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:38:10 INFO - 'USER': 'cltbld', 08:38:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:38:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:38:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:10 INFO - 'XPC_FLAGS': '0x0', 08:38:10 INFO - 'XPC_SERVICE_NAME': '0', 08:38:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:38:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:11 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08: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 08: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 08: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 08: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 08: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 08: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 08:38:13 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:38:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:38:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:38:13 INFO - Installing collected packages: mozsystemmonitor 08:38:13 INFO - Running setup.py install for mozsystemmonitor 08:38:13 INFO - Successfully installed mozsystemmonitor 08:38:13 INFO - Cleaning up... 08:38:13 INFO - Return code: 0 08:38:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:38:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c5c8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5d8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2e1d97170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c467e00>, '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 0x10c290db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c462b20>, '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.tLjDsv5zZ1/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.OZDFNAqmja/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 08:38:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:38:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:38:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tLjDsv5zZ1/Render', 08:38:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:38:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:38:13 INFO - 'HOME': '/Users/cltbld', 08:38:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:38:13 INFO - 'LOGNAME': 'cltbld', 08:38:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:13 INFO - 'MOZ_NO_REMOTE': '1', 08:38:13 INFO - 'NO_EM_RESTART': '1', 08:38:13 INFO - 'PAGER': '/bin/cat', 08:38:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:38:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:13 INFO - 'PWD': '/builds/slave/test', 08:38:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:38:13 INFO - 'SHELL': '/bin/bash', 08:38:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OZDFNAqmja/Listeners', 08:38:13 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 08:38:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:38:13 INFO - 'USER': 'cltbld', 08:38:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:38:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:38:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:13 INFO - 'XPC_FLAGS': '0x0', 08:38:13 INFO - 'XPC_SERVICE_NAME': '0', 08:38:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:38:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:14 INFO - Downloading/unpacking blobuploader==1.2.4 08: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 08: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 08: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 08: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 08: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 08: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 08:38:16 INFO - Downloading blobuploader-1.2.4.tar.gz 08:38:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:38:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:38:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:38:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:38:17 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 08:38:17 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 08:38:17 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 08:38:17 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 08:38:17 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 08:38:17 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 08:38:17 INFO - Downloading docopt-0.6.1.tar.gz 08:38:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:38:17 INFO - Installing collected packages: blobuploader, requests, docopt 08:38:17 INFO - Running setup.py install for blobuploader 08:38:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:38:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:38:17 INFO - Running setup.py install for requests 08:38:18 INFO - Running setup.py install for docopt 08:38:18 INFO - Successfully installed blobuploader requests docopt 08:38:18 INFO - Cleaning up... 08:38:18 INFO - Return code: 0 08:38:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:38:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:19 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 0x10c5c8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5d8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2e1d97170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c467e00>, '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 0x10c290db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c462b20>, '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.tLjDsv5zZ1/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.OZDFNAqmja/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 08:38:19 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 08:38:19 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 08:38:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tLjDsv5zZ1/Render', 08:38:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:38:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:38:19 INFO - 'HOME': '/Users/cltbld', 08:38:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:38:19 INFO - 'LOGNAME': 'cltbld', 08:38:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:19 INFO - 'MOZ_NO_REMOTE': '1', 08:38:19 INFO - 'NO_EM_RESTART': '1', 08:38:19 INFO - 'PAGER': '/bin/cat', 08:38:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:38:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:19 INFO - 'PWD': '/builds/slave/test', 08:38:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:38:19 INFO - 'SHELL': '/bin/bash', 08:38:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OZDFNAqmja/Listeners', 08:38:19 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 08:38:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:38:19 INFO - 'USER': 'cltbld', 08:38:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:38:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:38:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:19 INFO - 'XPC_FLAGS': '0x0', 08:38:19 INFO - 'XPC_SERVICE_NAME': '0', 08:38:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:38:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:38:19 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-fOX_5C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:38:19 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-OakdBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:38:19 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-172KWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:38:19 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-Z1mCXj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:38:19 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-7IhHdt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:38:19 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-8hrNV8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:38:20 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-gxJr_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:38:20 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-rRMFtc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:38:20 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-7fkzxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:38:20 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-q7n9p_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:38:20 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-27jUR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:38:20 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-JGbBM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:38:20 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-313qFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:38:20 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-h0Wxq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:38:20 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-KanLjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:38:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:38:21 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-efbvW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:38:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:38:21 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-tfS9DV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:38:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:38:21 INFO - Running setup.py install for manifestparser 08:38:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:38:21 INFO - Running setup.py install for mozcrash 08:38:21 INFO - Running setup.py install for mozdebug 08:38:21 INFO - Running setup.py install for mozdevice 08:38:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:38:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:38:21 INFO - Running setup.py install for mozfile 08:38:21 INFO - Running setup.py install for mozhttpd 08:38:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:38:22 INFO - Running setup.py install for mozinfo 08:38:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:38:22 INFO - Running setup.py install for mozInstall 08:38:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:38:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:38:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:38:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:38:22 INFO - Running setup.py install for mozleak 08:38:22 INFO - Running setup.py install for mozlog 08:38:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:38:22 INFO - Running setup.py install for moznetwork 08:38:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:38:22 INFO - Running setup.py install for mozprocess 08:38:23 INFO - Running setup.py install for mozprofile 08:38:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:38:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:38:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:38:23 INFO - Running setup.py install for mozrunner 08:38:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:38:23 INFO - Running setup.py install for mozscreenshot 08:38:23 INFO - Running setup.py install for moztest 08:38:23 INFO - Running setup.py install for mozversion 08:38:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:38:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:38:23 INFO - Cleaning up... 08:38:23 INFO - Return code: 0 08:38:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:38:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:23 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 0x10c5c8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5d8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2e1d97170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c467e00>, '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 0x10c290db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c462b20>, '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.tLjDsv5zZ1/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.OZDFNAqmja/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 08:38:23 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 08:38:23 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 08:38:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tLjDsv5zZ1/Render', 08:38:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:38:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:38:23 INFO - 'HOME': '/Users/cltbld', 08:38:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:38:23 INFO - 'LOGNAME': 'cltbld', 08:38:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:23 INFO - 'MOZ_NO_REMOTE': '1', 08:38:23 INFO - 'NO_EM_RESTART': '1', 08:38:23 INFO - 'PAGER': '/bin/cat', 08:38:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:38:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:23 INFO - 'PWD': '/builds/slave/test', 08:38:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:38:23 INFO - 'SHELL': '/bin/bash', 08:38:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OZDFNAqmja/Listeners', 08:38:23 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 08:38:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:38:23 INFO - 'USER': 'cltbld', 08:38:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:38:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:38:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:23 INFO - 'XPC_FLAGS': '0x0', 08:38:23 INFO - 'XPC_SERVICE_NAME': '0', 08:38:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:38:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:38:24 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-idAV15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:38:24 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)) 08:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:38:24 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-VcjPyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:38:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:38:24 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-F0W8Nf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:38:24 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)) 08:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:38:24 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-UP4U8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:38:24 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)) 08:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:38:24 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-pOAHZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:38:24 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)) 08:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:38:24 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-CLhwwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:38:24 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)) 08:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:38:24 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-VnwBnI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:38:24 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)) 08:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:38:24 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-E0v7Yl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:38:25 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)) 08:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:38:25 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-LVzoTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:38:25 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)) 08:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:38:25 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-Svcb2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:38:25 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)) 08:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:38:25 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-wokjn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:38:25 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)) 08:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:38:25 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-ImC17P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:38:25 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)) 08:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:38:25 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-5_pJH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:38:25 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)) 08:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:38:25 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-s8UWvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:38:25 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)) 08:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:38:25 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-5v9SNH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:38:25 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)) 08:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:38:25 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-4Qnqnv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:38:25 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)) 08:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:38:25 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-jY_gdc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:38:25 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)) 08:38:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:38:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:38:26 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)) 08: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 mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:38:26 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)) 08:38:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08: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 08: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 08: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 08: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 08: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 08: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 08:38:28 INFO - Downloading blessings-1.6.tar.gz 08:38:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:38:28 INFO - Installing collected packages: blessings 08:38:28 INFO - Running setup.py install for blessings 08:38:28 INFO - Successfully installed blessings 08:38:28 INFO - Cleaning up... 08:38:28 INFO - Return code: 0 08:38:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:38:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:38:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:38:29 INFO - Reading from file tmpfile_stdout 08:38:29 INFO - Current package versions: 08:38:29 INFO - blessings == 1.6 08:38:29 INFO - blobuploader == 1.2.4 08:38:29 INFO - docopt == 0.6.1 08:38:29 INFO - manifestparser == 1.1 08:38:29 INFO - mozInstall == 1.12 08:38:29 INFO - mozcrash == 0.17 08:38:29 INFO - mozdebug == 0.1 08:38:29 INFO - mozdevice == 0.48 08:38:29 INFO - mozfile == 1.2 08:38:29 INFO - mozhttpd == 0.7 08:38:29 INFO - mozinfo == 0.9 08:38:29 INFO - mozleak == 0.1 08:38:29 INFO - mozlog == 3.1 08:38:29 INFO - moznetwork == 0.27 08:38:29 INFO - mozprocess == 0.22 08:38:29 INFO - mozprofile == 0.28 08:38:29 INFO - mozrunner == 6.11 08:38:29 INFO - mozscreenshot == 0.1 08:38:29 INFO - mozsystemmonitor == 0.0 08:38:29 INFO - moztest == 0.7 08:38:29 INFO - mozversion == 1.4 08:38:29 INFO - psutil == 3.1.1 08:38:29 INFO - requests == 1.2.3 08:38:29 INFO - wsgiref == 0.1.2 08:38:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08: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')]} 08:38:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08: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')]} 08:38:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:29 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 0x10c5c8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5d8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2e1d97170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c467e00>, '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 0x10c290db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c462b20>, '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.tLjDsv5zZ1/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.OZDFNAqmja/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 08:38:29 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 08:38:29 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 08:38:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tLjDsv5zZ1/Render', 08:38:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:38:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:38:29 INFO - 'HOME': '/Users/cltbld', 08:38:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:38:29 INFO - 'LOGNAME': 'cltbld', 08:38:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:29 INFO - 'MOZ_NO_REMOTE': '1', 08:38:29 INFO - 'NO_EM_RESTART': '1', 08:38:29 INFO - 'PAGER': '/bin/cat', 08:38:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:38:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:29 INFO - 'PWD': '/builds/slave/test', 08:38:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:38:29 INFO - 'SHELL': '/bin/bash', 08:38:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OZDFNAqmja/Listeners', 08:38:29 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 08:38:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:38:29 INFO - 'USER': 'cltbld', 08:38:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:38:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:38:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:29 INFO - 'XPC_FLAGS': '0x0', 08:38:29 INFO - 'XPC_SERVICE_NAME': '0', 08:38:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:38:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:29 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)) 08:38:29 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)) 08:38:29 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)) 08:38:29 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)) 08:38:29 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)) 08:38:29 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)) 08:38:29 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)) 08:38:29 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)) 08:38:29 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)) 08:38:29 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)) 08:38:29 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)) 08:38:29 INFO - Cleaning up... 08:38:29 INFO - Return code: 0 08:38:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08: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')]} 08:38:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08: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')]} 08:38:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c5c8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5d8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2e1d97170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c467e00>, '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 0x10c290db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c462b20>, '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.tLjDsv5zZ1/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.OZDFNAqmja/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 08: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', 'jsonschema'] in /builds/slave/test/build 08: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 jsonschema 08:38:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tLjDsv5zZ1/Render', 08:38:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:38:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:38:29 INFO - 'HOME': '/Users/cltbld', 08:38:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:38:29 INFO - 'LOGNAME': 'cltbld', 08:38:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:29 INFO - 'MOZ_NO_REMOTE': '1', 08:38:29 INFO - 'NO_EM_RESTART': '1', 08:38:29 INFO - 'PAGER': '/bin/cat', 08:38:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:38:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:29 INFO - 'PWD': '/builds/slave/test', 08:38:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:38:29 INFO - 'SHELL': '/bin/bash', 08:38:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OZDFNAqmja/Listeners', 08:38:29 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 08:38:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:38:29 INFO - 'USER': 'cltbld', 08:38:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:38:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:38:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:29 INFO - 'XPC_FLAGS': '0x0', 08:38:29 INFO - 'XPC_SERVICE_NAME': '0', 08:38:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:38:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:29 INFO - Downloading/unpacking jsonschema 08: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 08: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 08: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 08: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 08: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 08: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 08:38:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:38:31 INFO - Downloading/unpacking functools32 (from jsonschema) 08: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 08: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 08: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 08: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 08: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 08: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 08:38:32 INFO - Downloading functools32-3.2.3-2.tar.gz 08:38:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:38:32 INFO - warning: no files found matching '*.txt' 08:38:32 INFO - no previously-included directories found matching 'build' 08:38:32 INFO - no previously-included directories found matching 'dist' 08:38:32 INFO - no previously-included directories found matching '.git*' 08:38:32 INFO - Installing collected packages: jsonschema, functools32 08:38:32 INFO - Running setup.py install for functools32 08:38:32 INFO - warning: no files found matching '*.txt' 08:38:32 INFO - no previously-included directories found matching 'build' 08:38:32 INFO - no previously-included directories found matching 'dist' 08:38:32 INFO - no previously-included directories found matching '.git*' 08:38:32 INFO - Successfully installed jsonschema functools32 08:38:32 INFO - Cleaning up... 08:38:32 INFO - Return code: 0 08:38:32 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:38:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c5c8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5d8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2e1d97170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c467e00>, '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 0x10c290db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c462b20>, '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.tLjDsv5zZ1/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.OZDFNAqmja/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 08:38:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:38:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:38:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tLjDsv5zZ1/Render', 08:38:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:38:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:38:32 INFO - 'HOME': '/Users/cltbld', 08:38:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:38:32 INFO - 'LOGNAME': 'cltbld', 08:38:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:32 INFO - 'MOZ_NO_REMOTE': '1', 08:38:32 INFO - 'NO_EM_RESTART': '1', 08:38:32 INFO - 'PAGER': '/bin/cat', 08:38:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:38:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:32 INFO - 'PWD': '/builds/slave/test', 08:38:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:38:32 INFO - 'SHELL': '/bin/bash', 08:38:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OZDFNAqmja/Listeners', 08:38:32 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 08:38:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:38:32 INFO - 'USER': 'cltbld', 08:38:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:38:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:38:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:32 INFO - 'XPC_FLAGS': '0x0', 08:38:32 INFO - 'XPC_SERVICE_NAME': '0', 08:38:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:38:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:33 INFO - Downloading/unpacking flake8 08:38:33 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 08:38:33 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 08:38:33 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 08:38:33 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 08:38:33 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 08:38:33 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 08:38:35 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:38:35 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:38:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:35 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:38:35 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:38:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:36 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:38:36 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 08:38:36 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 08:38:36 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 08:38:36 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 08:38:36 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 08:38:36 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 08:38:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:38:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:38:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:38:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:38:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:38:36 INFO - no previously-included directories found matching 'docs/_build' 08:38:36 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:38:36 INFO - Running setup.py install for pep8 08:38:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:38:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:38:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:38:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:38:36 INFO - no previously-included directories found matching 'docs/_build' 08:38:37 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:38:37 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:38:37 INFO - Cleaning up... 08:38:37 INFO - Return code: 0 08:38:37 INFO - Running post-action listener: _resource_record_post_action 08:38:37 INFO - Running post-action listener: _start_resource_monitoring 08:38:37 INFO - Starting resource monitoring. 08:38:37 INFO - ##### 08:38:37 INFO - ##### Running install step. 08:38:37 INFO - ##### 08:38:37 INFO - Running pre-action listener: _resource_record_pre_action 08:38:37 INFO - Running main action method: install 08:38:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:38:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:38:37 INFO - Reading from file tmpfile_stdout 08:38:37 INFO - Detecting whether we're running mozinstall >=1.0... 08:38:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:38:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:38:37 INFO - Reading from file tmpfile_stdout 08:38:37 INFO - Output received: 08:38:37 INFO - Usage: mozinstall [options] installer 08:38:37 INFO - Options: 08:38:37 INFO - -h, --help show this help message and exit 08:38:37 INFO - -d DEST, --destination=DEST 08:38:37 INFO - Directory to install application into. [default: 08:38:37 INFO - "/builds/slave/test"] 08:38:37 INFO - --app=APP Application being installed. [default: firefox] 08:38:37 INFO - mkdir: /builds/slave/test/build/application 08:38:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:38:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 08:39:11 INFO - Reading from file tmpfile_stdout 08:39:11 INFO - Output received: 08:39:11 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:39:11 INFO - Running post-action listener: _resource_record_post_action 08:39:11 INFO - ##### 08:39:11 INFO - ##### Running run-tests step. 08:39:11 INFO - ##### 08:39:11 INFO - Running pre-action listener: _resource_record_pre_action 08:39:11 INFO - Running main action method: run_tests 08:39:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:39:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:39:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:39:11 INFO - 2016-04-09 08:39:11.028 screenresolution[1655:8244] starting screenresolution argv=screenresolution get 08:39:11 INFO - 2016-04-09 08:39:11.031 screenresolution[1655:8244] Display 0: 1600x1200x32@60 08:39:11 INFO - 2016-04-09 08:39:11.037 screenresolution[1656:8246] starting screenresolution argv=screenresolution list 08:39:11 INFO - Available Modes on Display 0 08:39:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:39:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:39:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:39:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:39:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:39:11 INFO - Intel Iris: 08:39:11 INFO - Chipset Model: Intel Iris 08:39:11 INFO - Type: GPU 08:39:11 INFO - Bus: Built-In 08:39:11 INFO - VRAM (Dynamic, Max): 1536 MB 08:39:11 INFO - Vendor: Intel (0x8086) 08:39:11 INFO - Device ID: 0x0a2e 08:39:11 INFO - Revision ID: 0x0009 08:39:11 INFO - Displays: 08:39:11 INFO - Display: 08:39:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:39:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:39:11 INFO - Display Serial Number: 1600x1200 60 08:39:11 INFO - Main Display: Yes 08:39:11 INFO - Mirror: Off 08:39:11 INFO - Online: Yes 08:39:11 INFO - Rotation: Supported 08:39:11 INFO - Return code: 0 08:39:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:39:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:39:11 INFO - Python 2.7.3 08:39:11 INFO - Return code: 0 08:39:11 INFO - grabbing minidump binary from tooltool 08:39: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')]} 08:39:11 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 0x10c467e00>, '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 0x10c290db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c462b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:39:11 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 08:39:11 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 08:39:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:39:11 INFO - Return code: 0 08:39:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:39:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:39:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:39:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:39:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:39:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:39:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:39:12 INFO - Return code: 0 08:39:12 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/D3QUcp0iQOe4jGHfeagZ2w/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0023', '--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 08:39:12 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/D3QUcp0iQOe4jGHfeagZ2w/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0023 --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 08:39:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tLjDsv5zZ1/Render', 08:39:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:39:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:39:12 INFO - 'HOME': '/Users/cltbld', 08:39:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:39:12 INFO - 'LOGNAME': 'cltbld', 08:39:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:39:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:39:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:12 INFO - 'MOZ_NO_REMOTE': '1', 08:39:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:39:12 INFO - 'NO_EM_RESTART': '1', 08:39:12 INFO - 'PAGER': '/bin/cat', 08:39:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:39:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:12 INFO - 'PWD': '/builds/slave/test', 08:39:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:39:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:39:12 INFO - 'SHELL': '/bin/bash', 08:39:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OZDFNAqmja/Listeners', 08:39:12 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 08:39:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:39:12 INFO - 'USER': 'cltbld', 08:39:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:39:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:39:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:12 INFO - 'XPC_FLAGS': '0x0', 08:39:12 INFO - 'XPC_SERVICE_NAME': '0', 08:39:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:39:12 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/D3QUcp0iQOe4jGHfeagZ2w/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0023', '--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 08:39:12 INFO - mozversion application_buildid: 20160409071138 08:39:12 INFO - mozversion application_changeset: d62963756d9a9d19cbbb5d8f3dd3c7cfa8fdef88 08:39:12 INFO - mozversion application_display_name: Nightly 08:39:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:39:12 INFO - mozversion application_name: Firefox 08:39:12 INFO - mozversion application_remotingname: firefox 08:39:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:39:12 INFO - mozversion application_vendor: Mozilla 08:39:12 INFO - mozversion application_version: 48.0a1 08:39:12 INFO - mozversion platform_buildid: 20160409071138 08:39:12 INFO - mozversion platform_changeset: d62963756d9a9d19cbbb5d8f3dd3c7cfa8fdef88 08:39:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:39:12 INFO - mozversion platform_version: 48.0a1 08:39:12 INFO - using testdate: 1460216352 08:39:12 INFO - actual date: 1460216352 08:39:12 INFO - starting webserver on 'localhost:49275' 08:39:12 INFO - SUITE-START | Running 2 tests 08:39:12 INFO - TEST-START | dromaeo_css 08:39:12 INFO - operating with platform_type : mac_ 08:39:12 INFO - Initialising browser for dromaeo_css test... 08:39:12 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmpHT2Pmq/profile http://localhost:49275/getInfo.html) 08:39:14 INFO - PROCESS | 1674 | __metrics Screen width/height:1600/1200 08:39:14 INFO - PROCESS | 1674 | colorDepth:24 08:39:14 INFO - PROCESS | 1674 | Browser inner width/height: 1024/689 08:39:14 INFO - PROCESS | 1674 | __metrics 08:39:15 INFO - PROCESS | 1674 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:39:15 ERROR - PROCESS | 1674 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:39:15 INFO - TEST-INFO | 1674: exit 0 08:39:15 INFO - Browser initialized. 08:39:15 INFO - Running cycle 1/1 for dromaeo_css test... 08:39:15 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmpHT2Pmq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:39:27 INFO - PROCESS | 1677 | RSS: Main: 237498368 08:39:27 INFO - PROCESS | 1677 | 08:40:18 INFO - PROCESS | 1677 | 1460216418943 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] 08:42:28 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 08:42:30 INFO - PROCESS | 1677 | RSS: Main: 333287424 08:42:30 INFO - PROCESS | 1677 | 08:45:33 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 08:45:33 INFO - PROCESS | 1677 | RSS: Main: 376328192 08:45:33 INFO - PROCESS | 1677 | 08:48:35 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 08:48:36 INFO - PROCESS | 1677 | RSS: Main: 377073664 08:48:36 INFO - PROCESS | 1677 | 08:51:38 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 08:51:39 INFO - PROCESS | 1677 | RSS: Main: 336613376 08:51:39 INFO - PROCESS | 1677 | 08:54:42 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 08:54:42 INFO - PROCESS | 1677 | RSS: Main: 335683584 08:54:42 INFO - PROCESS | 1677 | 08:57:45 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 08:57:45 INFO - PROCESS | 1677 | RSS: Main: 384196608 08:57:45 INFO - PROCESS | 1677 | 08:57:45 INFO - PROCESS | 1677 | __start_tp_report 08:57:45 INFO - PROCESS | 1677 | _x_x_mozilla_page_load 08:57:45 INFO - PROCESS | 1677 | _x_x_mozilla_page_load_details 08:57:45 INFO - PROCESS | 1677 | |i|pagename|runs| 08:57:45 INFO - PROCESS | 1677 | |0;dojo.html;3386.661333866613;3432.914177145571;3467;3473.3747925373423;3508.2281897982452;5550.944490555094;5605.7197140142935;5687.800926967557;5709.914351284729;5710.200571919934;5625.156226566017;5674.744636491358;5677.17680936264;5680.488756011958;5689.459501347375;5100.234964755288;5131.461196574362;5157.7936882524655;5161.4322424533275;5207.817726379578;5213.791448342062;5215.687058776485;5215.713135777531;5217.895642087156;5223.686578805284;5145.6398052136365;5175.508326708976;5179.948200517984;5198.662086964354;5264.184051472028;5189.195674670432;5263.921041184385;5264.947010597895;5268.315119034501;5318.25544423781;5021.14640511114;5064.56951159152;5088.491150884919;5186.7147306898105;5197;5522.972385138049;5558.833235002957;5585.776568937237;5595.1886976388605;5656.547476201894;6241.063840423927;6253.687315634245;6271.466925311354;6286.937130628681;6289.182406287199;6071.909439984033;6137.447629713302;6265.812025639192;6316.778912738078;6327.24073111225;5778.133280008033;5780.797672081457;5796.855078623026;5809.767609295665;5815.534757219412;6305.18032655761;6310.652914089677;6317.3366796486625;6322.114903913456;6328.17733694626;6006.699665016732;6062.575619706667;6137.376985335611;6141.662208578571;6144.539159563051;6219.751209951552;6226.501879849601;6266.686665666698;6278.30938596754;6291;6148.231471066117;6206.379362063848;6215.533834962396;6222.62664240147;6240.563160578716;6086.452219300196;6122.093225952662;6162.5378096642935;6173.41352571505;6233.345498722569;4906.5280415875095;4912.508749125059;4914.164592019365;4915.606751459946;4931.309616653672;4413.58070983256;4427.114577084596;4433.113377324548;4437.911241775211;4460.665450091256;4591.632669386441;5611.775528978795;5666.660000399989;5675.120356344773;5686.459786320293;6259.624422534663;6297.496200304056;6298.212723409574;6314;6316.210473690789;5597.664140151523;5663.093904975184;5665.6034077614995;5682.715864206773;5710.086386178275;5258.553022993012;5335.786568537215;5356.384015838151;5402.081646120169;5404.756785944642;6346.079818426302;6361.554691171574;6366.427021568081;6368.554201205871;6377.3303803100935;6321.367863213642;6334.239891213084;6336.524760642878;6343.397377249154;6355.936440635534;6257.624542527463;6278.309385967631;6307.369263073656;6329.303776584664;6366.108744775643;6190.907136392868;6196.225471816023;6220.191375121205;6220.844478888064;6236.18929539157;6317.115603815561;6329.303776584664;6330.39861213184;6347.016212487072;6350.904736428864;5884.146798714077;6057.697115144313;6107.037103281039;6136.85608443425;6141.731496609813;5293.311869456946;5978.551608629283;6128.1726966858905;6128.479079278133;6130.785422510191;5601.271834661468;5923.496502797138;5943.64338139713;5947.940520594739;5965.522758179422;6017.548683848641;6051.33435322123;6085;6125.816225513242;6135.355787642234;5857.531397488276;5877.529797616095;5890.204822348928;5906.645601263938;5913.319968203539 08:57:45 INFO - PROCESS | 1677 | |1;ext.html;479.9736014519201;490.65163733749034;523.2230138244706;530.9487215313679;586.5893874287999;28700.56949145762;29177.416451670953;29207.707922920763;29228;29250.97621583245;38192.80903595478;39407;39515.0121246969;39605.60394396055;39606;8129.4715843470285;8133.959330203341;9285.860712089307;9565.330426870121;9581.041895810433;9490.288228382864;9660.661876834312;9670.178034867045;9672.854907176397;9682.177014953737;9586.712398628053;9658.227341812673;9684.854727179098;9687.806243875119;9694.854577181313;9555;9602.615895364177;9605.039496050409;9606.855897161548;9610.75973100671;9509.239260859184;9611;9627.951860240724;9643.517824108767;9649.276304277137;39026;39462.80268598667;39511.40732889009;39517.60482395168;39615.60384396148;3165.4618714818534;3277.0332751838264;3316.1875340541483;3355.07735372772;3412.6246112927556;27632;27800;28332.575011374847;28617;28634.427311453863;2734.6991830898587;2755.6830964438946;2788.2750484874077;2852.686204517501;2899.6375453068367;468888;469078;469331;469343.65328173485;470286;44248.77875610601;58604.53488662732;58984.410155897895;59016.40983590195;59142.70428647829;59890;60195.69902150461;66225.33774662288;67559.66220168868;67789.25475216786;16306.184690765414;16541.917290413712;16559.751603725952;16559.83440165607;16569.751453728204;12527.686807829878;12628.81056784149;12654.177478463871;12661.93669031649;12693.555725549562;18833.434996950113;18893.7165942511;18914;18920;18963.715544266848;6576.835579110465;7619.456952516995;7805.336546393507;7817.921820781833;7919.84160316802;770.7186876790043;954.9761255968656;969.5787210320959;1030.4796077980573;1061.6231237910586;26687.733122668913;27002.459950800872;27313.863430683115;27341.258335749317;27381.86309068442;899.869518919766;974.4007435427161;1062.3838173859144;1065.6430095917954;1151.3437340715711;13853.376598053112;14120.364583593762;14146.646333841736;14384.208868512123;14428.639284017983;593921;597907;599509;601038.9948050319;601510;56323.71838140783;58440.707796460745;58473.70763146242;58732.70633646804;58802.705986469795;1249.9437525311382;1306.6994591243877;1309.0247765414827;1451.6153219396867;1566;20313.79686203119;30097;30320.84839575788;30374;30959.380812384075;51068.74465627648;52176.739116304176;52216.47783522116;52220;52302;568281;578518;579042;579326;579918;22614.095436182368;25631.487370252864;26039.609405859304;26473.867630662495;26496.735032649427;41089.79455102705;41481.58518414777;42907.35638965481;43174.78412607917;43255.351169733105;35809.46285805663;36091;36225.27549448943;37017.259654806214;37094.44358334681;34962.300753985284;35404.822975884956;35957.28085438224;36175.81912090423;36296.63703363038;28261.02103178122;35152.64847351596;36009.459858101625;36791.44812827863;36929.63070369369;29942.401151977276;30765.232688310185;31849.566769494966;32140.67859321377;32285;20693.58612827705;22453.77546224517;22606.94092026157;23503.647445288676;23727.64408533839 08:57:45 INFO - PROCESS | 1677 | |2;jquery.html;377.29634232157036;389.3225787130392;392.3663283796668;398.2214770124405;401.9753086419753;14001.052636756713;19676.606467870668;19679.409617711455;20606.896965515152;20617;15494.999999999973;16136.83863161368;19563.413097607096;19829.008549572536;19839.5040123997;5674.631148975313;5955.940440595582;5987.610805297663;6008.699565021753;6009.759609615632;5769.798057068004;5965.582409231334;5998.9700051499685;6023.2169817923605;6122.632642041492;3862.8454861805494;4104.076582768868;4107.589241075883;4111.424400583921;4113.465249517559;5676.205331253628;6015.879682406371;6108.786192483286;6114.3579924108;6115.082737589375;5648.491635752802;5849.912251316234;5881.441263080001;5881.764729410818;5891;13158.934205329007;13422.664433389145;16607.08661023643;24235.394115147086;25608.74391256082;1860.8697391182623;2050.917963281467;2113.651247544153;2269.761675024115;2303.0787684925995;9413.90586094144;9795.804083918281;9801.264905132073;9991.90008099917;10011.349262298;1624.4801663467695;1639.3032960991532;1656.8757343199309;1669.2404955745228;1758.8842109463787;91506.5424672879;95536.08927821404;96450;98182.99999999929;108103;11103.44482775858;11499.655010349703;11550.306981581132;11587.826182607268;11742.70643233909;14894.255287235595;14940.775888361683;14970.026948248329;15000.174990375415;15004.849951500564;8327.750167494985;8530.488170709654;8539.316854651614;8620.827583448296;8645;8287.12985136552;8317.625706843206;8349.29031032357;8440.029396619344;8456.957715211385;4525;4610;4624.375709279271;4677.836275730401;4716.551927566876;1623.448027670574;1896.3268039845932;1945.1538580717433;1951.5316324082119;1993.1728332742039;713.9612505678193;915.391264808908;926.9304802139867;944.976375590602;987.160913223754;18979.620407592047;19109.85340879524;19337.903310483638;19945.800541994686;20454;916.4313667211519;954.2938225713061;958.8465845464832;980.2696990741942;980.9313348065567;7763.2236776321915;10321.019503147189;10409.42748148859;10432.895671043345;10600.893991060146;609420;616979;620240.8987955032;635487;636041;132455;133068.3346583261;133782;134215.6578434203;138979;961.3462845265286;978.2614126334572;993.478423827482;994.4282037828277;1017.9999999999852;17245.65508689794;17571.56071098233;17580.208890599697;17583.472495825146;18009.549761256072;35453.82273088618;46232.76883615561;46818.53181468142;46920.7653961728;49126.75436622794;66314;70295;70869.29130708834;71100;74676.62661686656;8020.478668886503;8095.635696393559;8097.473664211808;8165.755027349189;8196.262336389753;9043.457392556467;12187.964023058139;12409.751804964031;12492.25046497213;12635.684107897376;10360.222983276435;10704.518296676824;10751.247412681038;10865.78268434611;11040.558377664804;10435.634752783617;10507.161246781936;10608.681739547827;10745.838812417664;10937.781244375226;10858.294210876267;11108.333499990027;11225.66323010311;11276.210665253353;11277.71805704831;7926.881096783438;8072;8086.15095414973;8097.1497992712275;8372.832543349221;8237.217464340878;10524.473776311306;10579.62971296001;10899.29154604948;11070.501827417624 08:57:45 INFO - PROCESS | 1677 | |3;mootools.html;1394.78380850968;1574.5906064423255;1590.7772911792347;1846.2522678315288;1979.0500559731338;7750.341220996215;8605.91394086059;8878.15657512537;8878.200961913435;8879.378443508956;8530.57347132644;8719.346049046331;8749.25631321337;8776.868346974785;8781.297496200305;2439.4511234972165;2466.260121963413;2490.638857365681;2490.7011158660894;2492.7756501914823;1928.797476264993;2351.6825228594175;2426.0538390027905;2494.7006359236916;2500.499900020003;2184.4757258258064;2196.428928478599;2467.5064987002584;2501.3621526510715;2502.612095125249;2333.346662934381;2351.47091904321;2356.6229403295392;2365.2667673021333;2365.9408514787183;2357.4931389751114;2440.341107900857;2461.54461424637;2462.1997850698594;2466.1738317663603;8879.245264152554;8959.865602015974;8960.8655870162;8970.372073954826;9006.504642244674;5301.893962120775;5478.260434841325;5497.725113744297;5516.475934786189;5527.695976721278;3365.5961284645755;3402.2344972381015;3421.6920477157178;3461.2212252243294;3464.3764122457947;950.7718147644584;975.3952549419334;984.2716389871443;984.7538115471132;987.7036888933363;11590;11605.30368177912;11607.593734219261;11642.417879106011;11645.010174135208;4641.350210970467;4722.5513576210205;4765.833195838199;4824.0834241494;4833.975830120827;9579.233661307218;9590.520473976274;9596.472194029257;9598.95200524007;9611.951940240393;5358.490943360374;5359.196120581944;5382.596305277119;5420.891582168335;5507.807226747044;4326.805293761725;4364.388985542027;4936.086823937583;4946.332245146859;4976.850694479172;3980.383040628707;4006.8797936061965;4096.32410652245;4110.095778928631;4142.606452387018;1336.411978729356;1342.3020029584561;1344.798280257969;1358.5448874626913;1361.9659508512168;950.1401231885155;995.64654547636;1148.3741360958131;1269.6127681057367;1404.3610157378369;7517.721987262178;7981.2018798119725;8014.599270036591;8122.634481448349;8139.593020348959;1153.9307641541534;1205.873383294759;1206.5415142246065;1207.885250901163;1218.3542722357165;6268.749250030039;6273;6361.650109244036;6422.6467544285515;6433.195850518685;10346.793064138825;10579;10583.100436462833;10678.038976492153;10710.625128120479;10346.896531034743;10547.789044219226;10613.681589552325;10690.839637405445;10704.89295107039;8071.919280807234;8170.428070035159;8194.34445244367;8198;8217.95891020553;7712.344450721752;7862.292393684367;7987.161348058603;7990.440669153336;8014.398920080901;9127.58925848325;9144.58849351794;9703.757406064904;9758.170555502862;10005.399676019462;9834.360766550151;9938.354006989523;10195.898041019494;10236.744081398025;10257.846132307872;7366.852662946818;7473.402127829652;7592.8481430369975;7597.6581053851605;7615.086189657055;6772.796816095525;8177.918220817954;8208.671653133808;8222.424430289822;8242.381821363542;7320.084989376328;7450.329470347478;7480.925190748023;7580.128285247267;7597.848043038997;7158.355747982707;7270.382017528569;7284.854302913806;7396.223396543501;7455.179930207782;7680.846383072196;7764.417668674985;7764.92235077642;7772.650230739518;7773;6741.359570840762;6964.721411143701;7053.894191587027;7077.964610176916;7082.964585177041;7089.929100708927;7121.501494895308;7164.785056448315;7169.139703235645;7169.211386747558 08:57:45 INFO - PROCESS | 1677 | |4;prototype.html;316.1810909743764;317.8871500617281;323.79924446842955;326.91173383186526;327.81314650649125;4808.687435316702;5742.799002034924;5837.824865254039;5842.182094506762;5864.3256025557075;5688.696078088381;5700.5202736809415;5729.512991395726;5744.156642461977;5756.481916627503;3474.461458473928;3495.860165593386;3594.867616700731;4297.570242975708;4357.564243575641;3827.655511004009;3957.821898014596;4315.309550471925;4331.328644060176;4354.1944740223;4321.740695558261;4346.5436129206455;4354.390385346054;4359.847405340814;4378.846740364088;4091.652209562191;4162.791860406998;4347.130573885235;4347.587034213893;4372.672049596277;3753;3760.793156376398;3760.868369607078;3776.2636285924254;3791.184895247535;5490.313710786152;5494.697791621459;5505.779768809243;5511.834644960658;5511.917321240185;4810.89349449625;5003.448241396877;5015.824446144367;5024.447310795809;5063.594912406998;5699.544036477072;5864.149698293766;5961.493273071794;5974.8506287342725;5979.431953964367;3692.8522859085606;3697.574778900434;3850.306944749944;4178.958210417887;4179.707420480568;5050.368703912011;6024.728887200086;6244.6253224806205;6391.616503009788;6399.26408463028;4126.91746165075;4216.325387937976;4240.385144154142;4242.830286788494;4265.253580623378;4334.5882141196535;4346.174226896879;4364.170807546556;4366.694331396835;4366.8034938427845;4854.863859901632;4893.882646691635;4980.576650984634;4986.825461108844;5027.723475208825;5882.3529411764675;6051.425114614105;6074.0281554951;6129.938700613026;6130.570860039755;1333.4666133546466;1400.859914008591;1480.9111453312835;1484.1317829070115;1491.3736230783097;972.2076507646245;996.3971797062818;1012.4633944009687;1013.6756238003916;1021.8313978193663;4961.50384961501;5660;5661.716914154358;5690.943090569124;5705.803265742719;5496.422875598085;5598.964191624563;6291.213598300213;6304.716287767062;6324.33594472583;4904.509549045067;5119.718415487109;5451.48210919962;5626.381098079208;5707.885842283131;2629.6318515407856;3205.1506350817053;3273.5580696605653;3299.1422230220314;3306.669333066722;5294.867628309323;6254.530910181755;6585.209774827052;6594.802155935329;6612.09068010074;6020.488258497989;6118.898598252357;6440.194975628046;6465.806025819139;6473.248869230558;6566.704498297588;6591.43972762311;6593.6703164841565;6602.3397660233595;6610;5303.655262408085;5967.940320596738;6169.020981467019;6244.687765611792;6290.779822706183;5970.910436343372;6125.754969801336;6156.476699480594;6164.630122192682;6174.413430724074;6019.367966363468;6092.75628974836;6351.650659213788;6485.513586480938;6525.8694826104165;3365.3942290386985;4011.5988401159652;4253.234417804825;4290.334998075304;4402.977985110054;5550.419055139379;6247.281562620356;6296.212973378328;6297.905531416941;6313.179286692701;5940.198073260054;6073.635581864925;6097.908531371944;6101.176341193882;6159.260888693386;4914.189158788759;5771.711414429178;5939.910901336397;6101.115338275837;6107.206063211932;5660.207570940154;5943;5967.492763115184;5979.910301345396;6058.666773327333;5375.4087050425205;6151.477124444294;6155.47678447337;6158.445739883432;6196.783112591038;6002.879942401215;6017.909731354121;6046.123312119806;6049.153118563493;6057.42454466825 08:57:45 INFO - PROCESS | 1677 | |5;yui.html;627.6579264300956;644.6647743173553;758.9165191828898;760.1714131596563;776.6776787633136;15080.095194288337;15151;15315.770263446057;15378.307976141072;15379.23103844806;14133.222672752994;14188.290585470711;14202.14787112774;14210.928945355285;14234.644133896658;910.1626503616671;945.3052006775015;946.8248374050788;947.9194268487187;951.7763325618474;733.6368497593699;749.1759065028452;927.332320729074;937.3906960475678;944.9794222239964;965.937214081086;992.0773680477154;994.9502524873764;995.9850602240936;996.2329006664863;980.5048450532436;981.0336818234034;983.7491439682907;984.5667906121283;985.3841349156777;562.2381672833293;711.0827033127259;730.9634518274119;734.5005396330494;737.0602481835703;15593.22033898312;15637;15666.373345066184;15669.21653917311;15701.842981570153;10351.430671313075;12287;12306.26162430248;12644.620661380173;12761.425735841909;9959.352642078242;10058.195344372505;10112.393256404639;10474.47627618616;10505.52725127371;3399.201187720884;3455.378031954247;3472.739544534145;3519.7184225261917;3721.6650501455;81913.59043204805;82030.94922626922;85845;87403.12596874013;87809.56095219548;9116.386498150723;9261.120193581733;9367.62529498826;9617.663381781604;9631.988641192715;21132.683009754866;21227.257046003626;21237.150513979577;21271.574568508542;21276.78723212779;7154.713811447588;7354.632268386559;7427.925720742724;7437.628118594049;7525.661345239368;3869.3615553433933;4142.109446469024;4167.74993500391;4173.749575025508;4198.538160802309;3022.30486987994;3479.356319080978;3575.1598374382;3581.767185132958;3589.9282014360087;627.3663599764271;641.8868487833968;643.5495153392644;650.8665723526666;651.1014799576554;496.8087286394764;499.53792741713767;532.2335836395578;599.5952731905946;618.3785295777715;7514.774556763306;7941.404394670423;8096.028476582847;8198.877016844752;8218.383621228431;511.9283300337956;512.3032675561234;526.6971491392464;547.6276132230122;548.18047019705;3721.962780372216;3756.154865155373;3774.5659249186697;3946.4672269243283;4019.055521952339;86353.70469442963;89562.55218723865;91857.08142918485;92096;93165.5341723287;60648.696756516816;71525.21186970368;71636;75782.31632627574;77251.84122238171;53368;60058;60403.395966039774;63455;63753.362466376595;7824.139344671968;7960.6417711201975;8000.319972802377;8139.348852091937;8263.256306932164;40407.3938890911;40506.594934050285;40581.59418405778;40821.18357632771;40875.18249634931;53910.92178156337;55044.174337385775;57036;57818.7109064452;58562.7071864638;10682.89317106819;10736;10791.406472643766;10936.12510999134;11248.156388270749;11837.704057398634;11898.76202475963;11916.821247681119;12046.457909393923;12808.615741527396;11255.437228138397;11390.772184556428;11531.019863311378;11604.245724027911;11791.528338866348;11520.423978801195;11709.238899471507;11816.291022538675;11887.989520890475;12081.637550873487;10908.290961087503;10972.506237219504;11253.943730281297;11261.268017578832;11508.769824603629;9572.664956726481;9673.903260967581;9765.658201962897;9943.701688949342;9990.15083717892;9415.85876211871;9436.716898493056;9559.187469065208;9602.423854568748;9603.279754018336 08:57:45 INFO - PROCESS | 1677 | __end_tp_report 08:57:45 INFO - PROCESS | 1677 | __start_cc_report 08:57:45 INFO - PROCESS | 1677 | _x_x_mozilla_cycle_collect,1415 08:57:45 INFO - PROCESS | 1677 | __end_cc_report 08:57:45 INFO - PROCESS | 1677 | __startTimestamp1460217465927__endTimestamp 08:57:45 INFO - PROCESS | 1677 | 08:57:45 INFO - PROCESS | 1677 | ------- Summary: start ------- 08:57:45 INFO - PROCESS | 1677 | Number of tests: 6 08:57:45 INFO - PROCESS | 1677 | 08:57:45 INFO - PROCESS | 1677 | [#0] dojo.html Cycles:165 Average:5731.20 Median:5913.32 stddev:645.98 (10.9%) stddev-sans-first:621.22 08:57:45 INFO - PROCESS | 1677 | Values: 3386.7 3432.9 3467.0 3473.4 3508.2 5550.9 5605.7 5687.8 5709.9 5710.2 5625.2 5674.7 5677.2 5680.5 5689.5 5100.2 5131.5 5157.8 5161.4 5207.8 5213.8 5215.7 5215.7 5217.9 5223.7 5145.6 5175.5 5179.9 5198.7 5264.2 5189.2 5263.9 5264.9 5268.3 5318.3 5021.1 5064.6 5088.5 5186.7 5197.0 5523.0 5558.8 5585.8 5595.2 5656.5 6241.1 6253.7 6271.5 6286.9 6289.2 6071.9 6137.4 6265.8 6316.8 6327.2 5778.1 5780.8 5796.9 5809.8 5815.5 6305.2 6310.7 6317.3 6322.1 6328.2 6006.7 6062.6 6137.4 6141.7 6144.5 6219.8 6226.5 6266.7 6278.3 6291.0 6148.2 6206.4 6215.5 6222.6 6240.6 6086.5 6122.1 6162.5 6173.4 6233.3 4906.5 4912.5 4914.2 4915.6 4931.3 4413.6 4427.1 4433.1 4437.9 4460.7 4591.6 5611.8 5666.7 5675.1 5686.5 6259.6 6297.5 6298.2 6314.0 6316.2 5597.7 5663.1 5665.6 5682.7 5710.1 5258.6 5335.8 5356.4 5402.1 5404.8 6346.1 6361.6 6366.4 6368.6 6377.3 6321.4 6334.2 6336.5 6343.4 6355.9 6257.6 6278.3 6307.4 6329.3 6366.1 6190.9 6196.2 6220.2 6220.8 6236.2 6317.1 6329.3 6330.4 6347.0 6350.9 5884.1 6057.7 6107.0 6136.9 6141.7 5293.3 5978.6 6128.2 6128.5 6130.8 5601.3 5923.5 5943.6 5947.9 5965.5 6017.5 6051.3 6085.0 6125.8 6135.4 5857.5 5877.5 5890.2 5906.6 5913.3 08:57:45 INFO - PROCESS | 1677 | 08:57:45 INFO - PROCESS | 1677 | [#1] ext.html Cycles:180 Average:67308.64 Median:38609.40 stddev:147391.61 (381.8%) stddev-sans-first:147719.68 08:57:45 INFO - PROCESS | 1677 | Values: 480.0 490.7 523.2 530.9 586.6 28700.6 29177.4 29207.7 29228.0 29251.0 38192.8 39407.0 39515.0 39605.6 39606.0 8129.5 8134.0 9285.9 9565.3 9581.0 9490.3 9660.7 9670.2 9672.9 9682.2 9586.7 9658.2 9684.9 9687.8 9694.9 9555.0 9602.6 9605.0 9606.9 9610.8 9509.2 9611.0 9628.0 9643.5 9649.3 39026.0 39462.8 39511.4 39517.6 39615.6 3165.5 3277.0 3316.2 3355.1 3412.6 27632.0 27800.0 28332.6 28617.0 28634.4 2734.7 2755.7 2788.3 2852.7 2899.6 468888.0 469078.0 469331.0 469343.7 470286.0 44248.8 58604.5 58984.4 59016.4 59142.7 59890.0 60195.7 66225.3 67559.7 67789.3 16306.2 16541.9 16559.8 16559.8 16569.8 12527.7 12628.8 12654.2 12661.9 12693.6 18833.4 18893.7 18914.0 18920.0 18963.7 6576.8 7619.5 7805.3 7817.9 7919.8 770.7 955.0 969.6 1030.5 1061.6 26687.7 27002.5 27313.9 27341.3 27381.9 899.9 974.4 1062.4 1065.6 1151.3 13853.4 14120.4 14146.6 14384.2 14428.6 593921.0 597907.0 599509.0 601039.0 601510.0 56323.7 58440.7 58473.7 58732.7 58802.7 1249.9 1306.7 1309.0 1451.6 1566.0 20313.8 30097.0 30320.8 30374.0 30959.4 51068.7 52176.7 52216.5 52220.0 52302.0 568281.0 578518.0 579042.0 579326.0 579918.0 22614.1 25631.5 26039.6 26473.9 26496.7 41089.8 41481.6 42907.4 43174.8 43255.4 35809.5 36091.0 36225.3 37017.3 37094.4 34962.3 35404.8 35957.3 36175.8 36296.6 28261.0 35152.6 36009.5 36791.4 36929.6 29942.4 30765.2 31849.6 32140.7 32285.0 20693.6 22453.8 22606.9 23503.6 23727.6 08:57:45 INFO - PROCESS | 1677 | 08:57:45 INFO - PROCESS | 1677 | [#2] jquery.html Cycles:180 Average:34436.15 Median:400.10 stddev:103632.74 (25901.8%) stddev-sans-first:103891.90 08:57:45 INFO - PROCESS | 1677 | Values: 377.3 389.3 392.4 398.2 402.0 14001.1 19676.6 19679.4 20606.9 20617.0 15495.0 16136.8 19563.4 19829.0 19839.5 5674.6 5955.9 5987.6 6008.7 6009.8 5769.8 5965.6 5999.0 6023.2 6122.6 3862.8 4104.1 4107.6 4111.4 4113.5 5676.2 6015.9 6108.8 6114.4 6115.1 5648.5 5849.9 5881.4 5881.8 5891.0 13158.9 13422.7 16607.1 24235.4 25608.7 1860.9 2050.9 2113.7 2269.8 2303.1 9413.9 9795.8 9801.3 9991.9 10011.3 1624.5 1639.3 1656.9 1669.2 1758.9 91506.5 95536.1 96450.0 98183.0 108103.0 11103.4 11499.7 11550.3 11587.8 11742.7 14894.3 14940.8 14970.0 15000.2 15004.8 8327.8 8530.5 8539.3 8620.8 8645.0 8287.1 8317.6 8349.3 8440.0 8457.0 4525.0 4610.0 4624.4 4677.8 4716.6 1623.4 1896.3 1945.2 1951.5 1993.2 714.0 915.4 926.9 945.0 987.2 18979.6 19109.9 19337.9 19945.8 20454.0 916.4 954.3 958.8 980.3 980.9 7763.2 10321.0 10409.4 10432.9 10600.9 609420.0 616979.0 620240.9 635487.0 636041.0 132455.0 133068.3 133782.0 134215.7 138979.0 961.3 978.3 993.5 994.4 1018.0 17245.7 17571.6 17580.2 17583.5 18009.5 35453.8 46232.8 46818.5 46920.8 49126.8 66314.0 70295.0 70869.3 71100.0 74676.6 8020.5 8095.6 8097.5 8165.8 8196.3 9043.5 12188.0 12409.8 12492.3 12635.7 10360.2 10704.5 10751.2 10865.8 11040.6 10435.6 10507.2 10608.7 10745.8 10937.8 10858.3 11108.3 11225.7 11276.2 11277.7 7926.9 8072.0 8086.2 8097.1 8372.8 8237.2 10524.5 10579.6 10899.3 11070.5 08:57:45 INFO - PROCESS | 1677 | 08:57:45 INFO - PROCESS | 1677 | [#3] mootools.html Cycles:180 Average:6026.76 Median:5522.09 stddev:3164.97 (57.3%) stddev-sans-first:3154.70 08:57:45 INFO - PROCESS | 1677 | Values: 1394.8 1574.6 1590.8 1846.3 1979.1 7750.3 8605.9 8878.2 8878.2 8879.4 8530.6 8719.3 8749.3 8776.9 8781.3 2439.5 2466.3 2490.6 2490.7 2492.8 1928.8 2351.7 2426.1 2494.7 2500.5 2184.5 2196.4 2467.5 2501.4 2502.6 2333.3 2351.5 2356.6 2365.3 2365.9 2357.5 2440.3 2461.5 2462.2 2466.2 8879.2 8959.9 8960.9 8970.4 9006.5 5301.9 5478.3 5497.7 5516.5 5527.7 3365.6 3402.2 3421.7 3461.2 3464.4 950.8 975.4 984.3 984.8 987.7 11590.0 11605.3 11607.6 11642.4 11645.0 4641.4 4722.6 4765.8 4824.1 4834.0 9579.2 9590.5 9596.5 9599.0 9612.0 5358.5 5359.2 5382.6 5420.9 5507.8 4326.8 4364.4 4936.1 4946.3 4976.9 3980.4 4006.9 4096.3 4110.1 4142.6 1336.4 1342.3 1344.8 1358.5 1362.0 950.1 995.6 1148.4 1269.6 1404.4 7517.7 7981.2 8014.6 8122.6 8139.6 1153.9 1205.9 1206.5 1207.9 1218.4 6268.7 6273.0 6361.7 6422.6 6433.2 10346.8 10579.0 10583.1 10678.0 10710.6 10346.9 10547.8 10613.7 10690.8 10704.9 8071.9 8170.4 8194.3 8198.0 8218.0 7712.3 7862.3 7987.2 7990.4 8014.4 9127.6 9144.6 9703.8 9758.2 10005.4 9834.4 9938.4 10195.9 10236.7 10257.8 7366.9 7473.4 7592.8 7597.7 7615.1 6772.8 8177.9 8208.7 8222.4 8242.4 7320.1 7450.3 7480.9 7580.1 7597.8 7158.4 7270.4 7284.9 7396.2 7455.2 7680.8 7764.4 7764.9 7772.7 7773.0 6741.4 6964.7 7053.9 7078.0 7083.0 7089.9 7121.5 7164.8 7169.1 7169.2 08:57:45 INFO - PROCESS | 1677 | 08:57:45 INFO - PROCESS | 1677 | [#4] prototype.html Cycles:180 Average:4945.08 Median:5612.67 stddev:1539.88 (27.4%) stddev-sans-first:1504.49 08:57:45 INFO - PROCESS | 1677 | Values: 316.2 317.9 323.8 326.9 327.8 4808.7 5742.8 5837.8 5842.2 5864.3 5688.7 5700.5 5729.5 5744.2 5756.5 3474.5 3495.9 3594.9 4297.6 4357.6 3827.7 3957.8 4315.3 4331.3 4354.2 4321.7 4346.5 4354.4 4359.8 4378.8 4091.7 4162.8 4347.1 4347.6 4372.7 3753.0 3760.8 3760.9 3776.3 3791.2 5490.3 5494.7 5505.8 5511.8 5511.9 4810.9 5003.4 5015.8 5024.4 5063.6 5699.5 5864.1 5961.5 5974.9 5979.4 3692.9 3697.6 3850.3 4179.0 4179.7 5050.4 6024.7 6244.6 6391.6 6399.3 4126.9 4216.3 4240.4 4242.8 4265.3 4334.6 4346.2 4364.2 4366.7 4366.8 4854.9 4893.9 4980.6 4986.8 5027.7 5882.4 6051.4 6074.0 6129.9 6130.6 1333.5 1400.9 1480.9 1484.1 1491.4 972.2 996.4 1012.5 1013.7 1021.8 4961.5 5660.0 5661.7 5690.9 5705.8 5496.4 5599.0 6291.2 6304.7 6324.3 4904.5 5119.7 5451.5 5626.4 5707.9 2629.6 3205.2 3273.6 3299.1 3306.7 5294.9 6254.5 6585.2 6594.8 6612.1 6020.5 6118.9 6440.2 6465.8 6473.2 6566.7 6591.4 6593.7 6602.3 6610.0 5303.7 5967.9 6169.0 6244.7 6290.8 5970.9 6125.8 6156.5 6164.6 6174.4 6019.4 6092.8 6351.7 6485.5 6525.9 3365.4 4011.6 4253.2 4290.3 4403.0 5550.4 6247.3 6296.2 6297.9 6313.2 5940.2 6073.6 6097.9 6101.2 6159.3 4914.2 5771.7 5939.9 6101.1 6107.2 5660.2 5943.0 5967.5 5979.9 6058.7 5375.4 6151.5 6155.5 6158.4 6196.8 6002.9 6017.9 6046.1 6049.2 6057.4 08:57:45 INFO - PROCESS | 1677 | 08:57:45 INFO - PROCESS | 1677 | [#5] yui.html Cycles:180 Average:17342.98 Median:28799.12 stddev:24099.39 (83.7%) stddev-sans-first:24134.31 08:57:45 INFO - PROCESS | 1677 | Values: 627.7 644.7 758.9 760.2 776.7 15080.1 15151.0 15315.8 15378.3 15379.2 14133.2 14188.3 14202.1 14210.9 14234.6 910.2 945.3 946.8 947.9 951.8 733.6 749.2 927.3 937.4 945.0 965.9 992.1 995.0 996.0 996.2 980.5 981.0 983.7 984.6 985.4 562.2 711.1 731.0 734.5 737.1 15593.2 15637.0 15666.4 15669.2 15701.8 10351.4 12287.0 12306.3 12644.6 12761.4 9959.4 10058.2 10112.4 10474.5 10505.5 3399.2 3455.4 3472.7 3519.7 3721.7 81913.6 82030.9 85845.0 87403.1 87809.6 9116.4 9261.1 9367.6 9617.7 9632.0 21132.7 21227.3 21237.2 21271.6 21276.8 7154.7 7354.6 7427.9 7437.6 7525.7 3869.4 4142.1 4167.7 4173.7 4198.5 3022.3 3479.4 3575.2 3581.8 3589.9 627.4 641.9 643.5 650.9 651.1 496.8 499.5 532.2 599.6 618.4 7514.8 7941.4 8096.0 8198.9 8218.4 511.9 512.3 526.7 547.6 548.2 3722.0 3756.2 3774.6 3946.5 4019.1 86353.7 89562.6 91857.1 92096.0 93165.5 60648.7 71525.2 71636.0 75782.3 77251.8 53368.0 60058.0 60403.4 63455.0 63753.4 7824.1 7960.6 8000.3 8139.3 8263.3 40407.4 40506.6 40581.6 40821.2 40875.2 53910.9 55044.2 57036.0 57818.7 58562.7 10682.9 10736.0 10791.4 10936.1 11248.2 11837.7 11898.8 11916.8 12046.5 12808.6 11255.4 11390.8 11531.0 11604.2 11791.5 11520.4 11709.2 11816.3 11888.0 12081.6 10908.3 10972.5 11253.9 11261.3 11508.8 9572.7 9673.9 9765.7 9943.7 9990.2 9415.9 9436.7 9559.2 9602.4 9603.3 08:57:45 INFO - PROCESS | 1677 | -------- Summary: end -------- 08:57:45 INFO - PROCESS | 1677 | 08:57:46 INFO - TEST-INFO | 1677: exit 0 08:57:46 INFO - TEST-OK | dromaeo_css | took 1113666ms 08:57:46 INFO - TEST-START | kraken 08:57:46 INFO - operating with platform_type : mac_ 08:57:46 INFO - Initialising browser for kraken test... 08:57:46 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmpp5n0T1/profile http://localhost:49275/getInfo.html) 08:57:48 INFO - PROCESS | 1683 | __metrics Screen width/height:1600/1200 08:57:48 INFO - PROCESS | 1683 | colorDepth:24 08:57:48 INFO - PROCESS | 1683 | Browser inner width/height: 1024/689 08:57:48 INFO - PROCESS | 1683 | __metrics 08:57:48 INFO - PROCESS | 1683 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:57:48 ERROR - PROCESS | 1683 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:57:49 INFO - TEST-INFO | 1683: exit 0 08:57:49 INFO - Browser initialized. 08:57:49 INFO - Running cycle 1/1 for kraken test... 08:57:49 INFO - TEST-INFO | started process 1685 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmpp5n0T1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:58:01 INFO - PROCESS | 1685 | RSS: Main: 237170688 08:58:01 INFO - PROCESS | 1685 | 08:58:03 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 08:58:04 INFO - PROCESS | 1685 | RSS: Main: 283832320 08:58:04 INFO - PROCESS | 1685 | 08:58:07 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 08:58:07 INFO - PROCESS | 1685 | RSS: Main: 294670336 08:58:07 INFO - PROCESS | 1685 | 08:58:10 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 08:58:11 INFO - PROCESS | 1685 | RSS: Main: 281391104 08:58:11 INFO - PROCESS | 1685 | 08:58:13 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 08:58:14 INFO - PROCESS | 1685 | RSS: Main: 285020160 08:58:14 INFO - PROCESS | 1685 | 08:58:16 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:58:16 INFO - PROCESS | 1685 | RSS: Main: 284618752 08:58:16 INFO - PROCESS | 1685 | 08:58:19 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 08:58:20 INFO - PROCESS | 1685 | RSS: Main: 284704768 08:58:20 INFO - PROCESS | 1685 | 08:58:22 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 08:58:23 INFO - PROCESS | 1685 | RSS: Main: 284905472 08:58:23 INFO - PROCESS | 1685 | 08:58:26 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 08:58:26 INFO - PROCESS | 1685 | RSS: Main: 285253632 08:58:26 INFO - PROCESS | 1685 | 08:58:28 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:58:28 INFO - PROCESS | 1685 | RSS: Main: 318656512 08:58:28 INFO - PROCESS | 1685 | 08:58:30 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:58:31 INFO - PROCESS | 1685 | RSS: Main: 318009344 08:58:31 INFO - PROCESS | 1685 | 08:58:33 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:58:34 INFO - PROCESS | 1685 | RSS: Main: 324378624 08:58:34 INFO - PROCESS | 1685 | 08:58:37 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:58:37 INFO - PROCESS | 1685 | RSS: Main: 325828608 08:58:37 INFO - PROCESS | 1685 | 08:58:40 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:58:41 INFO - PROCESS | 1685 | RSS: Main: 325861376 08:58:41 INFO - PROCESS | 1685 | 08:58:42 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 08:58:43 INFO - PROCESS | 1685 | RSS: Main: 389611520 08:58:43 INFO - PROCESS | 1685 | 08:58:43 INFO - PROCESS | 1685 | __start_tp_report 08:58:43 INFO - PROCESS | 1685 | _x_x_mozilla_page_load 08:58:43 INFO - PROCESS | 1685 | _x_x_mozilla_page_load_details 08:58:43 INFO - PROCESS | 1685 | |i|pagename|runs| 08:58:43 INFO - PROCESS | 1685 | |0;ai-astar;113;110;114;112;113;113;118;113;114;113 08:58:43 INFO - PROCESS | 1685 | |1;audio-beat-detection;157;126;143;161;118;144;130;153;197;148 08:58:43 INFO - PROCESS | 1685 | |2;audio-dft;186;186;188;184;186;183;185;187;181;181 08:58:43 INFO - PROCESS | 1685 | |3;audio-fft;75;77;74;117;56;58;57;58;116;55 08:58:43 INFO - PROCESS | 1685 | |4;audio-oscillator;95;93;125;78;78;78;120;78;76;112 08:58:43 INFO - PROCESS | 1685 | |5;imaging-gaussian-blur;88;86;89;85;126;86;89;86;88;85 08:58:43 INFO - PROCESS | 1685 | |6;imaging-darkroom;98;115;94;94;95;94;93;95;94;94 08:58:43 INFO - PROCESS | 1685 | |7;imaging-desaturate;87;85;86;85;86;85;85;87;85;88 08:58:43 INFO - PROCESS | 1685 | |8;json-parse-financial;54;59;68;42;43;42;43;83;91;85 08:58:43 INFO - PROCESS | 1685 | |9;json-stringify-tinderbox;66;63;75;75;71;68;68;68;67;68 08:58:43 INFO - PROCESS | 1685 | |10;stanford-crypto-aes;86;85;91;113;112;112;97;84;85;86 08:58:43 INFO - PROCESS | 1685 | |11;stanford-crypto-ccm;146;167;165;161;143;140;141;142;143;147 08:58:43 INFO - PROCESS | 1685 | |12;stanford-crypto-pbkdf2;172;172;173;166;180;170;169;176;160;168 08:58:43 INFO - PROCESS | 1685 | |13;stanford-crypto-sha256-iterative;68;69;70;68;68;68;68;69;67;68 08:58:43 INFO - PROCESS | 1685 | __end_tp_report 08:58:43 INFO - PROCESS | 1685 | __start_cc_report 08:58:43 INFO - PROCESS | 1685 | _x_x_mozilla_cycle_collect,1315 08:58:43 INFO - PROCESS | 1685 | __end_cc_report 08:58:43 INFO - PROCESS | 1685 | __startTimestamp1460217523196__endTimestamp 08:58:43 INFO - PROCESS | 1685 | 08:58:43 INFO - PROCESS | 1685 | ------- Summary: start ------- 08:58:43 INFO - PROCESS | 1685 | Number of tests: 14 08:58:43 INFO - PROCESS | 1685 | 08:58:43 INFO - PROCESS | 1685 | [#0] ai-astar Cycles:10 Average:113.30 Median:113.00 stddev:2.00 (1.8%) stddev-sans-first:2.12 08:58:43 INFO - PROCESS | 1685 | Values: 113.0 110.0 114.0 112.0 113.0 113.0 118.0 113.0 114.0 113.0 08:58:43 INFO - PROCESS | 1685 | 08:58:43 INFO - PROCESS | 1685 | [#1] audio-beat-detection Cycles:10 Average:147.70 Median:150.50 stddev:22.17 (14.7%) stddev-sans-first:23.26 08:58:43 INFO - PROCESS | 1685 | Values: 157.0 126.0 143.0 161.0 118.0 144.0 130.0 153.0 197.0 148.0 08:58:43 INFO - PROCESS | 1685 | 08:58:43 INFO - PROCESS | 1685 | [#2] audio-dft Cycles:10 Average:184.70 Median:186.00 stddev:2.41 (1.3%) stddev-sans-first:2.51 08:58:43 INFO - PROCESS | 1685 | Values: 186.0 186.0 188.0 184.0 186.0 183.0 185.0 187.0 181.0 181.0 08:58:43 INFO - PROCESS | 1685 | 08:58:43 INFO - PROCESS | 1685 | [#3] audio-fft Cycles:10 Average:74.30 Median:58.00 stddev:23.82 (41.1%) stddev-sans-first:25.27 08:58:43 INFO - PROCESS | 1685 | Values: 75.0 77.0 74.0 117.0 56.0 58.0 57.0 58.0 116.0 55.0 08:58:43 INFO - PROCESS | 1685 | 08:58:43 INFO - PROCESS | 1685 | [#4] audio-oscillator Cycles:10 Average:93.30 Median:78.00 stddev:19.17 (24.6%) stddev-sans-first:20.32 08:58:43 INFO - PROCESS | 1685 | Values: 95.0 93.0 125.0 78.0 78.0 78.0 120.0 78.0 76.0 112.0 08:58:43 INFO - PROCESS | 1685 | 08:58:43 INFO - PROCESS | 1685 | [#5] imaging-gaussian-blur Cycles:10 Average:90.80 Median:87.00 stddev:12.46 (14.3%) stddev-sans-first:13.18 08:58:43 INFO - PROCESS | 1685 | Values: 88.0 86.0 89.0 85.0 126.0 86.0 89.0 86.0 88.0 85.0 08:58:43 INFO - PROCESS | 1685 | 08:58:43 INFO - PROCESS | 1685 | [#6] imaging-darkroom Cycles:10 Average:96.60 Median:94.00 stddev:6.60 (7.0%) stddev-sans-first:6.98 08:58:43 INFO - PROCESS | 1685 | Values: 98.0 115.0 94.0 94.0 95.0 94.0 93.0 95.0 94.0 94.0 08:58:43 INFO - PROCESS | 1685 | 08:58:43 INFO - PROCESS | 1685 | [#7] imaging-desaturate Cycles:10 Average:85.90 Median:86.00 stddev:1.10 (1.3%) stddev-sans-first:1.09 08:58:43 INFO - PROCESS | 1685 | Values: 87.0 85.0 86.0 85.0 86.0 85.0 85.0 87.0 85.0 88.0 08:58:43 INFO - PROCESS | 1685 | 08:58:43 INFO - PROCESS | 1685 | [#8] json-parse-financial Cycles:10 Average:61.00 Median:63.50 stddev:19.53 (30.8%) stddev-sans-first:20.55 08:58:43 INFO - PROCESS | 1685 | Values: 54.0 59.0 68.0 42.0 43.0 42.0 43.0 83.0 91.0 85.0 08:58:43 INFO - PROCESS | 1685 | 08:58:43 INFO - PROCESS | 1685 | [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:68.00 stddev:3.78 (5.6%) stddev-sans-first:3.87 08:58:43 INFO - PROCESS | 1685 | Values: 66.0 63.0 75.0 75.0 71.0 68.0 68.0 68.0 67.0 68.0 08:58:43 INFO - PROCESS | 1685 | 08:58:43 INFO - PROCESS | 1685 | [#10] stanford-crypto-aes Cycles:10 Average:95.10 Median:85.50 stddev:12.49 (14.6%) stddev-sans-first:12.81 08:58:43 INFO - PROCESS | 1685 | Values: 86.0 85.0 91.0 113.0 112.0 112.0 97.0 84.0 85.0 86.0 08:58:43 INFO - PROCESS | 1685 | 08:58:43 INFO - PROCESS | 1685 | [#11] stanford-crypto-ccm Cycles:10 Average:149.50 Median:146.50 stddev:10.54 (7.2%) stddev-sans-first:11.11 08:58:43 INFO - PROCESS | 1685 | Values: 146.0 167.0 165.0 161.0 143.0 140.0 141.0 142.0 143.0 147.0 08:58:43 INFO - PROCESS | 1685 | 08:58:43 INFO - PROCESS | 1685 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.60 Median:172.00 stddev:5.48 (3.2%) stddev-sans-first:5.79 08:58:43 INFO - PROCESS | 1685 | Values: 172.0 172.0 173.0 166.0 180.0 170.0 169.0 176.0 160.0 168.0 08:58:43 INFO - PROCESS | 1685 | 08:58:43 INFO - PROCESS | 1685 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 08:58:43 INFO - PROCESS | 1685 | Values: 68.0 69.0 70.0 68.0 68.0 68.0 68.0 69.0 67.0 68.0 08:58:43 INFO - PROCESS | 1685 | -------- Summary: end -------- 08:58:43 INFO - PROCESS | 1685 | 08:58:43 INFO - TEST-INFO | 1685: exit 0 08:58:43 INFO - TEST-OK | kraken | took 57497ms 08:58:43 INFO - SUITE-END | took 1171s 08:58:44 INFO - Completed test suite (00:19:31) 08:58:44 INFO - javascript benchmark 08:58:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3386.661333866613, 3432.914177145571, 3467.0, 3473.3747925373423, 3508.2281897982452, 5550.944490555094, 5605.7197140142935, 5687.800926967557, 5709.914351284729, 5710.200571919934, 5625.156226566017, 5674.744636491358, 5677.17680936264, 5680.488756011958, 5689.459501347375, 5100.234964755288, 5131.461196574362, 5157.7936882524655, 5161.4322424533275, 5207.817726379578, 5213.791448342062, 5215.687058776485, 5215.713135777531, 5217.895642087156, 5223.686578805284, 5145.6398052136365, 5175.508326708976, 5179.948200517984, 5198.662086964354, 5264.184051472028, 5189.195674670432, 5263.921041184385, 5264.947010597895, 5268.315119034501, 5318.25544423781, 5021.14640511114, 5064.56951159152, 5088.491150884919, 5186.7147306898105, 5197.0, 5522.972385138049, 5558.833235002957, 5585.776568937237, 5595.1886976388605, 5656.547476201894, 6241.063840423927, 6253.687315634245, 6271.466925311354, 6286.937130628681, 6289.182406287199, 6071.909439984033, 6137.447629713302, 6265.812025639192, 6316.778912738078, 6327.24073111225, 5778.133280008033, 5780.797672081457, 5796.855078623026, 5809.767609295665, 5815.534757219412, 6305.18032655761, 6310.652914089677, 6317.3366796486625, 6322.114903913456, 6328.17733694626, 6006.699665016732, 6062.575619706667, 6137.376985335611, 6141.662208578571, 6144.539159563051, 6219.751209951552, 6226.501879849601, 6266.686665666698, 6278.30938596754, 6291.0, 6148.231471066117, 6206.379362063848, 6215.533834962396, 6222.62664240147, 6240.563160578716, 6086.452219300196, 6122.093225952662, 6162.5378096642935, 6173.41352571505, 6233.345498722569, 4906.5280415875095, 4912.508749125059, 4914.164592019365, 4915.606751459946, 4931.309616653672, 4413.58070983256, 4427.114577084596, 4433.113377324548, 4437.911241775211, 4460.665450091256, 4591.632669386441, 5611.775528978795, 5666.660000399989, 5675.120356344773, 5686.459786320293, 6259.624422534663, 6297.496200304056, 6298.212723409574, 6314.0, 6316.210473690789, 5597.664140151523, 5663.093904975184, 5665.6034077614995, 5682.715864206773, 5710.086386178275, 5258.553022993012, 5335.786568537215, 5356.384015838151, 5402.081646120169, 5404.756785944642, 6346.079818426302, 6361.554691171574, 6366.427021568081, 6368.554201205871, 6377.3303803100935, 6321.367863213642, 6334.239891213084, 6336.524760642878, 6343.397377249154, 6355.936440635534, 6257.624542527463, 6278.309385967631, 6307.369263073656, 6329.303776584664, 6366.108744775643, 6190.907136392868, 6196.225471816023, 6220.191375121205, 6220.844478888064, 6236.18929539157, 6317.115603815561, 6329.303776584664, 6330.39861213184, 6347.016212487072, 6350.904736428864, 5884.146798714077, 6057.697115144313, 6107.037103281039, 6136.85608443425, 6141.731496609813, 5293.311869456946, 5978.551608629283, 6128.1726966858905, 6128.479079278133, 6130.785422510191, 5601.271834661468, 5923.496502797138, 5943.64338139713, 5947.940520594739, 5965.522758179422, 6017.548683848641, 6051.33435322123, 6085.0, 6125.816225513242, 6135.355787642234, 5857.531397488276, 5877.529797616095, 5890.204822348928, 5906.645601263938, 5913.319968203539], "value": 5690.209651897457, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [479.9736014519201, 490.65163733749034, 523.2230138244706, 530.9487215313679, 586.5893874287999, 28700.56949145762, 29177.416451670953, 29207.707922920763, 29228.0, 29250.97621583245, 38192.80903595478, 39407.0, 39515.0121246969, 39605.60394396055, 39606.0, 8129.4715843470285, 8133.959330203341, 9285.860712089307, 9565.330426870121, 9581.041895810433, 9490.288228382864, 9660.661876834312, 9670.178034867045, 9672.854907176397, 9682.177014953737, 9586.712398628053, 9658.227341812673, 9684.854727179098, 9687.806243875119, 9694.854577181313, 9555.0, 9602.615895364177, 9605.039496050409, 9606.855897161548, 9610.75973100671, 9509.239260859184, 9611.0, 9627.951860240724, 9643.517824108767, 9649.276304277137, 39026.0, 39462.80268598667, 39511.40732889009, 39517.60482395168, 39615.60384396148, 3165.4618714818534, 3277.0332751838264, 3316.1875340541483, 3355.07735372772, 3412.6246112927556, 27632.0, 27800.0, 28332.575011374847, 28617.0, 28634.427311453863, 2734.6991830898587, 2755.6830964438946, 2788.2750484874077, 2852.686204517501, 2899.6375453068367, 468888.0, 469078.0, 469331.0, 469343.65328173485, 470286.0, 44248.77875610601, 58604.53488662732, 58984.410155897895, 59016.40983590195, 59142.70428647829, 59890.0, 60195.69902150461, 66225.33774662288, 67559.66220168868, 67789.25475216786, 16306.184690765414, 16541.917290413712, 16559.751603725952, 16559.83440165607, 16569.751453728204, 12527.686807829878, 12628.81056784149, 12654.177478463871, 12661.93669031649, 12693.555725549562, 18833.434996950113, 18893.7165942511, 18914.0, 18920.0, 18963.715544266848, 6576.835579110465, 7619.456952516995, 7805.336546393507, 7817.921820781833, 7919.84160316802, 770.7186876790043, 954.9761255968656, 969.5787210320959, 1030.4796077980573, 1061.6231237910586, 26687.733122668913, 27002.459950800872, 27313.863430683115, 27341.258335749317, 27381.86309068442, 899.869518919766, 974.4007435427161, 1062.3838173859144, 1065.6430095917954, 1151.3437340715711, 13853.376598053112, 14120.364583593762, 14146.646333841736, 14384.208868512123, 14428.639284017983, 593921.0, 597907.0, 599509.0, 601038.9948050319, 601510.0, 56323.71838140783, 58440.707796460745, 58473.70763146242, 58732.70633646804, 58802.705986469795, 1249.9437525311382, 1306.6994591243877, 1309.0247765414827, 1451.6153219396867, 1566.0, 20313.79686203119, 30097.0, 30320.84839575788, 30374.0, 30959.380812384075, 51068.74465627648, 52176.739116304176, 52216.47783522116, 52220.0, 52302.0, 568281.0, 578518.0, 579042.0, 579326.0, 579918.0, 22614.095436182368, 25631.487370252864, 26039.609405859304, 26473.867630662495, 26496.735032649427, 41089.79455102705, 41481.58518414777, 42907.35638965481, 43174.78412607917, 43255.351169733105, 35809.46285805663, 36091.0, 36225.27549448943, 37017.259654806214, 37094.44358334681, 34962.300753985284, 35404.822975884956, 35957.28085438224, 36175.81912090423, 36296.63703363038, 28261.02103178122, 35152.64847351596, 36009.459858101625, 36791.44812827863, 36929.63070369369, 29942.401151977276, 30765.232688310185, 31849.566769494966, 32140.67859321377, 32285.0, 20693.58612827705, 22453.77546224517, 22606.94092026157, 23503.647445288676, 23727.64408533839], "value": 19088.461739807513, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.29634232157036, 389.3225787130392, 392.3663283796668, 398.2214770124405, 401.9753086419753, 14001.052636756713, 19676.606467870668, 19679.409617711455, 20606.896965515152, 20617.0, 15494.999999999973, 16136.83863161368, 19563.413097607096, 19829.008549572536, 19839.5040123997, 5674.631148975313, 5955.940440595582, 5987.610805297663, 6008.699565021753, 6009.759609615632, 5769.798057068004, 5965.582409231334, 5998.9700051499685, 6023.2169817923605, 6122.632642041492, 3862.8454861805494, 4104.076582768868, 4107.589241075883, 4111.424400583921, 4113.465249517559, 5676.205331253628, 6015.879682406371, 6108.786192483286, 6114.3579924108, 6115.082737589375, 5648.491635752802, 5849.912251316234, 5881.441263080001, 5881.764729410818, 5891.0, 13158.934205329007, 13422.664433389145, 16607.08661023643, 24235.394115147086, 25608.74391256082, 1860.8697391182623, 2050.917963281467, 2113.651247544153, 2269.761675024115, 2303.0787684925995, 9413.90586094144, 9795.804083918281, 9801.264905132073, 9991.90008099917, 10011.349262298, 1624.4801663467695, 1639.3032960991532, 1656.8757343199309, 1669.2404955745228, 1758.8842109463787, 91506.5424672879, 95536.08927821404, 96450.0, 98182.99999999929, 108103.0, 11103.44482775858, 11499.655010349703, 11550.306981581132, 11587.826182607268, 11742.70643233909, 14894.255287235595, 14940.775888361683, 14970.026948248329, 15000.174990375415, 15004.849951500564, 8327.750167494985, 8530.488170709654, 8539.316854651614, 8620.827583448296, 8645.0, 8287.12985136552, 8317.625706843206, 8349.29031032357, 8440.029396619344, 8456.957715211385, 4525.0, 4610.0, 4624.375709279271, 4677.836275730401, 4716.551927566876, 1623.448027670574, 1896.3268039845932, 1945.1538580717433, 1951.5316324082119, 1993.1728332742039, 713.9612505678193, 915.391264808908, 926.9304802139867, 944.976375590602, 987.160913223754, 18979.620407592047, 19109.85340879524, 19337.903310483638, 19945.800541994686, 20454.0, 916.4313667211519, 954.2938225713061, 958.8465845464832, 980.2696990741942, 980.9313348065567, 7763.2236776321915, 10321.019503147189, 10409.42748148859, 10432.895671043345, 10600.893991060146, 609420.0, 616979.0, 620240.8987955032, 635487.0, 636041.0, 132455.0, 133068.3346583261, 133782.0, 134215.6578434203, 138979.0, 961.3462845265286, 978.2614126334572, 993.478423827482, 994.4282037828277, 1017.9999999999852, 17245.65508689794, 17571.56071098233, 17580.208890599697, 17583.472495825146, 18009.549761256072, 35453.82273088618, 46232.76883615561, 46818.53181468142, 46920.7653961728, 49126.75436622794, 66314.0, 70295.0, 70869.29130708834, 71100.0, 74676.62661686656, 8020.478668886503, 8095.635696393559, 8097.473664211808, 8165.755027349189, 8196.262336389753, 9043.457392556467, 12187.964023058139, 12409.751804964031, 12492.25046497213, 12635.684107897376, 10360.222983276435, 10704.518296676824, 10751.247412681038, 10865.78268434611, 11040.558377664804, 10435.634752783617, 10507.161246781936, 10608.681739547827, 10745.838812417664, 10937.781244375226, 10858.294210876267, 11108.333499990027, 11225.66323010311, 11276.210665253353, 11277.71805704831, 7926.881096783438, 8072.0, 8086.15095414973, 8097.1497992712275, 8372.832543349221, 8237.217464340878, 10524.473776311306, 10579.62971296001, 10899.29154604948, 11070.501827417624], "value": 9118.890430107755, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1394.78380850968, 1574.5906064423255, 1590.7772911792347, 1846.2522678315288, 1979.0500559731338, 7750.341220996215, 8605.91394086059, 8878.15657512537, 8878.200961913435, 8879.378443508956, 8530.57347132644, 8719.346049046331, 8749.25631321337, 8776.868346974785, 8781.297496200305, 2439.4511234972165, 2466.260121963413, 2490.638857365681, 2490.7011158660894, 2492.7756501914823, 1928.797476264993, 2351.6825228594175, 2426.0538390027905, 2494.7006359236916, 2500.499900020003, 2184.4757258258064, 2196.428928478599, 2467.5064987002584, 2501.3621526510715, 2502.612095125249, 2333.346662934381, 2351.47091904321, 2356.6229403295392, 2365.2667673021333, 2365.9408514787183, 2357.4931389751114, 2440.341107900857, 2461.54461424637, 2462.1997850698594, 2466.1738317663603, 8879.245264152554, 8959.865602015974, 8960.8655870162, 8970.372073954826, 9006.504642244674, 5301.893962120775, 5478.260434841325, 5497.725113744297, 5516.475934786189, 5527.695976721278, 3365.5961284645755, 3402.2344972381015, 3421.6920477157178, 3461.2212252243294, 3464.3764122457947, 950.7718147644584, 975.3952549419334, 984.2716389871443, 984.7538115471132, 987.7036888933363, 11590.0, 11605.30368177912, 11607.593734219261, 11642.417879106011, 11645.010174135208, 4641.350210970467, 4722.5513576210205, 4765.833195838199, 4824.0834241494, 4833.975830120827, 9579.233661307218, 9590.520473976274, 9596.472194029257, 9598.95200524007, 9611.951940240393, 5358.490943360374, 5359.196120581944, 5382.596305277119, 5420.891582168335, 5507.807226747044, 4326.805293761725, 4364.388985542027, 4936.086823937583, 4946.332245146859, 4976.850694479172, 3980.383040628707, 4006.8797936061965, 4096.32410652245, 4110.095778928631, 4142.606452387018, 1336.411978729356, 1342.3020029584561, 1344.798280257969, 1358.5448874626913, 1361.9659508512168, 950.1401231885155, 995.64654547636, 1148.3741360958131, 1269.6127681057367, 1404.3610157378369, 7517.721987262178, 7981.2018798119725, 8014.599270036591, 8122.634481448349, 8139.593020348959, 1153.9307641541534, 1205.873383294759, 1206.5415142246065, 1207.885250901163, 1218.3542722357165, 6268.749250030039, 6273.0, 6361.650109244036, 6422.6467544285515, 6433.195850518685, 10346.793064138825, 10579.0, 10583.100436462833, 10678.038976492153, 10710.625128120479, 10346.896531034743, 10547.789044219226, 10613.681589552325, 10690.839637405445, 10704.89295107039, 8071.919280807234, 8170.428070035159, 8194.34445244367, 8198.0, 8217.95891020553, 7712.344450721752, 7862.292393684367, 7987.161348058603, 7990.440669153336, 8014.398920080901, 9127.58925848325, 9144.58849351794, 9703.757406064904, 9758.170555502862, 10005.399676019462, 9834.360766550151, 9938.354006989523, 10195.898041019494, 10236.744081398025, 10257.846132307872, 7366.852662946818, 7473.402127829652, 7592.8481430369975, 7597.6581053851605, 7615.086189657055, 6772.796816095525, 8177.918220817954, 8208.671653133808, 8222.424430289822, 8242.381821363542, 7320.084989376328, 7450.329470347478, 7480.925190748023, 7580.128285247267, 7597.848043038997, 7158.355747982707, 7270.382017528569, 7284.854302913806, 7396.223396543501, 7455.179930207782, 7680.846383072196, 7764.417668674985, 7764.92235077642, 7772.650230739518, 7773.0, 6741.359570840762, 6964.721411143701, 7053.894191587027, 7077.964610176916, 7082.964585177041, 7089.929100708927, 7121.501494895308, 7164.785056448315, 7169.139703235645, 7169.211386747558], "value": 4907.054472444671, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.1810909743764, 317.8871500617281, 323.79924446842955, 326.91173383186526, 327.81314650649125, 4808.687435316702, 5742.799002034924, 5837.824865254039, 5842.182094506762, 5864.3256025557075, 5688.696078088381, 5700.5202736809415, 5729.512991395726, 5744.156642461977, 5756.481916627503, 3474.461458473928, 3495.860165593386, 3594.867616700731, 4297.570242975708, 4357.564243575641, 3827.655511004009, 3957.821898014596, 4315.309550471925, 4331.328644060176, 4354.1944740223, 4321.740695558261, 4346.5436129206455, 4354.390385346054, 4359.847405340814, 4378.846740364088, 4091.652209562191, 4162.791860406998, 4347.130573885235, 4347.587034213893, 4372.672049596277, 3753.0, 3760.793156376398, 3760.868369607078, 3776.2636285924254, 3791.184895247535, 5490.313710786152, 5494.697791621459, 5505.779768809243, 5511.834644960658, 5511.917321240185, 4810.89349449625, 5003.448241396877, 5015.824446144367, 5024.447310795809, 5063.594912406998, 5699.544036477072, 5864.149698293766, 5961.493273071794, 5974.8506287342725, 5979.431953964367, 3692.8522859085606, 3697.574778900434, 3850.306944749944, 4178.958210417887, 4179.707420480568, 5050.368703912011, 6024.728887200086, 6244.6253224806205, 6391.616503009788, 6399.26408463028, 4126.91746165075, 4216.325387937976, 4240.385144154142, 4242.830286788494, 4265.253580623378, 4334.5882141196535, 4346.174226896879, 4364.170807546556, 4366.694331396835, 4366.8034938427845, 4854.863859901632, 4893.882646691635, 4980.576650984634, 4986.825461108844, 5027.723475208825, 5882.3529411764675, 6051.425114614105, 6074.0281554951, 6129.938700613026, 6130.570860039755, 1333.4666133546466, 1400.859914008591, 1480.9111453312835, 1484.1317829070115, 1491.3736230783097, 972.2076507646245, 996.3971797062818, 1012.4633944009687, 1013.6756238003916, 1021.8313978193663, 4961.50384961501, 5660.0, 5661.716914154358, 5690.943090569124, 5705.803265742719, 5496.422875598085, 5598.964191624563, 6291.213598300213, 6304.716287767062, 6324.33594472583, 4904.509549045067, 5119.718415487109, 5451.48210919962, 5626.381098079208, 5707.885842283131, 2629.6318515407856, 3205.1506350817053, 3273.5580696605653, 3299.1422230220314, 3306.669333066722, 5294.867628309323, 6254.530910181755, 6585.209774827052, 6594.802155935329, 6612.09068010074, 6020.488258497989, 6118.898598252357, 6440.194975628046, 6465.806025819139, 6473.248869230558, 6566.704498297588, 6591.43972762311, 6593.6703164841565, 6602.3397660233595, 6610.0, 5303.655262408085, 5967.940320596738, 6169.020981467019, 6244.687765611792, 6290.779822706183, 5970.910436343372, 6125.754969801336, 6156.476699480594, 6164.630122192682, 6174.413430724074, 6019.367966363468, 6092.75628974836, 6351.650659213788, 6485.513586480938, 6525.8694826104165, 3365.3942290386985, 4011.5988401159652, 4253.234417804825, 4290.334998075304, 4402.977985110054, 5550.419055139379, 6247.281562620356, 6296.212973378328, 6297.905531416941, 6313.179286692701, 5940.198073260054, 6073.635581864925, 6097.908531371944, 6101.176341193882, 6159.260888693386, 4914.189158788759, 5771.711414429178, 5939.910901336397, 6101.115338275837, 6107.206063211932, 5660.207570940154, 5943.0, 5967.492763115184, 5979.910301345396, 6058.666773327333, 5375.4087050425205, 6151.477124444294, 6155.47678447337, 6158.445739883432, 6196.783112591038, 6002.879942401215, 6017.909731354121, 6046.123312119806, 6049.153118563493, 6057.42454466825], "value": 4452.084425935573, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [627.6579264300956, 644.6647743173553, 758.9165191828898, 760.1714131596563, 776.6776787633136, 15080.095194288337, 15151.0, 15315.770263446057, 15378.307976141072, 15379.23103844806, 14133.222672752994, 14188.290585470711, 14202.14787112774, 14210.928945355285, 14234.644133896658, 910.1626503616671, 945.3052006775015, 946.8248374050788, 947.9194268487187, 951.7763325618474, 733.6368497593699, 749.1759065028452, 927.332320729074, 937.3906960475678, 944.9794222239964, 965.937214081086, 992.0773680477154, 994.9502524873764, 995.9850602240936, 996.2329006664863, 980.5048450532436, 981.0336818234034, 983.7491439682907, 984.5667906121283, 985.3841349156777, 562.2381672833293, 711.0827033127259, 730.9634518274119, 734.5005396330494, 737.0602481835703, 15593.22033898312, 15637.0, 15666.373345066184, 15669.21653917311, 15701.842981570153, 10351.430671313075, 12287.0, 12306.26162430248, 12644.620661380173, 12761.425735841909, 9959.352642078242, 10058.195344372505, 10112.393256404639, 10474.47627618616, 10505.52725127371, 3399.201187720884, 3455.378031954247, 3472.739544534145, 3519.7184225261917, 3721.6650501455, 81913.59043204805, 82030.94922626922, 85845.0, 87403.12596874013, 87809.56095219548, 9116.386498150723, 9261.120193581733, 9367.62529498826, 9617.663381781604, 9631.988641192715, 21132.683009754866, 21227.257046003626, 21237.150513979577, 21271.574568508542, 21276.78723212779, 7154.713811447588, 7354.632268386559, 7427.925720742724, 7437.628118594049, 7525.661345239368, 3869.3615553433933, 4142.109446469024, 4167.74993500391, 4173.749575025508, 4198.538160802309, 3022.30486987994, 3479.356319080978, 3575.1598374382, 3581.767185132958, 3589.9282014360087, 627.3663599764271, 641.8868487833968, 643.5495153392644, 650.8665723526666, 651.1014799576554, 496.8087286394764, 499.53792741713767, 532.2335836395578, 599.5952731905946, 618.3785295777715, 7514.774556763306, 7941.404394670423, 8096.028476582847, 8198.877016844752, 8218.383621228431, 511.9283300337956, 512.3032675561234, 526.6971491392464, 547.6276132230122, 548.18047019705, 3721.962780372216, 3756.154865155373, 3774.5659249186697, 3946.4672269243283, 4019.055521952339, 86353.70469442963, 89562.55218723865, 91857.08142918485, 92096.0, 93165.5341723287, 60648.696756516816, 71525.21186970368, 71636.0, 75782.31632627574, 77251.84122238171, 53368.0, 60058.0, 60403.395966039774, 63455.0, 63753.362466376595, 7824.139344671968, 7960.6417711201975, 8000.319972802377, 8139.348852091937, 8263.256306932164, 40407.3938890911, 40506.594934050285, 40581.59418405778, 40821.18357632771, 40875.18249634931, 53910.92178156337, 55044.174337385775, 57036.0, 57818.7109064452, 58562.7071864638, 10682.89317106819, 10736.0, 10791.406472643766, 10936.12510999134, 11248.156388270749, 11837.704057398634, 11898.76202475963, 11916.821247681119, 12046.457909393923, 12808.615741527396, 11255.437228138397, 11390.772184556428, 11531.019863311378, 11604.245724027911, 11791.528338866348, 11520.423978801195, 11709.238899471507, 11816.291022538675, 11887.989520890475, 12081.637550873487, 10908.290961087503, 10972.506237219504, 11253.943730281297, 11261.268017578832, 11508.769824603629, 9572.664956726481, 9673.903260967581, 9765.658201962897, 9943.701688949342, 9990.15083717892, 9415.85876211871, 9436.716898493056, 9559.187469065208, 9602.423854568748, 9603.279754018336], "value": 6768.302908136494, "unit": "score"}], "name": "dromaeo_css", "value": 7260.344193810455, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 110.0, 114.0, 112.0, 113.0, 113.0, 118.0, 113.0, 114.0, 113.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 126.0, 143.0, 161.0, 118.0, 144.0, 130.0, 153.0, 197.0, 148.0], "value": 147.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 186.0, 188.0, 184.0, 186.0, 183.0, 185.0, 187.0, 181.0, 181.0], "value": 184.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 74.0, 117.0, 56.0, 58.0, 57.0, 58.0, 116.0, 55.0], "value": 74.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 93.0, 125.0, 78.0, 78.0, 78.0, 120.0, 78.0, 76.0, 112.0], "value": 93.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 89.0, 85.0, 126.0, 86.0, 89.0, 86.0, 88.0, 85.0], "value": 90.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 115.0, 94.0, 94.0, 95.0, 94.0, 93.0, 95.0, 94.0, 94.0], "value": 96.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 86.0, 85.0, 86.0, 85.0, 85.0, 87.0, 85.0, 88.0], "value": 85.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 59.0, 68.0, 42.0, 43.0, 42.0, 43.0, 83.0, 91.0, 85.0], "value": 61.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 75.0, 75.0, 71.0, 68.0, 68.0, 68.0, 67.0, 68.0], "value": 68.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 91.0, 113.0, 112.0, 112.0, 97.0, 84.0, 85.0, 86.0], "value": 95.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 167.0, 165.0, 161.0, 143.0, 140.0, 141.0, 142.0, 143.0, 147.0], "value": 149.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 172.0, 173.0, 166.0, 180.0, 170.0, 169.0, 176.0, 160.0, 168.0], "value": 170.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 70.0, 68.0, 68.0, 68.0, 68.0, 69.0, 67.0, 68.0], "value": 68.3, "unit": "score"}], "name": "kraken", "value": 1499.9999999999998, "alertThreshold": 2.0}]} 08:58:44 INFO - Return code: 0 08:58:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:58:44 ERROR - # TBPL SUCCESS # 08:58:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:58:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:58:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:58:44 INFO - 2016-04-09 08:58:44.496 screenresolution[1689:10256] starting screenresolution argv=screenresolution get 08:58:44 INFO - 2016-04-09 08:58:44.499 screenresolution[1689:10256] Display 0: 1600x1200x32@60 08:58:44 INFO - 2016-04-09 08:58:44.504 screenresolution[1690:10259] starting screenresolution argv=screenresolution list 08:58:44 INFO - Available Modes on Display 0 08:58:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:58:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:58:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:58:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:58:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:58:44 INFO - Intel Iris: 08:58:44 INFO - Chipset Model: Intel Iris 08:58:44 INFO - Type: GPU 08:58:44 INFO - Bus: Built-In 08:58:44 INFO - VRAM (Dynamic, Max): 1536 MB 08:58:44 INFO - Vendor: Intel (0x8086) 08:58:44 INFO - Device ID: 0x0a2e 08:58:44 INFO - Revision ID: 0x0009 08:58:44 INFO - Displays: 08:58:44 INFO - Display: 08:58:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:58:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:58:44 INFO - Display Serial Number: 1600x1200 60 08:58:44 INFO - Main Display: Yes 08:58:44 INFO - Mirror: Off 08:58:44 INFO - Online: Yes 08:58:44 INFO - Rotation: Supported 08:58:44 INFO - Return code: 0 08:58:44 INFO - Running post-action listener: _resource_record_post_action 08:58:44 INFO - Running post-run listener: _resource_record_post_run 08:58:45 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 32468480; Write bytes: 694973440; Read time: 326; Write time: 1869 08:58:45 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 375194112; Write bytes: 369530880; Read time: 28376; Write time: 694 08:58:45 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 31546880; Write bytes: 300411904; Read time: 312; Write time: 1120 08:58:45 INFO - Running post-run listener: _upload_blobber_files 08:58:45 INFO - Blob upload gear active. 08:58:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:58:45 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 08:58:45 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'] 08:58:45 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 08:58:46 INFO - (blobuploader) - INFO - Open directory for files ... 08:58:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:58:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:58:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:58:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:58:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:58:47 INFO - (blobuploader) - INFO - Done attempting. 08:58:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:58:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:58:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:58:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:58:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:58:47 INFO - (blobuploader) - INFO - Done attempting. 08:58:47 INFO - (blobuploader) - INFO - Iteration through files over. 08:58:47 INFO - Return code: 0 08:58:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:58:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:58:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cdc4ab1e37dc2164ac710c19c2c071e2270e81eb86e0e80832e4858cc3af3a714a92a5c2a2ffde0c2d7427c4b0d8c0dfbf8e4f8adaed742b6f4ac31a9c19193d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7135efb0da413a37e64652c81bd6a4a380fd236b0a38d7aff3828715be41c8ba119c6a0614d867ffae0b4fb19bfe7e21d61e23997029cf9b3175c1af06d1013f"} 08:58:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:58:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:58:47 INFO - Contents: 08:58:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cdc4ab1e37dc2164ac710c19c2c071e2270e81eb86e0e80832e4858cc3af3a714a92a5c2a2ffde0c2d7427c4b0d8c0dfbf8e4f8adaed742b6f4ac31a9c19193d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7135efb0da413a37e64652c81bd6a4a380fd236b0a38d7aff3828715be41c8ba119c6a0614d867ffae0b4fb19bfe7e21d61e23997029cf9b3175c1af06d1013f"} 08:58:47 INFO - Running post-run listener: copy_logs_to_upload_dir 08:58:47 INFO - Copying logs to upload dir... 08:58:47 INFO - mkdir: /builds/slave/test/build/upload/logs 08:58:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1295.090554 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 35 secs) (at 2016-04-09 08:58:47.989078) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-09 08:58:47.992348) ========= 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.tLjDsv5zZ1/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.OZDFNAqmja/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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/cdc4ab1e37dc2164ac710c19c2c071e2270e81eb86e0e80832e4858cc3af3a714a92a5c2a2ffde0c2d7427c4b0d8c0dfbf8e4f8adaed742b6f4ac31a9c19193d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7135efb0da413a37e64652c81bd6a4a380fd236b0a38d7aff3828715be41c8ba119c6a0614d867ffae0b4fb19bfe7e21d61e23997029cf9b3175c1af06d1013f"} build_url:https://queue.taskcluster.net/v1/task/D3QUcp0iQOe4jGHfeagZ2w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011262 build_url: 'https://queue.taskcluster.net/v1/task/D3QUcp0iQOe4jGHfeagZ2w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cdc4ab1e37dc2164ac710c19c2c071e2270e81eb86e0e80832e4858cc3af3a714a92a5c2a2ffde0c2d7427c4b0d8c0dfbf8e4f8adaed742b6f4ac31a9c19193d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7135efb0da413a37e64652c81bd6a4a380fd236b0a38d7aff3828715be41c8ba119c6a0614d867ffae0b4fb19bfe7e21d61e23997029cf9b3175c1af06d1013f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-09 08:58:48.020222) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 08:58:48.020579) ========= 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.tLjDsv5zZ1/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.OZDFNAqmja/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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.005136 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 08:58:48.070106) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-09 08:58:48.070476) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-09 08:58:48.070914) ========= ========= Total master_lag: 0.29 =========