builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0064 starttime: 1459257391.06 results: success (0) buildid: 20160329051635 builduid: 6ed7a21eecce433bb331055a802a242e revision: 971ee95dade06b20742e94d58c471e76705ca478 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-29 06:16:31.058661) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-29 06:16:31.064110) ========= ========= Started set props: basedir (results: 0, elapsed: 4 secs) (at 2016-03-29 06:16:31.064426) ========= 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.1pjgOOO7N6/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.nmiEokDztP/Listeners TMPDIR=/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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.005420 basedir: '/builds/slave/test' ========= master_lag: 4.74 ========= ========= Finished set props: basedir (results: 0, elapsed: 4 secs) (at 2016-03-29 06:16:35.806825) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 2 secs) (at 2016-03-29 06:16:35.807124) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 2 secs) (at 2016-03-29 06:16:37.928325) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 06:16:37.928796) ========= 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.1pjgOOO7N6/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.nmiEokDztP/Listeners TMPDIR=/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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.005993 ========= master_lag: 0.31 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 06:16:38.241464) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-29 06:16:38.241736) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-29 06:16:38.250160) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-03-29 06:16:38.250475) ========= 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.1pjgOOO7N6/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.nmiEokDztP/Listeners TMPDIR=/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-29 06:16:38-- 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% 14.1M=0.001s 2016-03-29 06:16:38 (14.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.447749 ========= master_lag: 2.59 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-03-29 06:16:41.287676) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-03-29 06:16:41.288040) ========= 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.1pjgOOO7N6/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.nmiEokDztP/Listeners TMPDIR=/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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.026678 ========= master_lag: 1.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-03-29 06:16:42.340728) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2016-03-29 06:16:42.341096) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 971ee95dade06b20742e94d58c471e76705ca478 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 971ee95dade06b20742e94d58c471e76705ca478 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1pjgOOO7N6/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.nmiEokDztP/Listeners TMPDIR=/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-29 06:16:42,478 truncating revision to first 12 chars 2016-03-29 06:16:42,478 Setting DEBUG logging. 2016-03-29 06:16:42,478 attempt 1/10 2016-03-29 06:16:42,478 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/971ee95dade0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-29 06:16:44,143 unpacking tar archive at: mozilla-central-971ee95dade0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.964251 ========= master_lag: 3.71 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2016-03-29 06:16:48.015326) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 5 secs) (at 2016-03-29 06:16:48.015643) ========= echo 971ee95dade06b20742e94d58c471e76705ca478 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'971ee95dade06b20742e94d58c471e76705ca478'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1pjgOOO7N6/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.nmiEokDztP/Listeners TMPDIR=/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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 971ee95dade06b20742e94d58c471e76705ca478 program finished with exit code 0 elapsedTime=0.005759 script_repo_revision: '971ee95dade06b20742e94d58c471e76705ca478' ========= master_lag: 5.49 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 5 secs) (at 2016-03-29 06:16:53.512951) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-29 06:16:53.513237) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-29 06:16:53.639703) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-03-29 06:16:53.640492) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1pjgOOO7N6/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.nmiEokDztP/Listeners TMPDIR=/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 06:16:53 INFO - MultiFileLogger online at 20160329 06:16:53 in /builds/slave/test 06:16:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:16:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:16:53 INFO - {'append_to_log': False, 06:16:53 INFO - 'base_work_dir': '/builds/slave/test', 06:16:53 INFO - 'blob_upload_branch': 'Firefox', 06:16:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:16:53 INFO - 'branch': 'Firefox', 06:16:53 INFO - 'buildbot_json_path': 'buildprops.json', 06:16:53 INFO - 'config_files': ('talos/mac_config.py',), 06:16:53 INFO - 'default_actions': ('clobber', 06:16:53 INFO - 'read-buildbot-config', 06:16:53 INFO - 'download-and-extract', 06:16:53 INFO - 'populate-webroot', 06:16:53 INFO - 'create-virtualenv', 06:16:53 INFO - 'install', 06:16:53 INFO - 'run-tests'), 06:16:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:16:53 INFO - 'download_minidump_stackwalk': True, 06:16:53 INFO - 'download_symbols': 'ondemand', 06:16:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:16:53 INFO - 'tooltool.py': '/tools/tooltool.py', 06:16:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:16:53 INFO - '/tools/misc-python/virtualenv.py')}, 06:16:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:16:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:16:53 INFO - 'installer_path': 'installer.exe', 06:16:53 INFO - 'log_level': 'info', 06:16:53 INFO - 'log_name': 'talos', 06:16:53 INFO - 'log_to_console': True, 06:16:53 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:16:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:16:53 INFO - 'opt_config_files': (), 06:16:53 INFO - 'pip_index': False, 06:16:53 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:16:53 INFO - 'cmd': ('bash', 06:16:53 INFO - '-c', 06:16:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:16:53 INFO - 'enabled': True, 06:16:53 INFO - 'halt_on_failure': False, 06:16:53 INFO - 'name': 'check_screen_resolution'},), 06:16:53 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:16:53 INFO - 'cmd': ('bash', 06:16:53 INFO - '-c', 06:16:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:16:53 INFO - 'enabled': True, 06:16:53 INFO - 'halt_on_failure': False, 06:16:53 INFO - 'name': 'check_screen_resolution'},), 06:16:53 INFO - 'run_cmd_checks_enabled': True, 06:16:53 INFO - 'sps_profile': False, 06:16:53 INFO - 'sps_profile_interval': 0, 06:16:53 INFO - 'suite': 'dromaeojs', 06:16:53 INFO - 'system_bits': '32', 06:16:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:16:53 INFO - 'title': 't-yosemite-r7-0064', 06:16:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:16:53 INFO - 'use_talos_json': True, 06:16:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:16:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:16:53 INFO - 'work_dir': 'build'} 06:16:53 INFO - ##### 06:16:53 INFO - ##### Running clobber step. 06:16:53 INFO - ##### 06:16:53 INFO - Running pre-action listener: _resource_record_pre_action 06:16:53 INFO - Running main action method: clobber 06:16:53 INFO - rmtree: /builds/slave/test/build 06:16:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:16:55 INFO - Running post-action listener: _resource_record_post_action 06:16:55 INFO - ##### 06:16:55 INFO - ##### Running read-buildbot-config step. 06:16:55 INFO - ##### 06:16:55 INFO - Running pre-action listener: _resource_record_pre_action 06:16:55 INFO - Running main action method: read_buildbot_config 06:16:55 INFO - Using buildbot properties: 06:16:55 INFO - { 06:16:55 INFO - "project": "", 06:16:55 INFO - "product": "firefox", 06:16:55 INFO - "script_repo_revision": "production", 06:16:55 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 06:16:55 INFO - "repository": "", 06:16:55 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 06:16:55 INFO - "buildid": "20160329051635", 06:16:55 INFO - "pgo_build": "False", 06:16:55 INFO - "basedir": "/builds/slave/test", 06:16:55 INFO - "buildnumber": 190, 06:16:55 INFO - "slavename": "t-yosemite-r7-0064", 06:16:55 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 06:16:55 INFO - "platform": "yosemite_r7", 06:16:55 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 06:16:55 INFO - "branch": "mozilla-central", 06:16:55 INFO - "repo_path": "mozilla-central", 06:16:55 INFO - "revision": "971ee95dade06b20742e94d58c471e76705ca478", 06:16:55 INFO - "stage_platform": "macosx64", 06:16:55 INFO - "builduid": "6ed7a21eecce433bb331055a802a242e", 06:16:55 INFO - "slavebuilddir": "test" 06:16:55 INFO - } 06:16:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/XJKtJC_hRAiYw-sPeEFOlw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 06:16:55 INFO - Running post-action listener: _resource_record_post_action 06:16:55 INFO - ##### 06:16:55 INFO - ##### Running download-and-extract step. 06:16:55 INFO - ##### 06:16:55 INFO - Running pre-action listener: _resource_record_pre_action 06:16:55 INFO - Running main action method: download_and_extract 06:16:55 INFO - mkdir: /builds/slave/test/build/tests 06:16:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:16:55 INFO - https://queue.taskcluster.net/v1/task/XJKtJC_hRAiYw-sPeEFOlw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 06:16:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XJKtJC_hRAiYw-sPeEFOlw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 06:16:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XJKtJC_hRAiYw-sPeEFOlw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 06:16:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XJKtJC_hRAiYw-sPeEFOlw/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 06:16:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XJKtJC_hRAiYw-sPeEFOlw/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 06:16:56 INFO - Downloaded 1199 bytes. 06:16:56 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 06:16:56 INFO - Using the following test package requirements: 06:16:56 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 06:16:56 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:16:56 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 06:16:56 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:16:56 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 06:16:56 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:16:56 INFO - u'jsshell-mac.zip'], 06:16:56 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:16:56 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 06:16:56 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 06:16:56 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:16:56 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 06:16:56 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:16:56 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 06:16:56 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:16:56 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 06:16:56 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:16:56 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 06:16:56 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:16:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:16:56 INFO - https://queue.taskcluster.net/v1/task/XJKtJC_hRAiYw-sPeEFOlw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:16:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XJKtJC_hRAiYw-sPeEFOlw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 06:16:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XJKtJC_hRAiYw-sPeEFOlw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 06:16:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XJKtJC_hRAiYw-sPeEFOlw/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 06:16:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XJKtJC_hRAiYw-sPeEFOlw/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 06:16:58 INFO - Downloaded 17943821 bytes. 06:16:58 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'] 06:16:58 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 06:17:01 INFO - Return code: 0 06:17:01 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 06:17:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:17:01 INFO - https://queue.taskcluster.net/v1/task/XJKtJC_hRAiYw-sPeEFOlw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:17:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XJKtJC_hRAiYw-sPeEFOlw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 06:17:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XJKtJC_hRAiYw-sPeEFOlw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 06:17:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XJKtJC_hRAiYw-sPeEFOlw/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 06:17:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XJKtJC_hRAiYw-sPeEFOlw/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 06:17:02 INFO - Downloaded 17943821 bytes. 06:17:02 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'] 06:17:02 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 06:17:06 INFO - Return code: 0 06:17: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')]} 06:17:06 INFO - https://queue.taskcluster.net/v1/task/XJKtJC_hRAiYw-sPeEFOlw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 06:17:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XJKtJC_hRAiYw-sPeEFOlw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 06:17:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XJKtJC_hRAiYw-sPeEFOlw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 06:17:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XJKtJC_hRAiYw-sPeEFOlw/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 06:17:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XJKtJC_hRAiYw-sPeEFOlw/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 06:17:07 INFO - Downloaded 10847531 bytes. 06:17:07 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'] 06:17:07 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 06:17:07 INFO - Return code: 0 06:17:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:17:07 INFO - https://queue.taskcluster.net/v1/task/XJKtJC_hRAiYw-sPeEFOlw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 06:17:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XJKtJC_hRAiYw-sPeEFOlw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 06:17:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XJKtJC_hRAiYw-sPeEFOlw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 06:17:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XJKtJC_hRAiYw-sPeEFOlw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 06:17:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XJKtJC_hRAiYw-sPeEFOlw/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 06:17:10 INFO - Downloaded 111447167 bytes. 06:17:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XJKtJC_hRAiYw-sPeEFOlw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 06:17:10 INFO - mkdir: /builds/slave/test/properties 06:17:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:17:10 INFO - Writing to file /builds/slave/test/properties/build_url 06:17:10 INFO - Contents: 06:17:10 INFO - build_url:https://queue.taskcluster.net/v1/task/XJKtJC_hRAiYw-sPeEFOlw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 06:17:12 INFO - Running post-action listener: _resource_record_post_action 06:17:12 INFO - Running post-action listener: set_extra_try_arguments 06:17:12 INFO - ##### 06:17:12 INFO - ##### Running populate-webroot step. 06:17:12 INFO - ##### 06:17:12 INFO - Running pre-action listener: _resource_record_pre_action 06:17:12 INFO - Running main action method: populate_webroot 06:17:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:17:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:17:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:17:12 INFO - '--tppagecycles', 06:17:12 INFO - '7'], 06:17:12 INFO - 'tests': ['tsvgm']}}, 06:17:12 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:17:12 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:17:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:17:12 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 06:17:12 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:17:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:17:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:17:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:17:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:17:12 INFO - 'talos_options': ['--e10s'], 06:17:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:17:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:17:12 INFO - 'tests': ['damp', 'tps']}, 06:17:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:17:12 INFO - 'talos_options': ['--e10s'], 06:17:12 INFO - 'tests': ['damp', 'tps']}, 06:17:12 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:17:12 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 06:17:12 INFO - 'tests': ['dromaeo_dom']}, 06:17:12 INFO - 'other': {'tests': ['a11yr', 06:17:12 INFO - 'ts_paint', 06:17:12 INFO - 'tpaint', 06:17:12 INFO - 'sessionrestore', 06:17:12 INFO - 'sessionrestore_no_auto_restore', 06:17:12 INFO - 'tabpaint']}, 06:17:12 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:17:12 INFO - 'tests': ['a11yr', 06:17:12 INFO - 'ts_paint', 06:17:12 INFO - 'tpaint', 06:17:12 INFO - 'sessionrestore', 06:17:12 INFO - 'sessionrestore_no_auto_restore', 06:17:12 INFO - 'tabpaint']}, 06:17:12 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:17:12 INFO - 'tests': ['a11yr', 06:17:12 INFO - 'ts_paint', 06:17:12 INFO - 'tpaint', 06:17:12 INFO - 'sessionrestore', 06:17:12 INFO - 'sessionrestore_no_auto_restore', 06:17:12 INFO - 'tabpaint']}, 06:17:12 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:17:12 INFO - 'tests': ['a11yr', 06:17:12 INFO - 'ts_paint', 06:17:12 INFO - 'tpaint', 06:17:12 INFO - 'sessionrestore', 06:17:12 INFO - 'sessionrestore_no_auto_restore', 06:17:12 INFO - 'tabpaint']}, 06:17:12 INFO - 'other_l64': {'tests': ['a11yr', 06:17:12 INFO - 'ts_paint', 06:17:12 INFO - 'tpaint', 06:17:12 INFO - 'sessionrestore', 06:17:12 INFO - 'sessionrestore_no_auto_restore', 06:17:12 INFO - 'tabpaint']}, 06:17:12 INFO - 'other_nol64': {'tests': ['a11yr', 06:17:12 INFO - 'ts_paint', 06:17:12 INFO - 'tpaint', 06:17:12 INFO - 'sessionrestore', 06:17:12 INFO - 'sessionrestore_no_auto_restore', 06:17:12 INFO - 'tabpaint']}, 06:17:12 INFO - 'svgr': {'tests': ['tsvgx', 06:17:12 INFO - 'tsvgr_opacity', 06:17:12 INFO - 'tart', 06:17:12 INFO - 'tscrollx', 06:17:12 INFO - 'cart']}, 06:17:12 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:17:12 INFO - 'tests': ['tsvgx', 06:17:12 INFO - 'tsvgr_opacity', 06:17:12 INFO - 'tart', 06:17:12 INFO - 'tscrollx', 06:17:12 INFO - 'cart']}, 06:17:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:17:12 INFO - 'tests': ['tp5o']}, 06:17:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:17:12 INFO - 'talos_options': ['--e10s'], 06:17:12 INFO - 'tests': ['tp5o']}, 06:17:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:17:12 INFO - 'talos_options': ['--xperf_path', 06:17:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:17:12 INFO - 'tests': ['tp5n']}, 06:17:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:17:12 INFO - 'talos_options': ['--e10s', 06:17:12 INFO - '--xperf_path', 06:17:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:17:12 INFO - 'tests': ['tp5n']}}, 06:17:12 INFO - 'talos.zip': {'path': '', 06:17:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:17:12 INFO - Running post-action listener: _resource_record_post_action 06:17:12 INFO - ##### 06:17:12 INFO - ##### Running create-virtualenv step. 06:17:12 INFO - ##### 06:17:12 INFO - Running pre-action listener: _resource_record_pre_action 06:17:12 INFO - Running main action method: create_virtualenv 06:17:12 INFO - Creating virtualenv /builds/slave/test/build/venv 06:17:12 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:17:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:17:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:17:12 INFO - Using real prefix '/tools/python27' 06:17:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:17:12 INFO - Installing distribute.............................................................................................................................................................................................done. 06:17:15 INFO - Installing pip.................done. 06:17:15 INFO - Return code: 0 06:17:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:17:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:17:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:17:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:17:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:17:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:15 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 0x10baf7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb07420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feff14a5be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b996e00>, '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 0x10b7bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b991b20>, '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.1pjgOOO7N6/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.nmiEokDztP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:17:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:17:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:17:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1pjgOOO7N6/Render', 06:17:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:17:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:17:15 INFO - 'HOME': '/Users/cltbld', 06:17:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:17:15 INFO - 'LOGNAME': 'cltbld', 06:17:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:17:15 INFO - 'MOZ_NO_REMOTE': '1', 06:17:15 INFO - 'NO_EM_RESTART': '1', 06:17:15 INFO - 'PAGER': '/bin/cat', 06:17:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:17:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:17:15 INFO - 'PWD': '/builds/slave/test', 06:17:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:17:15 INFO - 'SHELL': '/bin/bash', 06:17:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nmiEokDztP/Listeners', 06:17:15 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 06:17:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:17:15 INFO - 'USER': 'cltbld', 06:17:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:17:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:17:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:17:15 INFO - 'XPC_FLAGS': '0x0', 06:17:15 INFO - 'XPC_SERVICE_NAME': '0', 06:17:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:17:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:17:16 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:17:16 INFO - Cleaning up... 06:17:16 INFO - Return code: 0 06:17:16 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:17:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:17:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:17:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:17:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:16 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 0x10baf7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb07420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feff14a5be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b996e00>, '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 0x10b7bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b991b20>, '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.1pjgOOO7N6/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.nmiEokDztP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:17:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 06:17:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 06:17:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1pjgOOO7N6/Render', 06:17:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:17:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:17:16 INFO - 'HOME': '/Users/cltbld', 06:17:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:17:16 INFO - 'LOGNAME': 'cltbld', 06:17:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:17:16 INFO - 'MOZ_NO_REMOTE': '1', 06:17:16 INFO - 'NO_EM_RESTART': '1', 06:17:16 INFO - 'PAGER': '/bin/cat', 06:17:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:17:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:17:16 INFO - 'PWD': '/builds/slave/test', 06:17:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:17:16 INFO - 'SHELL': '/bin/bash', 06:17:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nmiEokDztP/Listeners', 06:17:16 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 06:17:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:17:16 INFO - 'USER': 'cltbld', 06:17:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:17:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:17:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:17:16 INFO - 'XPC_FLAGS': '0x0', 06:17:16 INFO - 'XPC_SERVICE_NAME': '0', 06:17:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:17:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:17:16 INFO - Downloading/unpacking psutil>=0.7.1 06:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:17:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:17:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:17:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:17:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:17:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:17:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:17:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:17:18 INFO - Installing collected packages: psutil 06:17:18 INFO - Running setup.py install for psutil 06:17:18 INFO - building 'psutil._psutil_osx' extension 06:17:18 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 06:17:19 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 06:17:19 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 06:17:19 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 06:17:19 INFO - building 'psutil._psutil_posix' extension 06:17:19 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 06:17:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:17:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:17:19 INFO - ^ 06:17:19 INFO - 1 warning generated. 06:17:19 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 06:17:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:17:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:17:20 INFO - Successfully installed psutil 06:17:20 INFO - Cleaning up... 06:17:20 INFO - Return code: 0 06:17:20 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:17: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')]} 06:17:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:17:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17: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')]} 06:17:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:17:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:20 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 0x10baf7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb07420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feff14a5be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b996e00>, '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 0x10b7bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b991b20>, '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.1pjgOOO7N6/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.nmiEokDztP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:17:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 06:17:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 06:17:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1pjgOOO7N6/Render', 06:17:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:17:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:17:20 INFO - 'HOME': '/Users/cltbld', 06:17:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:17:20 INFO - 'LOGNAME': 'cltbld', 06:17:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:17:20 INFO - 'MOZ_NO_REMOTE': '1', 06:17:20 INFO - 'NO_EM_RESTART': '1', 06:17:20 INFO - 'PAGER': '/bin/cat', 06:17:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:17:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:17:20 INFO - 'PWD': '/builds/slave/test', 06:17:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:17:20 INFO - 'SHELL': '/bin/bash', 06:17:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nmiEokDztP/Listeners', 06:17:20 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 06:17:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:17:20 INFO - 'USER': 'cltbld', 06:17:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:17:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:17:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:17:20 INFO - 'XPC_FLAGS': '0x0', 06:17:20 INFO - 'XPC_SERVICE_NAME': '0', 06:17:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:17:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:17:20 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:17:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:17:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:17:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:17:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:17:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:17:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:17:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:17:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:17:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:17:23 INFO - Installing collected packages: mozsystemmonitor 06:17:23 INFO - Running setup.py install for mozsystemmonitor 06:17:23 INFO - Successfully installed mozsystemmonitor 06:17:23 INFO - Cleaning up... 06:17:23 INFO - Return code: 0 06:17:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:17: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')]} 06:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:17:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:17:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:17:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:24 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 0x10baf7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb07420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feff14a5be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b996e00>, '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 0x10b7bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b991b20>, '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.1pjgOOO7N6/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.nmiEokDztP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:17:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:17:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:17:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1pjgOOO7N6/Render', 06:17:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:17:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:17:24 INFO - 'HOME': '/Users/cltbld', 06:17:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:17:24 INFO - 'LOGNAME': 'cltbld', 06:17:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:17:24 INFO - 'MOZ_NO_REMOTE': '1', 06:17:24 INFO - 'NO_EM_RESTART': '1', 06:17:24 INFO - 'PAGER': '/bin/cat', 06:17:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:17:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:17:24 INFO - 'PWD': '/builds/slave/test', 06:17:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:17:24 INFO - 'SHELL': '/bin/bash', 06:17:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nmiEokDztP/Listeners', 06:17:24 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 06:17:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:17:24 INFO - 'USER': 'cltbld', 06:17:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:17:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:17:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:17:24 INFO - 'XPC_FLAGS': '0x0', 06:17:24 INFO - 'XPC_SERVICE_NAME': '0', 06:17:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:17:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:17:24 INFO - Downloading/unpacking blobuploader==1.2.4 06:17:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:17:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:17:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:17:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:17:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:17:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:17:26 INFO - Downloading blobuploader-1.2.4.tar.gz 06:17:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:17:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:17: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 06:17: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 06:17: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 06:17: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 06:17: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 06:17: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 06:17:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:17:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:17:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:17:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:17:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:17:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:17:27 INFO - Downloading docopt-0.6.1.tar.gz 06:17:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:17:28 INFO - Installing collected packages: blobuploader, requests, docopt 06:17:28 INFO - Running setup.py install for blobuploader 06:17:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:17:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:17:28 INFO - Running setup.py install for requests 06:17:28 INFO - Running setup.py install for docopt 06:17:28 INFO - Successfully installed blobuploader requests docopt 06:17:28 INFO - Cleaning up... 06:17:28 INFO - Return code: 0 06:17:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:17:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:17:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:17:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:17:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:17:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:28 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 0x10baf7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb07420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feff14a5be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b996e00>, '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 0x10b7bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b991b20>, '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.1pjgOOO7N6/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.nmiEokDztP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:17:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:17:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:17:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1pjgOOO7N6/Render', 06:17:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:17:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:17:28 INFO - 'HOME': '/Users/cltbld', 06:17:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:17:28 INFO - 'LOGNAME': 'cltbld', 06:17:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:17:28 INFO - 'MOZ_NO_REMOTE': '1', 06:17:28 INFO - 'NO_EM_RESTART': '1', 06:17:28 INFO - 'PAGER': '/bin/cat', 06:17:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:17:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:17:28 INFO - 'PWD': '/builds/slave/test', 06:17:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:17:28 INFO - 'SHELL': '/bin/bash', 06:17:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nmiEokDztP/Listeners', 06:17:28 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 06:17:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:17:28 INFO - 'USER': 'cltbld', 06:17:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:17:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:17:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:17:28 INFO - 'XPC_FLAGS': '0x0', 06:17:28 INFO - 'XPC_SERVICE_NAME': '0', 06:17:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:17:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:17:29 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-dO_Uu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:17:29 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-RaMwl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:17:29 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-bI6u8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:17:29 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-ZurU1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:17:29 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-d0vbHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:17:29 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-1KsW8A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:17:29 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-YaYHut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:17:29 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-191ItF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:17:30 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-G7S0xS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:17:30 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-lt5SWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:17:30 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-t6Fdlk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:17:30 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-gd7q39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:17:30 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-KRQRj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:17:30 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-8VN035-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:17:30 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-7BnDsV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:17:30 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-Rhuxkb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:17:30 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-xZUjt1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:17:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:17:31 INFO - Running setup.py install for manifestparser 06:17:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:17:31 INFO - Running setup.py install for mozcrash 06:17:31 INFO - Running setup.py install for mozdebug 06:17:31 INFO - Running setup.py install for mozdevice 06:17:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:17:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:17:31 INFO - Running setup.py install for mozfile 06:17:31 INFO - Running setup.py install for mozhttpd 06:17:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:17:31 INFO - Running setup.py install for mozinfo 06:17:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:17:32 INFO - Running setup.py install for mozInstall 06:17:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:17:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:17:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:17:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:17:32 INFO - Running setup.py install for mozleak 06:17:32 INFO - Running setup.py install for mozlog 06:17:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:17:32 INFO - Running setup.py install for moznetwork 06:17:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:17:32 INFO - Running setup.py install for mozprocess 06:17:32 INFO - Running setup.py install for mozprofile 06:17:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:17:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:17:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:17:32 INFO - Running setup.py install for mozrunner 06:17:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:17:33 INFO - Running setup.py install for mozscreenshot 06:17:33 INFO - Running setup.py install for moztest 06:17:33 INFO - Running setup.py install for mozversion 06:17:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:17:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:17:33 INFO - Cleaning up... 06:17:33 INFO - Return code: 0 06:17:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:17:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:17:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:17:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:17:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:17:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:33 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 0x10baf7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb07420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feff14a5be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b996e00>, '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 0x10b7bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b991b20>, '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.1pjgOOO7N6/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.nmiEokDztP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:17:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:17:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:17:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1pjgOOO7N6/Render', 06:17:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:17:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:17:33 INFO - 'HOME': '/Users/cltbld', 06:17:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:17:33 INFO - 'LOGNAME': 'cltbld', 06:17:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:17:33 INFO - 'MOZ_NO_REMOTE': '1', 06:17:33 INFO - 'NO_EM_RESTART': '1', 06:17:33 INFO - 'PAGER': '/bin/cat', 06:17:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:17:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:17:33 INFO - 'PWD': '/builds/slave/test', 06:17:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:17:33 INFO - 'SHELL': '/bin/bash', 06:17:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nmiEokDztP/Listeners', 06:17:33 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 06:17:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:17:33 INFO - 'USER': 'cltbld', 06:17:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:17:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:17:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:17:33 INFO - 'XPC_FLAGS': '0x0', 06:17:33 INFO - 'XPC_SERVICE_NAME': '0', 06:17:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:17:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:17:33 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-Zef0dR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:17:33 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:17:33 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-Pll1tQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:17:34 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)) 06:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:17:34 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-1cT9WP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:17:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:17:34 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-633s2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:17:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:17:34 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-JsrmjY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:17:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:17:34 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-1igMze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:17:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:17:34 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-SCUvsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:17:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:17:34 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-4yPZGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:17:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:17:34 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-4U3f3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:17:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:17:34 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-pu5g1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:17:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:17:34 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-99i4Pp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:17:35 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-b7a1L3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:17:35 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-GUSgfP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:17:35 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-TgNISU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:17:35 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-Gp2ZP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:17:35 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-FciK_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:17:35 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-byePtX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:17:35 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)) 06:17:35 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)) 06:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:17:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:17:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:17:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:17:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:17:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:17:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:17:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:17:38 INFO - Downloading blessings-1.6.tar.gz 06:17:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:17:38 INFO - Installing collected packages: blessings 06:17:38 INFO - Running setup.py install for blessings 06:17:38 INFO - Successfully installed blessings 06:17:38 INFO - Cleaning up... 06:17:38 INFO - Return code: 0 06:17:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:17:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:17:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:17:38 INFO - Reading from file tmpfile_stdout 06:17:38 INFO - Current package versions: 06:17:38 INFO - blessings == 1.6 06:17:38 INFO - blobuploader == 1.2.4 06:17:38 INFO - docopt == 0.6.1 06:17:38 INFO - manifestparser == 1.1 06:17:38 INFO - mozInstall == 1.12 06:17:38 INFO - mozcrash == 0.17 06:17:38 INFO - mozdebug == 0.1 06:17:38 INFO - mozdevice == 0.48 06:17:38 INFO - mozfile == 1.2 06:17:38 INFO - mozhttpd == 0.7 06:17:38 INFO - mozinfo == 0.9 06:17:38 INFO - mozleak == 0.1 06:17:38 INFO - mozlog == 3.1 06:17:38 INFO - moznetwork == 0.27 06:17:38 INFO - mozprocess == 0.22 06:17:38 INFO - mozprofile == 0.28 06:17:38 INFO - mozrunner == 6.11 06:17:38 INFO - mozscreenshot == 0.1 06:17:38 INFO - mozsystemmonitor == 0.0 06:17:38 INFO - moztest == 0.7 06:17:38 INFO - mozversion == 1.4 06:17:38 INFO - psutil == 3.1.1 06:17:38 INFO - requests == 1.2.3 06:17:38 INFO - wsgiref == 0.1.2 06:17:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:17:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:17:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:17:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:17:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:38 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 0x10baf7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb07420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feff14a5be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b996e00>, '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 0x10b7bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b991b20>, '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.1pjgOOO7N6/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.nmiEokDztP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:17:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:17:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:17:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1pjgOOO7N6/Render', 06:17:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:17:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:17:38 INFO - 'HOME': '/Users/cltbld', 06:17:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:17:38 INFO - 'LOGNAME': 'cltbld', 06:17:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:17:38 INFO - 'MOZ_NO_REMOTE': '1', 06:17:38 INFO - 'NO_EM_RESTART': '1', 06:17:38 INFO - 'PAGER': '/bin/cat', 06:17:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:17:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:17:38 INFO - 'PWD': '/builds/slave/test', 06:17:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:17:38 INFO - 'SHELL': '/bin/bash', 06:17:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nmiEokDztP/Listeners', 06:17:38 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 06:17:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:17:38 INFO - 'USER': 'cltbld', 06:17:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:17:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:17:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:17:38 INFO - 'XPC_FLAGS': '0x0', 06:17:38 INFO - 'XPC_SERVICE_NAME': '0', 06:17:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:17:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:17:38 INFO - Cleaning up... 06:17:38 INFO - Return code: 0 06:17:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:17:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:17:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:17:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:17:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:38 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 0x10baf7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb07420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feff14a5be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b996e00>, '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 0x10b7bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b991b20>, '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.1pjgOOO7N6/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.nmiEokDztP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:17:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:17:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:17:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1pjgOOO7N6/Render', 06:17:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:17:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:17:38 INFO - 'HOME': '/Users/cltbld', 06:17:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:17:38 INFO - 'LOGNAME': 'cltbld', 06:17:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:17:38 INFO - 'MOZ_NO_REMOTE': '1', 06:17:38 INFO - 'NO_EM_RESTART': '1', 06:17:38 INFO - 'PAGER': '/bin/cat', 06:17:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:17:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:17:38 INFO - 'PWD': '/builds/slave/test', 06:17:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:17:38 INFO - 'SHELL': '/bin/bash', 06:17:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nmiEokDztP/Listeners', 06:17:38 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 06:17:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:17:38 INFO - 'USER': 'cltbld', 06:17:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:17:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:17:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:17:38 INFO - 'XPC_FLAGS': '0x0', 06:17:38 INFO - 'XPC_SERVICE_NAME': '0', 06:17:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:17:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:17:39 INFO - Downloading/unpacking jsonschema 06:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:17:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:17:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:17:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:17:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:17:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:17:41 INFO - Downloading/unpacking functools32 (from jsonschema) 06:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:17:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:17:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:17:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:17:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:17:42 INFO - Downloading functools32-3.2.3-2.tar.gz 06:17:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:17:42 INFO - warning: no files found matching '*.txt' 06:17:42 INFO - no previously-included directories found matching 'build' 06:17:42 INFO - no previously-included directories found matching 'dist' 06:17:42 INFO - no previously-included directories found matching '.git*' 06:17:42 INFO - Installing collected packages: jsonschema, functools32 06:17:42 INFO - Running setup.py install for functools32 06:17:42 INFO - warning: no files found matching '*.txt' 06:17:42 INFO - no previously-included directories found matching 'build' 06:17:42 INFO - no previously-included directories found matching 'dist' 06:17:42 INFO - no previously-included directories found matching '.git*' 06:17:42 INFO - Successfully installed jsonschema functools32 06:17:42 INFO - Cleaning up... 06:17:42 INFO - Return code: 0 06:17:42 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:17:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:17:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:17:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:17:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:42 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 0x10baf7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb07420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feff14a5be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b996e00>, '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 0x10b7bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b991b20>, '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.1pjgOOO7N6/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.nmiEokDztP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:17:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 06:17:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 06:17:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1pjgOOO7N6/Render', 06:17:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:17:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:17:42 INFO - 'HOME': '/Users/cltbld', 06:17:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:17:42 INFO - 'LOGNAME': 'cltbld', 06:17:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:17:42 INFO - 'MOZ_NO_REMOTE': '1', 06:17:42 INFO - 'NO_EM_RESTART': '1', 06:17:42 INFO - 'PAGER': '/bin/cat', 06:17:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:17:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:17:42 INFO - 'PWD': '/builds/slave/test', 06:17:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:17:42 INFO - 'SHELL': '/bin/bash', 06:17:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nmiEokDztP/Listeners', 06:17:42 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 06:17:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:17:42 INFO - 'USER': 'cltbld', 06:17:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:17:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:17:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:17:42 INFO - 'XPC_FLAGS': '0x0', 06:17:42 INFO - 'XPC_SERVICE_NAME': '0', 06:17:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:17:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:17:42 INFO - Downloading/unpacking flake8 06:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:17:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:17:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:17:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:17:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:17:45 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:17:45 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:17:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:17:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:17:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:17:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:17:45 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:17:45 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:17:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:17:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:17:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:17:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:17:46 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:17:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:17:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:17:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:17:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:17:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:17:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:17:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:17:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:17:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:17:46 INFO - no previously-included directories found matching 'docs/_build' 06:17:46 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:17:46 INFO - Running setup.py install for pep8 06:17:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:17:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:17:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:17:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:17:46 INFO - no previously-included directories found matching 'docs/_build' 06:17:46 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:17:46 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:17:46 INFO - Cleaning up... 06:17:47 INFO - Return code: 0 06:17:47 INFO - Running post-action listener: _resource_record_post_action 06:17:47 INFO - Running post-action listener: _start_resource_monitoring 06:17:47 INFO - Starting resource monitoring. 06:17:47 INFO - ##### 06:17:47 INFO - ##### Running install step. 06:17:47 INFO - ##### 06:17:47 INFO - Running pre-action listener: _resource_record_pre_action 06:17:47 INFO - Running main action method: install 06:17:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:17:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:17:47 INFO - Reading from file tmpfile_stdout 06:17:47 INFO - Detecting whether we're running mozinstall >=1.0... 06:17:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:17:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:17:47 INFO - Reading from file tmpfile_stdout 06:17:47 INFO - Output received: 06:17:47 INFO - Usage: mozinstall [options] installer 06:17:47 INFO - Options: 06:17:47 INFO - -h, --help show this help message and exit 06:17:47 INFO - -d DEST, --destination=DEST 06:17:47 INFO - Directory to install application into. [default: 06:17:47 INFO - "/builds/slave/test"] 06:17:47 INFO - --app=APP Application being installed. [default: firefox] 06:17:47 INFO - mkdir: /builds/slave/test/build/application 06:17:47 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'] 06:17:47 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 06:18:21 INFO - Reading from file tmpfile_stdout 06:18:21 INFO - Output received: 06:18:21 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:18:21 INFO - Running post-action listener: _resource_record_post_action 06:18:21 INFO - ##### 06:18:21 INFO - ##### Running run-tests step. 06:18:21 INFO - ##### 06:18:21 INFO - Running pre-action listener: _resource_record_pre_action 06:18:21 INFO - Running main action method: run_tests 06:18:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:18:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:18:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:18:21 INFO - 2016-03-29 06:18:21.542 screenresolution[1647:7563] starting screenresolution argv=screenresolution get 06:18:21 INFO - 2016-03-29 06:18:21.545 screenresolution[1647:7563] Display 0: 1600x1200x32@60 06:18:21 INFO - 2016-03-29 06:18:21.551 screenresolution[1648:7565] starting screenresolution argv=screenresolution list 06:18:21 INFO - Available Modes on Display 0 06:18:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:18:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:18:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:18:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:18:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:18:21 INFO - Intel Iris: 06:18:21 INFO - Chipset Model: Intel Iris 06:18:21 INFO - Type: GPU 06:18:21 INFO - Bus: Built-In 06:18:21 INFO - VRAM (Dynamic, Max): 1536 MB 06:18:21 INFO - Vendor: Intel (0x8086) 06:18:21 INFO - Device ID: 0x0a2e 06:18:21 INFO - Revision ID: 0x0009 06:18:21 INFO - Displays: 06:18:21 INFO - Display: 06:18:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:18:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:18:21 INFO - Display Serial Number: 1600x1200 60 06:18:21 INFO - Main Display: Yes 06:18:21 INFO - Mirror: Off 06:18:21 INFO - Online: Yes 06:18:21 INFO - Rotation: Supported 06:18:21 INFO - Return code: 0 06:18:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:18:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:18:21 INFO - Python 2.7.3 06:18:21 INFO - Return code: 0 06:18:21 INFO - grabbing minidump binary from tooltool 06:18:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:21 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 0x10b996e00>, '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 0x10b7bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b991b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:18:21 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:18:21 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 06:18:21 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:18:21 INFO - Return code: 0 06:18:21 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:18:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:18:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:18:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:18:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:18:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:18:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:18:23 INFO - Return code: 0 06:18:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XJKtJC_hRAiYw-sPeEFOlw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:18:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XJKtJC_hRAiYw-sPeEFOlw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0064 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:18:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1pjgOOO7N6/Render', 06:18:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:18:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:18:23 INFO - 'HOME': '/Users/cltbld', 06:18:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:18:23 INFO - 'LOGNAME': 'cltbld', 06:18:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:18:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:18:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:23 INFO - 'MOZ_NO_REMOTE': '1', 06:18:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:18:23 INFO - 'NO_EM_RESTART': '1', 06:18:23 INFO - 'PAGER': '/bin/cat', 06:18:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:18:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:23 INFO - 'PWD': '/builds/slave/test', 06:18:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:18:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:18:23 INFO - 'SHELL': '/bin/bash', 06:18:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nmiEokDztP/Listeners', 06:18:23 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 06:18:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:18:23 INFO - 'USER': 'cltbld', 06:18:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:18:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:18:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:23 INFO - 'XPC_FLAGS': '0x0', 06:18:23 INFO - 'XPC_SERVICE_NAME': '0', 06:18:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:18:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XJKtJC_hRAiYw-sPeEFOlw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:18:23 INFO - mozversion application_buildid: 20160329051635 06:18:23 INFO - mozversion application_changeset: 971ee95dade06b20742e94d58c471e76705ca478 06:18:23 INFO - mozversion application_display_name: Nightly 06:18:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:18:23 INFO - mozversion application_name: Firefox 06:18:23 INFO - mozversion application_remotingname: firefox 06:18:23 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:18:23 INFO - mozversion application_vendor: Mozilla 06:18:23 INFO - mozversion application_version: 48.0a1 06:18:23 INFO - mozversion platform_buildid: 20160329051635 06:18:23 INFO - mozversion platform_changeset: 971ee95dade06b20742e94d58c471e76705ca478 06:18:23 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:18:23 INFO - mozversion platform_version: 48.0a1 06:18:23 INFO - using testdate: 1459257503 06:18:23 INFO - actual date: 1459257503 06:18:23 INFO - starting webserver on 'localhost:49278' 06:18:23 INFO - SUITE-START | Running 2 tests 06:18:23 INFO - TEST-START | dromaeo_css 06:18:23 INFO - operating with platform_type : mac_ 06:18:23 INFO - Initialising browser for dromaeo_css test... 06:18:23 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/tmpNQVoCY/profile http://localhost:49278/getInfo.html) 06:18:25 INFO - PROCESS | 1666 | __metrics Screen width/height:1600/1200 06:18:25 INFO - PROCESS | 1666 | colorDepth:24 06:18:25 INFO - PROCESS | 1666 | Browser inner width/height: 1024/689 06:18:25 INFO - PROCESS | 1666 | __metrics 06:18:25 INFO - PROCESS | 1666 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:18:25 ERROR - PROCESS | 1666 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:18:26 INFO - TEST-INFO | 1666: exit 0 06:18:26 INFO - Browser initialized. 06:18:26 INFO - Running cycle 1/1 for dromaeo_css test... 06:18:26 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/tmpNQVoCY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:18:38 INFO - PROCESS | 1669 | RSS: Main: 244178944 06:18:38 INFO - PROCESS | 1669 | 06:19:29 INFO - PROCESS | 1669 | 1459257569167 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 06:21:39 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 06:21:41 INFO - PROCESS | 1669 | RSS: Main: 330317824 06:21:41 INFO - PROCESS | 1669 | 06:24:43 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 06:24:44 INFO - PROCESS | 1669 | RSS: Main: 371044352 06:24:44 INFO - PROCESS | 1669 | 06:27:46 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 06:27:46 INFO - PROCESS | 1669 | RSS: Main: 372641792 06:27:46 INFO - PROCESS | 1669 | 06:30:48 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 06:30:49 INFO - PROCESS | 1669 | RSS: Main: 333123584 06:30:49 INFO - PROCESS | 1669 | 06:33:52 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 06:33:52 INFO - PROCESS | 1669 | RSS: Main: 333467648 06:33:52 INFO - PROCESS | 1669 | 06:36:55 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 06:36:55 INFO - PROCESS | 1669 | RSS: Main: 415408128 06:36:55 INFO - PROCESS | 1669 | 06:36:55 INFO - PROCESS | 1669 | __start_tp_report 06:36:55 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 06:36:55 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 06:36:55 INFO - PROCESS | 1669 | |i|pagename|runs| 06:36:55 INFO - PROCESS | 1669 | |0;dojo.html;2747;3462.584489861217;3509.526213961116;3511.4908338290966;3555.075680323115;5564.721763911798;5651.971740141304;5669.914951275729;5671.659700417978;5678.205051292817;5654.321481422235;5655.321361436633;5763.1355296705515;5816.098504731774;5824.592278540504;4677.438707355105;4763.071201115784;5080.568151707109;5111.872203194913;5171.948280517203;5202.4277329493725;5217.791288348461;5241.86895327616;5253.290805741233;5270.631055826094;5126.71803050832;5164.251183578379;5171.844844654666;5201.193814958688;5217.295665085203;5130.230465430215;5177.715225662587;5194.870128246786;5209.791608335662;5225.111731005738;5146.948530514722;5156.767945442427;5160.380754309507;5161.767720452589;5192.558632516203;5511.5039646432015;5573.303337082864;5603.411641777596;5604.299462567179;5604.8038318659055;6067.089936509559;6135.509159267248;6212.378762123797;6216.098665693495;6220.937790622126;5135.537801597874;6158.907616385758;6261.718222679945;6268.341824108448;6281.654509002003;5723.942760572382;5745.540356771448;5798.942010579883;5805.999999999958;5818.301803783573;6157.891579515641;6198.566100372931;6224.533160013018;6241.843953901189;6271.122042913996;6014.218151640346;6066.272047354346;6067.1202675611785;6102.549845102808;6126.264848218153;6215.751369945242;6222.253329600387;6227.439530442282;6239.376062393724;6245.28179259391;6060.181875446847;6114.266954506099;6212.161358216583;6224.346443623354;6228.5017198624;6134.559047376611;6216.067589861557;6218.906716399258;6227.750889964351;6254.499640028877;4819.349387832598;4857.028594281158;4866;4871.537203965618;4901.656884018084;3360.6975372216616;3516.226430185355;4381.079973205662;4442.200403927324;4480.641548676098;5621.0444224481935;5647.152927060892;5649.378568357477;5660.688662123623;5669.744861481243;6138.756267604181;6140.385961403913;6143.38566143391;6225.595336303217;6248.281447633581;5714.542836573064;5714.685692286964;5717.857053573611;5721.256236689203;5748.367679555246;5200.609954253446;5262.736863156903;5334.786608535693;5348.973255133699;5371.704556249444;6293.905591416133;6314.0528920661345;6349.460295874902;6363.490920726424;6379.266384365765;6151.876962460815;6155.322914479493;6161.753529858755;6173.104899789416;6191.19514463117;6181.721822517908;6256.937430625818;6300.2754683212015;6347.365263473615;6361.90457143134;6105.672036200829;6138.202033735586;6143.600665956698;6150.04674275488;6154.846128846814;6036.3058248302;6146.323904370426;6174.413430724074;6187.474064704551;6194.163787888578;5988.101784732325;6040.7583696651645;6108.281362585925;6128.63228206309;6139;6099.8243298231955;6105.763021687103;6109.022556390956;6110.16388879229;6113.993245360445;5980.43185897339;5997.130416089555;6008.639481631116;6008.76820251856;6010.398960103955;5892.646441213541;6080.391960803884;6136.7852125175405;6140.956037473551;6142.928535732134;5965.850853728518;5985.910211346746;5988.790392336247;6002.459778619946;6006.399360063959 06:36:55 INFO - PROCESS | 1669 | |1;ext.html;478.50713764822245;579.9304083509977;605.6547767772369;644.709880553751;646.8641585267094;29980.650870710815;37378.25243495128;37750.62249377505;37865.674701385455;38023.859284221486;41319;41661.375079373836;41705.58294417055;41788.95527611811;41801;9446.480443575601;9635.084666956627;9680.56437460316;9683.951580242088;9685.031496850293;9449.480278584675;9571.80856382872;9584.80830383392;9591.184749296282;9605.18355939746;9560.474173920431;9667.75830604237;9734.51327433629;9756.707298781048;9772.657956971507;9608.471534065624;9698.951505242429;9701.126898579127;9710.757231069209;9711.757206069904;9568.76078098053;9693.466859322734;9693.854592181124;9704.320697551175;9720.125188732978;39797.40303895444;40032.59967400318;40057.39913901294;40089.39865902014;40148.799256003535;3119.672434394401;3222.1622378181605;3222.355528894207;3278.49183376577;3405.4891766235014;27856.30359241015;28146.577801333;28887.42225155506;28939;29062.70937290621;2748.4228312054493;2768.390953990139;2776.6390369251867;2776.7917406194615;2935.911922642324;464652;465615;465710;466704;467125.3287467116;44294.114117717465;61022;61561.38438615646;61647.691761540904;61870;43999;44003.77998109989;44196.779016105356;44358.33462498065;44381.556184438385;15254.23728813555;15517.45688900883;15546.9222653886;15566.688666226612;15586.9220653896;12545.874541254652;12573.748525029449;12577.496900123893;12595.622131336075;12621.873781262253;14036.29818509091;14062.296885155702;14300.928495357457;14354.354054067591;14400.20798856052;6116.143739876421;6171.938280617226;6210.5652604317265;6216.720247588869;6253.218347706536;884.5046773806689;920.6455514626917;981.7741919358444;1021.2340744441668;1061.363182090755;28017.019404320752;28390;28910.566341504895;28990.535804456435;29015.98444054448;1109.295597295723;1145.8223975283845;1146.6502716671496;1152.7060599547062;1177.2053863642006;13603.251821149932;14413.495527656481;14486.275686215648;14783.482578109715;14876.851231487763;528536.3573182187;530849.6915030878;531129;533932;534009;55300.170497442574;57373.71313143491;57571.424285756606;57601.423985759604;57670.55823604443;1319.531566293971;1342.2483409290633;1420.708754705283;1438.173050495969;1456.0026381928412;27267.454650906475;27452.17643470619;27977.44045119127;28189.57715634226;28278;43472;43905.78047109744;44107;44127.558724412345;44264.55735442604;307343;308031;308622;309179;309278;28016.579751304154;31921.840390797897;32728;32958;33193.83403082969;39677;41221.23025216754;42640.78679606582;42759.3586096215;43808.78095609502;34421.311573768886;35244;36153.819230903675;36195.45706814347;36485.08787280339;34826.47760283649;34892.47661285032;34961.65038349584;35744.821275894494;35752.82123589469;35565.288694225455;35695.64304356923;35774;37355.81322093372;38072.04819879525;28664.283392915346;29111.563326549694;30153.547696784128;30401.84799076079;30578.541321879744;18502.774766854367;20319.898400507904;20608;23225.76774232236;23594.52810943806 06:36:55 INFO - PROCESS | 1669 | |2;jquery.html;369.50855362368054;370.96846768024716;373.86353980797;380.1996796742856;382.81242191326226;19408.029598520072;20265.290714824983;20346.694799578017;20429.897850510763;20695.275665351717;20117.798822011777;20336.593268134628;20859.582808343825;20989.950502474854;21014.369568912956;5340.519353258206;5821.563382746301;5989.580729348947;5998.4001599839885;6039.4262545058145;5577.414371490996;5830.62100963436;5833.737481813308;5850;5950.9107363389585;5816.476517113459;5837.1536127261525;5838.970805145968;5840.503557197643;5842.269716285465;5841.737121829507;6307.27466341372;6440.420362167404;6486.545941784077;6504.1869766279215;5683.119116536944;5695.088785794294;5709.942900570983;5710.77156913723;5738.598298119134;12390.690232744164;12889.355532223351;12930.935345323307;12931.353432328346;12935.80596291047;1969.241841890868;2161.9783802161933;2253.6140273731703;2699.5140874642752;2779.194033730216;9580;9699.272554558365;10155.847662285072;13240.933795330962;14176.787348189786;1435.9210243436607;1693.6528011757684;1702.608400067979;1758.1648716859518;1762.0749106718947;91143;91999;95576.52211738897;95833;95967;9074.729537864705;10944.343339399662;10966;11044.889551104387;11134.721631959104;13671.453141874412;13698.452061917611;13742.587722368346;13775.242361670003;13811.240381779098;8231.34149268057;8405.495670259805;8407.495550267004;8484.915150848536;8503.14968503157;8397.328213742885;8440.57797110142;8472.406931514735;8519.275861551838;8520.914790852135;4420;4439.311906654474;4445.444319460067;4448.021435284232;4492.820287188541;1806.7470554122433;1846.4645252876514;1850.555866592035;1866.9346572870156;1887.5465891263925;885.384657662931;898.7573355194061;926.501833597886;934.5981228071859;1085.945702714861;16782.664346712998;19235.615287694447;19469.92915389667;19613;19833.404997850088;948.7675519497767;959.2901253072815;961.1157734883924;989.188865130586;1011.9848202276971;10202.687991132418;10397.84403233952;10403.687889363331;10409.479526023668;10469;599091;623725;638109;638301;648872;84173.57913210517;85416;102481;102859;105504;842.5534466732641;1035.8756949165997;1060.745421098946;1062.5909025025421;1064.2762921213493;13747.587572372844;16819.327226910787;17020.74468882943;17093.401730939357;17407.82592174113;30708;44827;45622.31566526438;45761.542384575725;47762.52237477581;56416.717916410154;56570;59986.40013599983;61660.07509887445;62982.425439364386;7347.33873951347;7619.69521219145;7689.615519224129;7843.6862525498345;7981.521108733495;9859.507024648883;11447.771044579229;12080.51677932873;12226.572069977508;12452.377381131088;10764.515596798006;10836.349819010884;10932.234743567873;11150.888491114985;11171.106311495223;10534.36793792375;10557.472126393803;10744.83882741744;10977.725556861142;11021.173411994292;9103.681371151977;10986.890131098588;11091.223614346918;11236.66290011301;11325.886741132812;7616.657250423855;7708.229177082247;7747.496412733154;8002.159773223728;8142.18578142181;10006;10860.837087443853;10935.890641093805;11200.887991119984;11275 06:36:55 INFO - PROCESS | 1669 | |3;mootools.html;1432.5129455984963;1595.768613551035;1602.9599260018501;1870.8222718841714;2011.446852115668;7915.92084079159;8498;8679.001914779803;8684.435511691736;8687.56562171892;8473.91526084739;8758.649654013832;8764.868526972085;8778.166074222938;8812.8678069829;2168.176093084626;2257.9096836126537;2393.712754469457;2474.6288056791445;2509.0214816221596;2297.1041293895396;2463.2117722328862;2467.469494058777;2468.7654672806057;2471.5551200783852;2314.6990891184123;2324.93025209244;2379.2624286471164;2386.3556839653284;2396.3769419950763;2423.09134074722;2459.0655550890638;2470;2496.113879572744;2500.612405077216;2437.3175510856813;2470.6911636045493;2473.542394656994;2489.2158969924417;2491.327341617753;8665.263452606472;8771.561421928878;8774.298056155492;8782.07788182238;8785.956070219672;5404.729763511808;5522.254495643077;5522.66863988162;5558;5584.972075139639;3526.717862570988;3542.4155014422845;3629.2015756533783;3687.4468829675493;3704.518412606371;1044.6395993382348;1055.5250137438106;1057.6139709006234;1069.6149386220955;1074.274864466482;11703.765924681544;11781.293122412597;11784.88215117855;11788.764224715458;11792.88207117935;4855.1018061658;4869;4894.3147959285725;4916.262560615936;4923.729194894244;10058.34620749649;10076.19390448777;10092.990700929995;10094.24293178;10097.949510252402;5475.835724928259;5476.67139971603;5482.588805839578;5483.588730845203;5489.34127904654;3666.8899933002053;4584.77076146198;4779.187538118528;4838.782254798542;4916.8770780730765;3360.479125735515;3830.5594856591847;3907.5115610548683;3926.6466018058513;3971.940420893689;1307.300594182108;1323.1928523600595;1324.9801252981213;1338.344211336438;1339.3236415610054;1099.631623406152;1113.6213687346342;1113.660333598244;1301.7266374061364;1406.7889816527397;8157.75526734199;8208.630611622491;8260.752177434686;8273.255407013397;8286.668533258602;505.858359659296;506.6250974279007;510.8416390918827;512.451676705921;525.3118414876524;6227.844303892439;6249.000159974473;6300.621962682254;6310.211223597051;6321.304656487782;10213.489325533843;10547.208959328082;10579.682609521727;10674.62638807638;10706.571737130584;10002.199824014062;10456.006679365448;10526.999935006163;10573.577056917637;10573.788524229472;8107.351411887035;8228.8354232915;8254.174582541698;8268.83462330762;8271.917280827114;8072.677092916218;8131.105578386491;8139.918600813916;8188.549629770419;8245.752627421187;9284.675036373694;9308.813823723623;9432.386894851812;9472.857907131536;9560.856587151338;9714.3199976001;9846.950765246127;9939.453330066915;9975.700728978143;10000.099981003586;6766.830829229309;6844.28135045813;7330.743423980349;7523.774286771406;7673.386129109546;8204.015518137861;8245.876311855207;8287.254147126787;8294.668213271401;8303.626336814737;7233.168185658506;7275.236100209613;7308.30571095745;7444.255574442729;7477.551346919202;7044.612546309797;7219.205887352492;7224.74713385029;7246.96376518114;7285.417166626763;7622.16156222804;7706.807329816799;7711.305982461606;7720.382369410321;7727.381809455118;5780.797672081457;6920.757773477904;7013.158420989514;7016.158061032709;7022.789316320519;7040.0847889774;7095.609741464269;7126.465515086285;7130.2869713028285;7133.429325653831 06:36:55 INFO - PROCESS | 1669 | |4;prototype.html;330.47619523055954;333.7430178762353;339.3941813862256;340.84491556341857;344.43512639271586;6459.257185423678;6488.994205898081;6524.2170939487205;6527.11883895674;6552.475801935846;6375.10748495211;6402.071699603554;6430.356964303567;6438.066480360345;6438.742450301982;4540.568645978627;4634.72191668501;4646.4888862225125;4718.764061796896;4853.1506986277345;4801.759912004403;4802.975985120087;4803.663743537953;4807.591354734852;4815.638827087965;4749.335093086971;4767.880802979936;4771.093492236481;4777.378940737699;4782.234842425212;4586.2661974083985;4711.104890070876;4723.929141062887;4774.737389443597;4783.115123702126;4013.478247827793;4070.5929407059057;4106.7946602669745;4128.4632997710405;4136.855210067663;6175.69121543921;6194.194754681907;6224;6227.346128656471;6228.252609686821;5586.273784408041;5608.551315894719;5618;5624.15637654351;5627.6060675752715;6844.589324640538;6852.246252912176;6853.17761868574;6863.691133898937;6883;3518.7888726676483;4448.1770872388715;4499.572540608637;4607.654425918036;4608.032313214229;7135.82160445993;7138.714451421937;7157.785266441963;7179.748708795167;7199.712011519533;4542.364069030338;4547.408836851188;4551.226291530448;4555.658325625592;4557.1797076526545;3827.75119617224;4617.46899106607;4620.075984803053;4627.583517483443;4636.675432719745;4072.714909956334;5443.727813609383;5446.537044351196;5488.368837583649;5605.495505404451;5235.267062611238;6872.278410766898;6873.106496155568;6880.69036893341;6892.862142757217;1556.097463471184;1566.6240102375575;1573.622330640638;1575.04709650662;1580.7944967154197;1007.7326016462958;1014.2393205096178;1030.299396410433;1031.200819364983;1036.4403222259896;6115.877682446326;6317.936820631827;6363.172787537591;6372.968135159294;6389.274895778114;5863.501602363762;6389.073584330246;6766.864662706718;7012.018317435563;7205.9551365051775;6419.679016049179;6431.067495213261;6574.474042076718;6590.868182636416;6599.901001484982;3308.6195087564756;3615.060084378081;3750.2124553843996;3800.410936304877;3812.1232116613332;7107.822304442327;7451.254874512505;7459.440541959266;7460.358721081353;7488.438367122488;5961.5230781537375;7229.493935424575;7336.926630733731;7388.261173882569;7389.408847292204;7465.962670186615;7470.103587569526;7474.327310542078;7485.101787785392;7496.400287977058;7072.257412971564;7088.220295767358;7096.432285417258;7101.964490177516;7104.857902842017;6707.5304728668525;6912.654367281716;7008.824779380557;7014.473914456335;7051.894221586783;5733.397993210653;6904.689288981907;7434.479586428898;7466.664000120117;7489.475736698379;4503.279475283939;4536.342230376643;4556.476005259437;4566.383538222298;4566.429196350457;5774.740136693775;6011.729472173675;6556.016597510412;6983.847665135399;7126.857462850818;6872.347127022925;6872.725090996504;6885.001674757032;6901.240863505111;6913.1358580177475;6649.368310010541;6902.896456553256;6920.619365934922;6937.017082654507;6951.27011663768;4990.80036798524;6492.870142597216;6533.41199292066;6737.023131645982;6800.217974932946;6909.861802764017;6911.516193866381;6928.203256625351;6928.688209030706;6951.6871740770775;5472.644278121909;6484.935150648622;6750.25747167821;6752.3922846944015;6763 06:36:55 INFO - PROCESS | 1669 | |5;yui.html;646.5151136647514;678.4470656415021;757.11795757942;757.8329372765941;771.9228077192284;15271.08373497591;15287.312070956807;15288.69422611547;15308.234588270583;15376.615584610376;12960.416781244843;13943.302834858267;13959.232242226699;13972;14049.227292498908;696.7944456385378;700.4816435837469;931.3201363005011;941.7268991992314;943.377370935183;932.4405356785942;934.4907025671025;936.9016253293408;938.8075444533854;941.9858702119474;992.3995982430633;993.7167907146464;995.0348162282611;995.3530205366498;997.3816233934934;811.8579248631495;977.6675930183736;984.9704508864673;985.3890587835516;986.082942863137;743.0488974113143;746.0413368821039;746.6901235987059;747.55146911853;748.4349316266239;13182.143160694524;13202.075854690176;13229.206247625174;13255.801162982563;13271.601851944457;11016.834747478793;11227.831582526269;11260.43697815106;11332.490037948312;11338.376389298584;9274.211692006187;9392.248620110375;9580.520973951345;9623.711288661281;9893;3313.2635296582507;3372.359251742161;3404.5744281964753;3413.7951722896455;3491.8777842775635;74381;75713;77543.61228193823;77604.44791104147;77718.22281777223;8049.758507244792;8191.549464779375;8226.917730822735;8236;8356.749297521084;18830.3409380671;18879;18901.905490472458;18917.33789317395;18938.337158199396;6843.486738494633;6985.825354366181;6994.02083708271;7128.465365097639;7160.57036577807;3836.9232615347537;3972.7616343019513;4000.299947509174;4020.618041286073;4312.202242585132;3374.1733275347697;3437.415639341318;3441.8107004115013;3443.5351227584456;3445.397055515325;568.573569822633;681.4990981628499;682.9214640316328;707.8407358344434;711.9572825630479;497.9502049794992;533.5038414274761;585.3122580967431;605.2102006880974;606.263389981175;7460.589667568336;8106.837863242702;8250.752477425687;8254.380921430917;8349.666013359398;432.60848931716845;584.231735268121;596.8299034775068;612.2561088277764;618.6659204029773;3772.679322257639;3776.150366167645;3810.2569998850513;3985.442038114666;3996.6403023728003;77815;85521.86195345166;86996.56501717577;92284.53857730802;92583;48984;77313.2268677306;77740;77783.22216777873;79015.60492197618;67913.66043169753;70252.29747702458;70345.94481082787;71130;72331.63834180795;7563.281488258606;7570.318671319607;7700.8074798128255;7929.682812687428;7994.960025199837;45093.872653183935;46326.74588930586;47427.762861185474;48249.03501929872;49345.75327123485;53284.73357633187;61916.38083619106;63036.36963630305;63324.36675633369;66757;11072.944635276772;11135.276207046516;11247.606333778605;11569.36368499707;12229.205101668718;10109.34289271195;12014.699632509257;12038.699032524257;12100.697482563006;12158.574449894211;11326.660200194008;11513.251638643462;11780.05759539252;11914.940425297818;12116.697082573006;11471.598494052669;11481.36852473122;11544.365059921785;11706.356150411468;11864.584739534075;11312.6040588579;11344.602938897098;11718.121140914294;11767.470463828977;11818.409079545816;8215;9262.16640502358;9298.860517092384;9528.28537859677;9939.950300248453;7484.663190156565;8828.205461508494;9323.347365684336;9365.438073715599;9411.576479058596 06:36:55 INFO - PROCESS | 1669 | __end_tp_report 06:36:55 INFO - PROCESS | 1669 | __start_cc_report 06:36:55 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,1179 06:36:55 INFO - PROCESS | 1669 | __end_cc_report 06:36:55 INFO - PROCESS | 1669 | __startTimestamp1459258615802__endTimestamp 06:36:55 INFO - PROCESS | 1669 | 06:36:55 INFO - PROCESS | 1669 | ------- Summary: start ------- 06:36:55 INFO - PROCESS | 1669 | Number of tests: 6 06:36:55 INFO - PROCESS | 1669 | 06:36:55 INFO - PROCESS | 1669 | [#0] dojo.html Cycles:165 Average:5697.61 Median:5997.13 stddev:678.02 (11.3%) stddev-sans-first:639.37 06:36:55 INFO - PROCESS | 1669 | Values: 2747.0 3462.6 3509.5 3511.5 3555.1 5564.7 5652.0 5669.9 5671.7 5678.2 5654.3 5655.3 5763.1 5816.1 5824.6 4677.4 4763.1 5080.6 5111.9 5171.9 5202.4 5217.8 5241.9 5253.3 5270.6 5126.7 5164.3 5171.8 5201.2 5217.3 5130.2 5177.7 5194.9 5209.8 5225.1 5146.9 5156.8 5160.4 5161.8 5192.6 5511.5 5573.3 5603.4 5604.3 5604.8 6067.1 6135.5 6212.4 6216.1 6220.9 5135.5 6158.9 6261.7 6268.3 6281.7 5723.9 5745.5 5798.9 5806.0 5818.3 6157.9 6198.6 6224.5 6241.8 6271.1 6014.2 6066.3 6067.1 6102.5 6126.3 6215.8 6222.3 6227.4 6239.4 6245.3 6060.2 6114.3 6212.2 6224.3 6228.5 6134.6 6216.1 6218.9 6227.8 6254.5 4819.3 4857.0 4866.0 4871.5 4901.7 3360.7 3516.2 4381.1 4442.2 4480.6 5621.0 5647.2 5649.4 5660.7 5669.7 6138.8 6140.4 6143.4 6225.6 6248.3 5714.5 5714.7 5717.9 5721.3 5748.4 5200.6 5262.7 5334.8 5349.0 5371.7 6293.9 6314.1 6349.5 6363.5 6379.3 6151.9 6155.3 6161.8 6173.1 6191.2 6181.7 6256.9 6300.3 6347.4 6361.9 6105.7 6138.2 6143.6 6150.0 6154.8 6036.3 6146.3 6174.4 6187.5 6194.2 5988.1 6040.8 6108.3 6128.6 6139.0 6099.8 6105.8 6109.0 6110.2 6114.0 5980.4 5997.1 6008.6 6008.8 6010.4 5892.6 6080.4 6136.8 6141.0 6142.9 5965.9 5985.9 5988.8 6002.5 6006.4 06:36:55 INFO - PROCESS | 1669 | 06:36:55 INFO - PROCESS | 1669 | [#1] ext.html Cycles:180 Average:57389.72 Median:36920.45 stddev:118577.18 (321.2%) stddev-sans-first:118832.83 06:36:55 INFO - PROCESS | 1669 | Values: 478.5 579.9 605.7 644.7 646.9 29980.7 37378.3 37750.6 37865.7 38023.9 41319.0 41661.4 41705.6 41789.0 41801.0 9446.5 9635.1 9680.6 9684.0 9685.0 9449.5 9571.8 9584.8 9591.2 9605.2 9560.5 9667.8 9734.5 9756.7 9772.7 9608.5 9699.0 9701.1 9710.8 9711.8 9568.8 9693.5 9693.9 9704.3 9720.1 39797.4 40032.6 40057.4 40089.4 40148.8 3119.7 3222.2 3222.4 3278.5 3405.5 27856.3 28146.6 28887.4 28939.0 29062.7 2748.4 2768.4 2776.6 2776.8 2935.9 464652.0 465615.0 465710.0 466704.0 467125.3 44294.1 61022.0 61561.4 61647.7 61870.0 43999.0 44003.8 44196.8 44358.3 44381.6 15254.2 15517.5 15546.9 15566.7 15586.9 12545.9 12573.7 12577.5 12595.6 12621.9 14036.3 14062.3 14300.9 14354.4 14400.2 6116.1 6171.9 6210.6 6216.7 6253.2 884.5 920.6 981.8 1021.2 1061.4 28017.0 28390.0 28910.6 28990.5 29016.0 1109.3 1145.8 1146.7 1152.7 1177.2 13603.3 14413.5 14486.3 14783.5 14876.9 528536.4 530849.7 531129.0 533932.0 534009.0 55300.2 57373.7 57571.4 57601.4 57670.6 1319.5 1342.2 1420.7 1438.2 1456.0 27267.5 27452.2 27977.4 28189.6 28278.0 43472.0 43905.8 44107.0 44127.6 44264.6 307343.0 308031.0 308622.0 309179.0 309278.0 28016.6 31921.8 32728.0 32958.0 33193.8 39677.0 41221.2 42640.8 42759.4 43808.8 34421.3 35244.0 36153.8 36195.5 36485.1 34826.5 34892.5 34961.7 35744.8 35752.8 35565.3 35695.6 35774.0 37355.8 38072.0 28664.3 29111.6 30153.5 30401.8 30578.5 18502.8 20319.9 20608.0 23225.8 23594.5 06:36:55 INFO - PROCESS | 1669 | 06:36:55 INFO - PROCESS | 1669 | [#2] jquery.html Cycles:180 Average:33000.91 Median:370.24 stddev:103618.65 (27987.0%) stddev-sans-first:103880.36 06:36:55 INFO - PROCESS | 1669 | Values: 369.5 371.0 373.9 380.2 382.8 19408.0 20265.3 20346.7 20429.9 20695.3 20117.8 20336.6 20859.6 20990.0 21014.4 5340.5 5821.6 5989.6 5998.4 6039.4 5577.4 5830.6 5833.7 5850.0 5950.9 5816.5 5837.2 5839.0 5840.5 5842.3 5841.7 6307.3 6440.4 6486.5 6504.2 5683.1 5695.1 5709.9 5710.8 5738.6 12390.7 12889.4 12930.9 12931.4 12935.8 1969.2 2162.0 2253.6 2699.5 2779.2 9580.0 9699.3 10155.8 13240.9 14176.8 1435.9 1693.7 1702.6 1758.2 1762.1 91143.0 91999.0 95576.5 95833.0 95967.0 9074.7 10944.3 10966.0 11044.9 11134.7 13671.5 13698.5 13742.6 13775.2 13811.2 8231.3 8405.5 8407.5 8484.9 8503.1 8397.3 8440.6 8472.4 8519.3 8520.9 4420.0 4439.3 4445.4 4448.0 4492.8 1806.7 1846.5 1850.6 1866.9 1887.5 885.4 898.8 926.5 934.6 1085.9 16782.7 19235.6 19469.9 19613.0 19833.4 948.8 959.3 961.1 989.2 1012.0 10202.7 10397.8 10403.7 10409.5 10469.0 599091.0 623725.0 638109.0 638301.0 648872.0 84173.6 85416.0 102481.0 102859.0 105504.0 842.6 1035.9 1060.7 1062.6 1064.3 13747.6 16819.3 17020.7 17093.4 17407.8 30708.0 44827.0 45622.3 45761.5 47762.5 56416.7 56570.0 59986.4 61660.1 62982.4 7347.3 7619.7 7689.6 7843.7 7981.5 9859.5 11447.8 12080.5 12226.6 12452.4 10764.5 10836.3 10932.2 11150.9 11171.1 10534.4 10557.5 10744.8 10977.7 11021.2 9103.7 10986.9 11091.2 11236.7 11325.9 7616.7 7708.2 7747.5 8002.2 8142.2 10006.0 10860.8 10935.9 11200.9 11275.0 06:36:55 INFO - PROCESS | 1669 | 06:36:55 INFO - PROCESS | 1669 | [#3] mootools.html Cycles:180 Average:6010.35 Median:2965.02 stddev:3191.70 (107.6%) stddev-sans-first:3182.10 06:36:55 INFO - PROCESS | 1669 | Values: 1432.5 1595.8 1603.0 1870.8 2011.4 7915.9 8498.0 8679.0 8684.4 8687.6 8473.9 8758.6 8764.9 8778.2 8812.9 2168.2 2257.9 2393.7 2474.6 2509.0 2297.1 2463.2 2467.5 2468.8 2471.6 2314.7 2324.9 2379.3 2386.4 2396.4 2423.1 2459.1 2470.0 2496.1 2500.6 2437.3 2470.7 2473.5 2489.2 2491.3 8665.3 8771.6 8774.3 8782.1 8786.0 5404.7 5522.3 5522.7 5558.0 5585.0 3526.7 3542.4 3629.2 3687.4 3704.5 1044.6 1055.5 1057.6 1069.6 1074.3 11703.8 11781.3 11784.9 11788.8 11792.9 4855.1 4869.0 4894.3 4916.3 4923.7 10058.3 10076.2 10093.0 10094.2 10097.9 5475.8 5476.7 5482.6 5483.6 5489.3 3666.9 4584.8 4779.2 4838.8 4916.9 3360.5 3830.6 3907.5 3926.6 3971.9 1307.3 1323.2 1325.0 1338.3 1339.3 1099.6 1113.6 1113.7 1301.7 1406.8 8157.8 8208.6 8260.8 8273.3 8286.7 505.9 506.6 510.8 512.5 525.3 6227.8 6249.0 6300.6 6310.2 6321.3 10213.5 10547.2 10579.7 10674.6 10706.6 10002.2 10456.0 10527.0 10573.6 10573.8 8107.4 8228.8 8254.2 8268.8 8271.9 8072.7 8131.1 8139.9 8188.5 8245.8 9284.7 9308.8 9432.4 9472.9 9560.9 9714.3 9847.0 9939.5 9975.7 10000.1 6766.8 6844.3 7330.7 7523.8 7673.4 8204.0 8245.9 8287.3 8294.7 8303.6 7233.2 7275.2 7308.3 7444.3 7477.6 7044.6 7219.2 7224.7 7247.0 7285.4 7622.2 7706.8 7711.3 7720.4 7727.4 5780.8 6920.8 7013.2 7016.2 7022.8 7040.1 7095.6 7126.5 7130.3 7133.4 06:36:55 INFO - PROCESS | 1669 | 06:36:55 INFO - PROCESS | 1669 | [#4] prototype.html Cycles:180 Average:5568.62 Median:6368.07 stddev:1779.61 (27.9%) stddev-sans-first:1740.63 06:36:55 INFO - PROCESS | 1669 | Values: 330.5 333.7 339.4 340.8 344.4 6459.3 6489.0 6524.2 6527.1 6552.5 6375.1 6402.1 6430.4 6438.1 6438.7 4540.6 4634.7 4646.5 4718.8 4853.2 4801.8 4803.0 4803.7 4807.6 4815.6 4749.3 4767.9 4771.1 4777.4 4782.2 4586.3 4711.1 4723.9 4774.7 4783.1 4013.5 4070.6 4106.8 4128.5 4136.9 6175.7 6194.2 6224.0 6227.3 6228.3 5586.3 5608.6 5618.0 5624.2 5627.6 6844.6 6852.2 6853.2 6863.7 6883.0 3518.8 4448.2 4499.6 4607.7 4608.0 7135.8 7138.7 7157.8 7179.7 7199.7 4542.4 4547.4 4551.2 4555.7 4557.2 3827.8 4617.5 4620.1 4627.6 4636.7 4072.7 5443.7 5446.5 5488.4 5605.5 5235.3 6872.3 6873.1 6880.7 6892.9 1556.1 1566.6 1573.6 1575.0 1580.8 1007.7 1014.2 1030.3 1031.2 1036.4 6115.9 6317.9 6363.2 6373.0 6389.3 5863.5 6389.1 6766.9 7012.0 7206.0 6419.7 6431.1 6574.5 6590.9 6599.9 3308.6 3615.1 3750.2 3800.4 3812.1 7107.8 7451.3 7459.4 7460.4 7488.4 5961.5 7229.5 7336.9 7388.3 7389.4 7466.0 7470.1 7474.3 7485.1 7496.4 7072.3 7088.2 7096.4 7102.0 7104.9 6707.5 6912.7 7008.8 7014.5 7051.9 5733.4 6904.7 7434.5 7466.7 7489.5 4503.3 4536.3 4556.5 4566.4 4566.4 5774.7 6011.7 6556.0 6983.8 7126.9 6872.3 6872.7 6885.0 6901.2 6913.1 6649.4 6902.9 6920.6 6937.0 6951.3 4990.8 6492.9 6533.4 6737.0 6800.2 6909.9 6911.5 6928.2 6928.7 6951.7 5472.6 6484.9 6750.3 6752.4 6763.0 06:36:55 INFO - PROCESS | 1669 | 06:36:55 INFO - PROCESS | 1669 | [#5] yui.html Cycles:180 Average:17392.64 Median:31985.44 stddev:24369.98 (76.2%) stddev-sans-first:24405.90 06:36:55 INFO - PROCESS | 1669 | Values: 646.5 678.4 757.1 757.8 771.9 15271.1 15287.3 15288.7 15308.2 15376.6 12960.4 13943.3 13959.2 13972.0 14049.2 696.8 700.5 931.3 941.7 943.4 932.4 934.5 936.9 938.8 942.0 992.4 993.7 995.0 995.4 997.4 811.9 977.7 985.0 985.4 986.1 743.0 746.0 746.7 747.6 748.4 13182.1 13202.1 13229.2 13255.8 13271.6 11016.8 11227.8 11260.4 11332.5 11338.4 9274.2 9392.2 9580.5 9623.7 9893.0 3313.3 3372.4 3404.6 3413.8 3491.9 74381.0 75713.0 77543.6 77604.4 77718.2 8049.8 8191.5 8226.9 8236.0 8356.7 18830.3 18879.0 18901.9 18917.3 18938.3 6843.5 6985.8 6994.0 7128.5 7160.6 3836.9 3972.8 4000.3 4020.6 4312.2 3374.2 3437.4 3441.8 3443.5 3445.4 568.6 681.5 682.9 707.8 712.0 498.0 533.5 585.3 605.2 606.3 7460.6 8106.8 8250.8 8254.4 8349.7 432.6 584.2 596.8 612.3 618.7 3772.7 3776.2 3810.3 3985.4 3996.6 77815.0 85521.9 86996.6 92284.5 92583.0 48984.0 77313.2 77740.0 77783.2 79015.6 67913.7 70252.3 70345.9 71130.0 72331.6 7563.3 7570.3 7700.8 7929.7 7995.0 45093.9 46326.7 47427.8 48249.0 49345.8 53284.7 61916.4 63036.4 63324.4 66757.0 11072.9 11135.3 11247.6 11569.4 12229.2 10109.3 12014.7 12038.7 12100.7 12158.6 11326.7 11513.3 11780.1 11914.9 12116.7 11471.6 11481.4 11544.4 11706.4 11864.6 11312.6 11344.6 11718.1 11767.5 11818.4 8215.0 9262.2 9298.9 9528.3 9940.0 7484.7 8828.2 9323.3 9365.4 9411.6 06:36:55 INFO - PROCESS | 1669 | -------- Summary: end -------- 06:36:55 INFO - PROCESS | 1669 | 06:36:56 INFO - TEST-INFO | 1669: exit 0 06:36:56 INFO - TEST-OK | dromaeo_css | took 1113084ms 06:36:56 INFO - TEST-START | kraken 06:36:56 INFO - operating with platform_type : mac_ 06:36:56 INFO - Initialising browser for kraken test... 06:36:56 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/tmpkORfXo/profile http://localhost:49278/getInfo.html) 06:36:58 INFO - PROCESS | 1676 | __metrics Screen width/height:1600/1200 06:36:58 INFO - PROCESS | 1676 | colorDepth:24 06:36:58 INFO - PROCESS | 1676 | Browser inner width/height: 1024/689 06:36:58 INFO - PROCESS | 1676 | __metrics 06:36:58 INFO - PROCESS | 1676 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:36:58 ERROR - PROCESS | 1676 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:36:59 INFO - TEST-INFO | 1676: exit 0 06:36:59 INFO - Browser initialized. 06:36:59 INFO - Running cycle 1/1 for kraken test... 06:36:59 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/tmpkORfXo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:37:11 INFO - PROCESS | 1678 | RSS: Main: 244113408 06:37:11 INFO - PROCESS | 1678 | 06:37:14 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 06:37:14 INFO - PROCESS | 1678 | RSS: Main: 289927168 06:37:14 INFO - PROCESS | 1678 | 06:37:17 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 06:37:17 INFO - PROCESS | 1678 | RSS: Main: 300482560 06:37:17 INFO - PROCESS | 1678 | 06:37:21 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 06:37:21 INFO - PROCESS | 1678 | RSS: Main: 288079872 06:37:21 INFO - PROCESS | 1678 | 06:37:23 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 06:37:24 INFO - PROCESS | 1678 | RSS: Main: 289849344 06:37:24 INFO - PROCESS | 1678 | 06:37:26 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:37:27 INFO - PROCESS | 1678 | RSS: Main: 291016704 06:37:27 INFO - PROCESS | 1678 | 06:37:29 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 06:37:30 INFO - PROCESS | 1678 | RSS: Main: 290959360 06:37:30 INFO - PROCESS | 1678 | 06:37:33 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 06:37:34 INFO - PROCESS | 1678 | RSS: Main: 291020800 06:37:34 INFO - PROCESS | 1678 | 06:37:36 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 06:37:37 INFO - PROCESS | 1678 | RSS: Main: 291422208 06:37:37 INFO - PROCESS | 1678 | 06:37:38 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:37:39 INFO - PROCESS | 1678 | RSS: Main: 324837376 06:37:39 INFO - PROCESS | 1678 | 06:37:41 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:37:41 INFO - PROCESS | 1678 | RSS: Main: 324907008 06:37:41 INFO - PROCESS | 1678 | 06:37:44 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:37:44 INFO - PROCESS | 1678 | RSS: Main: 330874880 06:37:44 INFO - PROCESS | 1678 | 06:37:47 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:37:47 INFO - PROCESS | 1678 | RSS: Main: 332128256 06:37:47 INFO - PROCESS | 1678 | 06:37:50 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:37:51 INFO - PROCESS | 1678 | RSS: Main: 332255232 06:37:51 INFO - PROCESS | 1678 | 06:37:52 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 06:37:53 INFO - PROCESS | 1678 | RSS: Main: 394780672 06:37:53 INFO - PROCESS | 1678 | 06:37:53 INFO - PROCESS | 1678 | __start_tp_report 06:37:53 INFO - PROCESS | 1678 | _x_x_mozilla_page_load 06:37:53 INFO - PROCESS | 1678 | _x_x_mozilla_page_load_details 06:37:53 INFO - PROCESS | 1678 | |i|pagename|runs| 06:37:53 INFO - PROCESS | 1678 | |0;ai-astar;110;109;110;111;113;117;167;164;111;110 06:37:53 INFO - PROCESS | 1678 | |1;audio-beat-detection;155;121;142;159;121;138;147;144;158;152 06:37:53 INFO - PROCESS | 1678 | |2;audio-dft;185;187;184;188;184;186;184;181;261;187 06:37:53 INFO - PROCESS | 1678 | |3;audio-fft;80;72;82;79;56;58;58;76;79;58 06:37:53 INFO - PROCESS | 1678 | |4;audio-oscillator;94;99;124;80;77;83;119;79;79;121 06:37:53 INFO - PROCESS | 1678 | |5;imaging-gaussian-blur;87;84;86;83;88;84;93;83;87;84 06:37:53 INFO - PROCESS | 1678 | |6;imaging-darkroom;92;92;93;92;93;93;109;149;93;92 06:37:53 INFO - PROCESS | 1678 | |7;imaging-desaturate;84;85;86;89;86;85;85;85;84;86 06:37:53 INFO - PROCESS | 1678 | |8;json-parse-financial;54;55;54;54;54;52;53;63;54;51 06:37:53 INFO - PROCESS | 1678 | |9;json-stringify-tinderbox;62;70;65;74;69;67;69;67;67;67 06:37:53 INFO - PROCESS | 1678 | |10;stanford-crypto-aes;83;84;83;83;79;82;82;82;82;84 06:37:53 INFO - PROCESS | 1678 | |11;stanford-crypto-ccm;137;134;134;122;123;131;122;131;120;121 06:37:53 INFO - PROCESS | 1678 | |12;stanford-crypto-pbkdf2;141;169;127;159;173;122;162;176;154;138 06:37:53 INFO - PROCESS | 1678 | |13;stanford-crypto-sha256-iterative;67;67;66;68;67;68;66;66;66;67 06:37:53 INFO - PROCESS | 1678 | __end_tp_report 06:37:53 INFO - PROCESS | 1678 | __start_cc_report 06:37:53 INFO - PROCESS | 1678 | _x_x_mozilla_cycle_collect,1313 06:37:53 INFO - PROCESS | 1678 | __end_cc_report 06:37:53 INFO - PROCESS | 1678 | __startTimestamp1459258673072__endTimestamp 06:37:53 INFO - PROCESS | 1678 | 06:37:53 INFO - PROCESS | 1678 | ------- Summary: start ------- 06:37:53 INFO - PROCESS | 1678 | Number of tests: 14 06:37:53 INFO - PROCESS | 1678 | 06:37:53 INFO - PROCESS | 1678 | [#0] ai-astar Cycles:10 Average:122.20 Median:112.00 stddev:22.94 (20.5%) stddev-sans-first:23.91 06:37:53 INFO - PROCESS | 1678 | Values: 110.0 109.0 110.0 111.0 113.0 117.0 167.0 164.0 111.0 110.0 06:37:53 INFO - PROCESS | 1678 | 06:37:53 INFO - PROCESS | 1678 | [#1] audio-beat-detection Cycles:10 Average:143.70 Median:149.50 stddev:13.79 (9.2%) stddev-sans-first:14.01 06:37:53 INFO - PROCESS | 1678 | Values: 155.0 121.0 142.0 159.0 121.0 138.0 147.0 144.0 158.0 152.0 06:37:53 INFO - PROCESS | 1678 | 06:37:53 INFO - PROCESS | 1678 | [#2] audio-dft Cycles:10 Average:192.70 Median:186.50 stddev:24.08 (12.9%) stddev-sans-first:25.38 06:37:53 INFO - PROCESS | 1678 | Values: 185.0 187.0 184.0 188.0 184.0 186.0 184.0 181.0 261.0 187.0 06:37:53 INFO - PROCESS | 1678 | 06:37:53 INFO - PROCESS | 1678 | [#3] audio-fft Cycles:10 Average:69.80 Median:77.50 stddev:10.92 (14.1%) stddev-sans-first:10.94 06:37:53 INFO - PROCESS | 1678 | Values: 80.0 72.0 82.0 79.0 56.0 58.0 58.0 76.0 79.0 58.0 06:37:53 INFO - PROCESS | 1678 | 06:37:53 INFO - PROCESS | 1678 | [#4] audio-oscillator Cycles:10 Average:95.50 Median:79.50 stddev:19.18 (24.1%) stddev-sans-first:20.34 06:37:53 INFO - PROCESS | 1678 | Values: 94.0 99.0 124.0 80.0 77.0 83.0 119.0 79.0 79.0 121.0 06:37:53 INFO - PROCESS | 1678 | 06:37:53 INFO - PROCESS | 1678 | [#5] imaging-gaussian-blur Cycles:10 Average:85.90 Median:86.50 stddev:3.07 (3.6%) stddev-sans-first:3.23 06:37:53 INFO - PROCESS | 1678 | Values: 87.0 84.0 86.0 83.0 88.0 84.0 93.0 83.0 87.0 84.0 06:37:53 INFO - PROCESS | 1678 | 06:37:53 INFO - PROCESS | 1678 | [#6] imaging-darkroom Cycles:10 Average:99.80 Median:92.50 stddev:18.05 (19.5%) stddev-sans-first:18.93 06:37:53 INFO - PROCESS | 1678 | Values: 92.0 92.0 93.0 92.0 93.0 93.0 109.0 149.0 93.0 92.0 06:37:53 INFO - PROCESS | 1678 | 06:37:53 INFO - PROCESS | 1678 | [#7] imaging-desaturate Cycles:10 Average:85.50 Median:85.50 stddev:1.43 (1.7%) stddev-sans-first:1.41 06:37:53 INFO - PROCESS | 1678 | Values: 84.0 85.0 86.0 89.0 86.0 85.0 85.0 85.0 84.0 86.0 06:37:53 INFO - PROCESS | 1678 | 06:37:53 INFO - PROCESS | 1678 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:54.00 stddev:3.24 (6.0%) stddev-sans-first:3.43 06:37:53 INFO - PROCESS | 1678 | Values: 54.0 55.0 54.0 54.0 54.0 52.0 53.0 63.0 54.0 51.0 06:37:53 INFO - PROCESS | 1678 | 06:37:53 INFO - PROCESS | 1678 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:68.00 stddev:3.16 (4.7%) stddev-sans-first:2.60 06:37:53 INFO - PROCESS | 1678 | Values: 62.0 70.0 65.0 74.0 69.0 67.0 69.0 67.0 67.0 67.0 06:37:53 INFO - PROCESS | 1678 | 06:37:53 INFO - PROCESS | 1678 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:83.00 stddev:1.43 (1.7%) stddev-sans-first:1.50 06:37:53 INFO - PROCESS | 1678 | Values: 83.0 84.0 83.0 83.0 79.0 82.0 82.0 82.0 82.0 84.0 06:37:53 INFO - PROCESS | 1678 | 06:37:53 INFO - PROCESS | 1678 | [#11] stanford-crypto-ccm Cycles:10 Average:127.50 Median:131.00 stddev:6.49 (5.0%) stddev-sans-first:5.90 06:37:53 INFO - PROCESS | 1678 | Values: 137.0 134.0 134.0 122.0 123.0 131.0 122.0 131.0 120.0 121.0 06:37:53 INFO - PROCESS | 1678 | 06:37:53 INFO - PROCESS | 1678 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.10 Median:160.50 stddev:19.15 (11.9%) stddev-sans-first:19.89 06:37:53 INFO - PROCESS | 1678 | Values: 141.0 169.0 127.0 159.0 173.0 122.0 162.0 176.0 154.0 138.0 06:37:53 INFO - PROCESS | 1678 | 06:37:53 INFO - PROCESS | 1678 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:0.79 (1.2%) stddev-sans-first:0.83 06:37:53 INFO - PROCESS | 1678 | Values: 67.0 67.0 66.0 68.0 67.0 68.0 66.0 66.0 66.0 67.0 06:37:53 INFO - PROCESS | 1678 | -------- Summary: end -------- 06:37:53 INFO - PROCESS | 1678 | 06:37:53 INFO - TEST-INFO | 1678: exit 0 06:37:53 INFO - TEST-OK | kraken | took 57480ms 06:37:53 INFO - SUITE-END | took 1170s 06:37:54 INFO - Completed test suite (00:19:30) 06:37:54 INFO - javascript benchmark 06:37:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2747.0, 3462.584489861217, 3509.526213961116, 3511.4908338290966, 3555.075680323115, 5564.721763911798, 5651.971740141304, 5669.914951275729, 5671.659700417978, 5678.205051292817, 5654.321481422235, 5655.321361436633, 5763.1355296705515, 5816.098504731774, 5824.592278540504, 4677.438707355105, 4763.071201115784, 5080.568151707109, 5111.872203194913, 5171.948280517203, 5202.4277329493725, 5217.791288348461, 5241.86895327616, 5253.290805741233, 5270.631055826094, 5126.71803050832, 5164.251183578379, 5171.844844654666, 5201.193814958688, 5217.295665085203, 5130.230465430215, 5177.715225662587, 5194.870128246786, 5209.791608335662, 5225.111731005738, 5146.948530514722, 5156.767945442427, 5160.380754309507, 5161.767720452589, 5192.558632516203, 5511.5039646432015, 5573.303337082864, 5603.411641777596, 5604.299462567179, 5604.8038318659055, 6067.089936509559, 6135.509159267248, 6212.378762123797, 6216.098665693495, 6220.937790622126, 5135.537801597874, 6158.907616385758, 6261.718222679945, 6268.341824108448, 6281.654509002003, 5723.942760572382, 5745.540356771448, 5798.942010579883, 5805.999999999958, 5818.301803783573, 6157.891579515641, 6198.566100372931, 6224.533160013018, 6241.843953901189, 6271.122042913996, 6014.218151640346, 6066.272047354346, 6067.1202675611785, 6102.549845102808, 6126.264848218153, 6215.751369945242, 6222.253329600387, 6227.439530442282, 6239.376062393724, 6245.28179259391, 6060.181875446847, 6114.266954506099, 6212.161358216583, 6224.346443623354, 6228.5017198624, 6134.559047376611, 6216.067589861557, 6218.906716399258, 6227.750889964351, 6254.499640028877, 4819.349387832598, 4857.028594281158, 4866.0, 4871.537203965618, 4901.656884018084, 3360.6975372216616, 3516.226430185355, 4381.079973205662, 4442.200403927324, 4480.641548676098, 5621.0444224481935, 5647.152927060892, 5649.378568357477, 5660.688662123623, 5669.744861481243, 6138.756267604181, 6140.385961403913, 6143.38566143391, 6225.595336303217, 6248.281447633581, 5714.542836573064, 5714.685692286964, 5717.857053573611, 5721.256236689203, 5748.367679555246, 5200.609954253446, 5262.736863156903, 5334.786608535693, 5348.973255133699, 5371.704556249444, 6293.905591416133, 6314.0528920661345, 6349.460295874902, 6363.490920726424, 6379.266384365765, 6151.876962460815, 6155.322914479493, 6161.753529858755, 6173.104899789416, 6191.19514463117, 6181.721822517908, 6256.937430625818, 6300.2754683212015, 6347.365263473615, 6361.90457143134, 6105.672036200829, 6138.202033735586, 6143.600665956698, 6150.04674275488, 6154.846128846814, 6036.3058248302, 6146.323904370426, 6174.413430724074, 6187.474064704551, 6194.163787888578, 5988.101784732325, 6040.7583696651645, 6108.281362585925, 6128.63228206309, 6139.0, 6099.8243298231955, 6105.763021687103, 6109.022556390956, 6110.16388879229, 6113.993245360445, 5980.43185897339, 5997.130416089555, 6008.639481631116, 6008.76820251856, 6010.398960103955, 5892.646441213541, 6080.391960803884, 6136.7852125175405, 6140.956037473551, 6142.928535732134, 5965.850853728518, 5985.910211346746, 5988.790392336247, 6002.459778619946, 6006.399360063959], "unit": "score", "name": "dojo.html", "value": 5651.69984146354}, {"lowerIsBetter": false, "replicates": [478.50713764822245, 579.9304083509977, 605.6547767772369, 644.709880553751, 646.8641585267094, 29980.650870710815, 37378.25243495128, 37750.62249377505, 37865.674701385455, 38023.859284221486, 41319.0, 41661.375079373836, 41705.58294417055, 41788.95527611811, 41801.0, 9446.480443575601, 9635.084666956627, 9680.56437460316, 9683.951580242088, 9685.031496850293, 9449.480278584675, 9571.80856382872, 9584.80830383392, 9591.184749296282, 9605.18355939746, 9560.474173920431, 9667.75830604237, 9734.51327433629, 9756.707298781048, 9772.657956971507, 9608.471534065624, 9698.951505242429, 9701.126898579127, 9710.757231069209, 9711.757206069904, 9568.76078098053, 9693.466859322734, 9693.854592181124, 9704.320697551175, 9720.125188732978, 39797.40303895444, 40032.59967400318, 40057.39913901294, 40089.39865902014, 40148.799256003535, 3119.672434394401, 3222.1622378181605, 3222.355528894207, 3278.49183376577, 3405.4891766235014, 27856.30359241015, 28146.577801333, 28887.42225155506, 28939.0, 29062.70937290621, 2748.4228312054493, 2768.390953990139, 2776.6390369251867, 2776.7917406194615, 2935.911922642324, 464652.0, 465615.0, 465710.0, 466704.0, 467125.3287467116, 44294.114117717465, 61022.0, 61561.38438615646, 61647.691761540904, 61870.0, 43999.0, 44003.77998109989, 44196.779016105356, 44358.33462498065, 44381.556184438385, 15254.23728813555, 15517.45688900883, 15546.9222653886, 15566.688666226612, 15586.9220653896, 12545.874541254652, 12573.748525029449, 12577.496900123893, 12595.622131336075, 12621.873781262253, 14036.29818509091, 14062.296885155702, 14300.928495357457, 14354.354054067591, 14400.20798856052, 6116.143739876421, 6171.938280617226, 6210.5652604317265, 6216.720247588869, 6253.218347706536, 884.5046773806689, 920.6455514626917, 981.7741919358444, 1021.2340744441668, 1061.363182090755, 28017.019404320752, 28390.0, 28910.566341504895, 28990.535804456435, 29015.98444054448, 1109.295597295723, 1145.8223975283845, 1146.6502716671496, 1152.7060599547062, 1177.2053863642006, 13603.251821149932, 14413.495527656481, 14486.275686215648, 14783.482578109715, 14876.851231487763, 528536.3573182187, 530849.6915030878, 531129.0, 533932.0, 534009.0, 55300.170497442574, 57373.71313143491, 57571.424285756606, 57601.423985759604, 57670.55823604443, 1319.531566293971, 1342.2483409290633, 1420.708754705283, 1438.173050495969, 1456.0026381928412, 27267.454650906475, 27452.17643470619, 27977.44045119127, 28189.57715634226, 28278.0, 43472.0, 43905.78047109744, 44107.0, 44127.558724412345, 44264.55735442604, 307343.0, 308031.0, 308622.0, 309179.0, 309278.0, 28016.579751304154, 31921.840390797897, 32728.0, 32958.0, 33193.83403082969, 39677.0, 41221.23025216754, 42640.78679606582, 42759.3586096215, 43808.78095609502, 34421.311573768886, 35244.0, 36153.819230903675, 36195.45706814347, 36485.08787280339, 34826.47760283649, 34892.47661285032, 34961.65038349584, 35744.821275894494, 35752.82123589469, 35565.288694225455, 35695.64304356923, 35774.0, 37355.81322093372, 38072.04819879525, 28664.283392915346, 29111.563326549694, 30153.547696784128, 30401.84799076079, 30578.541321879744, 18502.774766854367, 20319.898400507904, 20608.0, 23225.76774232236, 23594.52810943806], "unit": "score", "name": "ext.html", "value": 18551.885610386063}, {"lowerIsBetter": false, "replicates": [369.50855362368054, 370.96846768024716, 373.86353980797, 380.1996796742856, 382.81242191326226, 19408.029598520072, 20265.290714824983, 20346.694799578017, 20429.897850510763, 20695.275665351717, 20117.798822011777, 20336.593268134628, 20859.582808343825, 20989.950502474854, 21014.369568912956, 5340.519353258206, 5821.563382746301, 5989.580729348947, 5998.4001599839885, 6039.4262545058145, 5577.414371490996, 5830.62100963436, 5833.737481813308, 5850.0, 5950.9107363389585, 5816.476517113459, 5837.1536127261525, 5838.970805145968, 5840.503557197643, 5842.269716285465, 5841.737121829507, 6307.27466341372, 6440.420362167404, 6486.545941784077, 6504.1869766279215, 5683.119116536944, 5695.088785794294, 5709.942900570983, 5710.77156913723, 5738.598298119134, 12390.690232744164, 12889.355532223351, 12930.935345323307, 12931.353432328346, 12935.80596291047, 1969.241841890868, 2161.9783802161933, 2253.6140273731703, 2699.5140874642752, 2779.194033730216, 9580.0, 9699.272554558365, 10155.847662285072, 13240.933795330962, 14176.787348189786, 1435.9210243436607, 1693.6528011757684, 1702.608400067979, 1758.1648716859518, 1762.0749106718947, 91143.0, 91999.0, 95576.52211738897, 95833.0, 95967.0, 9074.729537864705, 10944.343339399662, 10966.0, 11044.889551104387, 11134.721631959104, 13671.453141874412, 13698.452061917611, 13742.587722368346, 13775.242361670003, 13811.240381779098, 8231.34149268057, 8405.495670259805, 8407.495550267004, 8484.915150848536, 8503.14968503157, 8397.328213742885, 8440.57797110142, 8472.406931514735, 8519.275861551838, 8520.914790852135, 4420.0, 4439.311906654474, 4445.444319460067, 4448.021435284232, 4492.820287188541, 1806.7470554122433, 1846.4645252876514, 1850.555866592035, 1866.9346572870156, 1887.5465891263925, 885.384657662931, 898.7573355194061, 926.501833597886, 934.5981228071859, 1085.945702714861, 16782.664346712998, 19235.615287694447, 19469.92915389667, 19613.0, 19833.404997850088, 948.7675519497767, 959.2901253072815, 961.1157734883924, 989.188865130586, 1011.9848202276971, 10202.687991132418, 10397.84403233952, 10403.687889363331, 10409.479526023668, 10469.0, 599091.0, 623725.0, 638109.0, 638301.0, 648872.0, 84173.57913210517, 85416.0, 102481.0, 102859.0, 105504.0, 842.5534466732641, 1035.8756949165997, 1060.745421098946, 1062.5909025025421, 1064.2762921213493, 13747.587572372844, 16819.327226910787, 17020.74468882943, 17093.401730939357, 17407.82592174113, 30708.0, 44827.0, 45622.31566526438, 45761.542384575725, 47762.52237477581, 56416.717916410154, 56570.0, 59986.40013599983, 61660.07509887445, 62982.425439364386, 7347.33873951347, 7619.69521219145, 7689.615519224129, 7843.6862525498345, 7981.521108733495, 9859.507024648883, 11447.771044579229, 12080.51677932873, 12226.572069977508, 12452.377381131088, 10764.515596798006, 10836.349819010884, 10932.234743567873, 11150.888491114985, 11171.106311495223, 10534.36793792375, 10557.472126393803, 10744.83882741744, 10977.725556861142, 11021.173411994292, 9103.681371151977, 10986.890131098588, 11091.223614346918, 11236.66290011301, 11325.886741132812, 7616.657250423855, 7708.229177082247, 7747.496412733154, 8002.159773223728, 8142.18578142181, 10006.0, 10860.837087443853, 10935.890641093805, 11200.887991119984, 11275.0], "unit": "score", "name": "jquery.html", "value": 9012.420775737117}, {"lowerIsBetter": false, "replicates": [1432.5129455984963, 1595.768613551035, 1602.9599260018501, 1870.8222718841714, 2011.446852115668, 7915.92084079159, 8498.0, 8679.001914779803, 8684.435511691736, 8687.56562171892, 8473.91526084739, 8758.649654013832, 8764.868526972085, 8778.166074222938, 8812.8678069829, 2168.176093084626, 2257.9096836126537, 2393.712754469457, 2474.6288056791445, 2509.0214816221596, 2297.1041293895396, 2463.2117722328862, 2467.469494058777, 2468.7654672806057, 2471.5551200783852, 2314.6990891184123, 2324.93025209244, 2379.2624286471164, 2386.3556839653284, 2396.3769419950763, 2423.09134074722, 2459.0655550890638, 2470.0, 2496.113879572744, 2500.612405077216, 2437.3175510856813, 2470.6911636045493, 2473.542394656994, 2489.2158969924417, 2491.327341617753, 8665.263452606472, 8771.561421928878, 8774.298056155492, 8782.07788182238, 8785.956070219672, 5404.729763511808, 5522.254495643077, 5522.66863988162, 5558.0, 5584.972075139639, 3526.717862570988, 3542.4155014422845, 3629.2015756533783, 3687.4468829675493, 3704.518412606371, 1044.6395993382348, 1055.5250137438106, 1057.6139709006234, 1069.6149386220955, 1074.274864466482, 11703.765924681544, 11781.293122412597, 11784.88215117855, 11788.764224715458, 11792.88207117935, 4855.1018061658, 4869.0, 4894.3147959285725, 4916.262560615936, 4923.729194894244, 10058.34620749649, 10076.19390448777, 10092.990700929995, 10094.24293178, 10097.949510252402, 5475.835724928259, 5476.67139971603, 5482.588805839578, 5483.588730845203, 5489.34127904654, 3666.8899933002053, 4584.77076146198, 4779.187538118528, 4838.782254798542, 4916.8770780730765, 3360.479125735515, 3830.5594856591847, 3907.5115610548683, 3926.6466018058513, 3971.940420893689, 1307.300594182108, 1323.1928523600595, 1324.9801252981213, 1338.344211336438, 1339.3236415610054, 1099.631623406152, 1113.6213687346342, 1113.660333598244, 1301.7266374061364, 1406.7889816527397, 8157.75526734199, 8208.630611622491, 8260.752177434686, 8273.255407013397, 8286.668533258602, 505.858359659296, 506.6250974279007, 510.8416390918827, 512.451676705921, 525.3118414876524, 6227.844303892439, 6249.000159974473, 6300.621962682254, 6310.211223597051, 6321.304656487782, 10213.489325533843, 10547.208959328082, 10579.682609521727, 10674.62638807638, 10706.571737130584, 10002.199824014062, 10456.006679365448, 10526.999935006163, 10573.577056917637, 10573.788524229472, 8107.351411887035, 8228.8354232915, 8254.174582541698, 8268.83462330762, 8271.917280827114, 8072.677092916218, 8131.105578386491, 8139.918600813916, 8188.549629770419, 8245.752627421187, 9284.675036373694, 9308.813823723623, 9432.386894851812, 9472.857907131536, 9560.856587151338, 9714.3199976001, 9846.950765246127, 9939.453330066915, 9975.700728978143, 10000.099981003586, 6766.830829229309, 6844.28135045813, 7330.743423980349, 7523.774286771406, 7673.386129109546, 8204.015518137861, 8245.876311855207, 8287.254147126787, 8294.668213271401, 8303.626336814737, 7233.168185658506, 7275.236100209613, 7308.30571095745, 7444.255574442729, 7477.551346919202, 7044.612546309797, 7219.205887352492, 7224.74713385029, 7246.96376518114, 7285.417166626763, 7622.16156222804, 7706.807329816799, 7711.305982461606, 7720.382369410321, 7727.381809455118, 5780.797672081457, 6920.757773477904, 7013.158420989514, 7016.158061032709, 7022.789316320519, 7040.0847889774, 7095.609741464269, 7126.465515086285, 7130.2869713028285, 7133.429325653831], "unit": "score", "name": "mootools.html", "value": 4811.308844372734}, {"lowerIsBetter": false, "replicates": [330.47619523055954, 333.7430178762353, 339.3941813862256, 340.84491556341857, 344.43512639271586, 6459.257185423678, 6488.994205898081, 6524.2170939487205, 6527.11883895674, 6552.475801935846, 6375.10748495211, 6402.071699603554, 6430.356964303567, 6438.066480360345, 6438.742450301982, 4540.568645978627, 4634.72191668501, 4646.4888862225125, 4718.764061796896, 4853.1506986277345, 4801.759912004403, 4802.975985120087, 4803.663743537953, 4807.591354734852, 4815.638827087965, 4749.335093086971, 4767.880802979936, 4771.093492236481, 4777.378940737699, 4782.234842425212, 4586.2661974083985, 4711.104890070876, 4723.929141062887, 4774.737389443597, 4783.115123702126, 4013.478247827793, 4070.5929407059057, 4106.7946602669745, 4128.4632997710405, 4136.855210067663, 6175.69121543921, 6194.194754681907, 6224.0, 6227.346128656471, 6228.252609686821, 5586.273784408041, 5608.551315894719, 5618.0, 5624.15637654351, 5627.6060675752715, 6844.589324640538, 6852.246252912176, 6853.17761868574, 6863.691133898937, 6883.0, 3518.7888726676483, 4448.1770872388715, 4499.572540608637, 4607.654425918036, 4608.032313214229, 7135.82160445993, 7138.714451421937, 7157.785266441963, 7179.748708795167, 7199.712011519533, 4542.364069030338, 4547.408836851188, 4551.226291530448, 4555.658325625592, 4557.1797076526545, 3827.75119617224, 4617.46899106607, 4620.075984803053, 4627.583517483443, 4636.675432719745, 4072.714909956334, 5443.727813609383, 5446.537044351196, 5488.368837583649, 5605.495505404451, 5235.267062611238, 6872.278410766898, 6873.106496155568, 6880.69036893341, 6892.862142757217, 1556.097463471184, 1566.6240102375575, 1573.622330640638, 1575.04709650662, 1580.7944967154197, 1007.7326016462958, 1014.2393205096178, 1030.299396410433, 1031.200819364983, 1036.4403222259896, 6115.877682446326, 6317.936820631827, 6363.172787537591, 6372.968135159294, 6389.274895778114, 5863.501602363762, 6389.073584330246, 6766.864662706718, 7012.018317435563, 7205.9551365051775, 6419.679016049179, 6431.067495213261, 6574.474042076718, 6590.868182636416, 6599.901001484982, 3308.6195087564756, 3615.060084378081, 3750.2124553843996, 3800.410936304877, 3812.1232116613332, 7107.822304442327, 7451.254874512505, 7459.440541959266, 7460.358721081353, 7488.438367122488, 5961.5230781537375, 7229.493935424575, 7336.926630733731, 7388.261173882569, 7389.408847292204, 7465.962670186615, 7470.103587569526, 7474.327310542078, 7485.101787785392, 7496.400287977058, 7072.257412971564, 7088.220295767358, 7096.432285417258, 7101.964490177516, 7104.857902842017, 6707.5304728668525, 6912.654367281716, 7008.824779380557, 7014.473914456335, 7051.894221586783, 5733.397993210653, 6904.689288981907, 7434.479586428898, 7466.664000120117, 7489.475736698379, 4503.279475283939, 4536.342230376643, 4556.476005259437, 4566.383538222298, 4566.429196350457, 5774.740136693775, 6011.729472173675, 6556.016597510412, 6983.847665135399, 7126.857462850818, 6872.347127022925, 6872.725090996504, 6885.001674757032, 6901.240863505111, 6913.1358580177475, 6649.368310010541, 6902.896456553256, 6920.619365934922, 6937.017082654507, 6951.27011663768, 4990.80036798524, 6492.870142597216, 6533.41199292066, 6737.023131645982, 6800.217974932946, 6909.861802764017, 6911.516193866381, 6928.203256625351, 6928.688209030706, 6951.6871740770775, 5472.644278121909, 6484.935150648622, 6750.25747167821, 6752.3922846944015, 6763.0], "unit": "score", "name": "prototype.html", "value": 4982.9404320111535}, {"lowerIsBetter": false, "replicates": [646.5151136647514, 678.4470656415021, 757.11795757942, 757.8329372765941, 771.9228077192284, 15271.08373497591, 15287.312070956807, 15288.69422611547, 15308.234588270583, 15376.615584610376, 12960.416781244843, 13943.302834858267, 13959.232242226699, 13972.0, 14049.227292498908, 696.7944456385378, 700.4816435837469, 931.3201363005011, 941.7268991992314, 943.377370935183, 932.4405356785942, 934.4907025671025, 936.9016253293408, 938.8075444533854, 941.9858702119474, 992.3995982430633, 993.7167907146464, 995.0348162282611, 995.3530205366498, 997.3816233934934, 811.8579248631495, 977.6675930183736, 984.9704508864673, 985.3890587835516, 986.082942863137, 743.0488974113143, 746.0413368821039, 746.6901235987059, 747.55146911853, 748.4349316266239, 13182.143160694524, 13202.075854690176, 13229.206247625174, 13255.801162982563, 13271.601851944457, 11016.834747478793, 11227.831582526269, 11260.43697815106, 11332.490037948312, 11338.376389298584, 9274.211692006187, 9392.248620110375, 9580.520973951345, 9623.711288661281, 9893.0, 3313.2635296582507, 3372.359251742161, 3404.5744281964753, 3413.7951722896455, 3491.8777842775635, 74381.0, 75713.0, 77543.61228193823, 77604.44791104147, 77718.22281777223, 8049.758507244792, 8191.549464779375, 8226.917730822735, 8236.0, 8356.749297521084, 18830.3409380671, 18879.0, 18901.905490472458, 18917.33789317395, 18938.337158199396, 6843.486738494633, 6985.825354366181, 6994.02083708271, 7128.465365097639, 7160.57036577807, 3836.9232615347537, 3972.7616343019513, 4000.299947509174, 4020.618041286073, 4312.202242585132, 3374.1733275347697, 3437.415639341318, 3441.8107004115013, 3443.5351227584456, 3445.397055515325, 568.573569822633, 681.4990981628499, 682.9214640316328, 707.8407358344434, 711.9572825630479, 497.9502049794992, 533.5038414274761, 585.3122580967431, 605.2102006880974, 606.263389981175, 7460.589667568336, 8106.837863242702, 8250.752477425687, 8254.380921430917, 8349.666013359398, 432.60848931716845, 584.231735268121, 596.8299034775068, 612.2561088277764, 618.6659204029773, 3772.679322257639, 3776.150366167645, 3810.2569998850513, 3985.442038114666, 3996.6403023728003, 77815.0, 85521.86195345166, 86996.56501717577, 92284.53857730802, 92583.0, 48984.0, 77313.2268677306, 77740.0, 77783.22216777873, 79015.60492197618, 67913.66043169753, 70252.29747702458, 70345.94481082787, 71130.0, 72331.63834180795, 7563.281488258606, 7570.318671319607, 7700.8074798128255, 7929.682812687428, 7994.960025199837, 45093.872653183935, 46326.74588930586, 47427.762861185474, 48249.03501929872, 49345.75327123485, 53284.73357633187, 61916.38083619106, 63036.36963630305, 63324.36675633369, 66757.0, 11072.944635276772, 11135.276207046516, 11247.606333778605, 11569.36368499707, 12229.205101668718, 10109.34289271195, 12014.699632509257, 12038.699032524257, 12100.697482563006, 12158.574449894211, 11326.660200194008, 11513.251638643462, 11780.05759539252, 11914.940425297818, 12116.697082573006, 11471.598494052669, 11481.36852473122, 11544.365059921785, 11706.356150411468, 11864.584739534075, 11312.6040588579, 11344.602938897098, 11718.121140914294, 11767.470463828977, 11818.409079545816, 8215.0, 9262.16640502358, 9298.860517092384, 9528.28537859677, 9939.950300248453, 7484.663190156565, 8828.205461508494, 9323.347365684336, 9365.438073715599, 9411.576479058596], "unit": "score", "name": "yui.html", "value": 6703.177149365637}], "name": "dromaeo_css", "value": 7304.301461943165}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 111.0, 113.0, 117.0, 167.0, 164.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 122.2}, {"lowerIsBetter": true, "replicates": [155.0, 121.0, 142.0, 159.0, 121.0, 138.0, 147.0, 144.0, 158.0, 152.0], "unit": "score", "name": "audio-beat-detection", "value": 143.7}, {"lowerIsBetter": true, "replicates": [185.0, 187.0, 184.0, 188.0, 184.0, 186.0, 184.0, 181.0, 261.0, 187.0], "unit": "score", "name": "audio-dft", "value": 192.7}, {"lowerIsBetter": true, "replicates": [80.0, 72.0, 82.0, 79.0, 56.0, 58.0, 58.0, 76.0, 79.0, 58.0], "unit": "score", "name": "audio-fft", "value": 69.8}, {"lowerIsBetter": true, "replicates": [94.0, 99.0, 124.0, 80.0, 77.0, 83.0, 119.0, 79.0, 79.0, 121.0], "unit": "score", "name": "audio-oscillator", "value": 95.5}, {"lowerIsBetter": true, "replicates": [87.0, 84.0, 86.0, 83.0, 88.0, 84.0, 93.0, 83.0, 87.0, 84.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 85.9}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 93.0, 92.0, 93.0, 93.0, 109.0, 149.0, 93.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 99.8}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 86.0, 89.0, 86.0, 85.0, 85.0, 85.0, 84.0, 86.0], "unit": "score", "name": "imaging-desaturate", "value": 85.5}, {"lowerIsBetter": true, "replicates": [54.0, 55.0, 54.0, 54.0, 54.0, 52.0, 53.0, 63.0, 54.0, 51.0], "unit": "score", "name": "json-parse-financial", "value": 54.4}, {"lowerIsBetter": true, "replicates": [62.0, 70.0, 65.0, 74.0, 69.0, 67.0, 69.0, 67.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.7}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 83.0, 83.0, 79.0, 82.0, 82.0, 82.0, 82.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.4}, {"lowerIsBetter": true, "replicates": [137.0, 134.0, 134.0, 122.0, 123.0, 131.0, 122.0, 131.0, 120.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.5}, {"lowerIsBetter": true, "replicates": [141.0, 169.0, 127.0, 159.0, 173.0, 122.0, 162.0, 176.0, 154.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 152.1}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 66.0, 68.0, 67.0, 68.0, 66.0, 66.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.8}], "name": "kraken", "value": 1445.9999999999998}]} 06:37:54 INFO - Return code: 0 06:37:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:37:54 ERROR - # TBPL SUCCESS # 06:37:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:37:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:37:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:37:54 INFO - 2016-03-29 06:37:54.371 screenresolution[1682:9682] starting screenresolution argv=screenresolution get 06:37:54 INFO - 2016-03-29 06:37:54.374 screenresolution[1682:9682] Display 0: 1600x1200x32@60 06:37:54 INFO - 2016-03-29 06:37:54.379 screenresolution[1683:9685] starting screenresolution argv=screenresolution list 06:37:54 INFO - Available Modes on Display 0 06:37:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:37:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:37:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:37:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:37:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:37:54 INFO - Intel Iris: 06:37:54 INFO - Chipset Model: Intel Iris 06:37:54 INFO - Type: GPU 06:37:54 INFO - Bus: Built-In 06:37:54 INFO - VRAM (Dynamic, Max): 1536 MB 06:37:54 INFO - Vendor: Intel (0x8086) 06:37:54 INFO - Device ID: 0x0a2e 06:37:54 INFO - Revision ID: 0x0009 06:37:54 INFO - Displays: 06:37:54 INFO - Display: 06:37:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:37:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:37:54 INFO - Display Serial Number: 1600x1200 60 06:37:54 INFO - Main Display: Yes 06:37:54 INFO - Mirror: Off 06:37:54 INFO - Online: Yes 06:37:54 INFO - Rotation: Supported 06:37:54 INFO - Return code: 0 06:37:54 INFO - Running post-action listener: _resource_record_post_action 06:37:54 INFO - Running post-run listener: _resource_record_post_run 06:37:55 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 39478784; Write bytes: 707107328; Read time: 430; Write time: 2048 06:37:55 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 401338880; Write bytes: 392097280; Read time: 29778; Write time: 760 06:37:55 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 32349696; Write bytes: 299772928; Read time: 338; Write time: 1252 06:37:55 INFO - Running post-run listener: _upload_blobber_files 06:37:55 INFO - Blob upload gear active. 06:37:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:37:55 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:37:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:37:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:37:56 INFO - (blobuploader) - INFO - Open directory for files ... 06:37:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:37:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:37:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:37:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:37:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:37:56 INFO - (blobuploader) - INFO - Done attempting. 06:37:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:37:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:37:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:37:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:37:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:37:57 INFO - (blobuploader) - INFO - Done attempting. 06:37:57 INFO - (blobuploader) - INFO - Iteration through files over. 06:37:57 INFO - Return code: 0 06:37:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:37:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:37:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5603051ba3b3cf667e891b91a89c9acc36608fe65fb92e46869a46a6cfd8f1e28bc99ed4614d3426aa3ebf0ea2eb4a38415e2612e26445e971c6a82c1774e1fa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d43251391d2ef92c21ccec0fd9fa117da04c2c07b30c25cba9ef979fa78a50fc1e582ccad8224a037c9b121ffa3eddf28dbb7ef76c8658ec5d7f72bb15a8b47"} 06:37:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:37:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:37:57 INFO - Contents: 06:37:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5603051ba3b3cf667e891b91a89c9acc36608fe65fb92e46869a46a6cfd8f1e28bc99ed4614d3426aa3ebf0ea2eb4a38415e2612e26445e971c6a82c1774e1fa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d43251391d2ef92c21ccec0fd9fa117da04c2c07b30c25cba9ef979fa78a50fc1e582ccad8224a037c9b121ffa3eddf28dbb7ef76c8658ec5d7f72bb15a8b47"} 06:37:57 INFO - Running post-run listener: copy_logs_to_upload_dir 06:37:57 INFO - Copying logs to upload dir... 06:37:57 INFO - mkdir: /builds/slave/test/build/upload/logs 06:37:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.236663 ========= master_lag: 0.13 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-03-29 06:37:58.005078) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-29 06:37:58.008223) ========= 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.1pjgOOO7N6/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.nmiEokDztP/Listeners TMPDIR=/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5603051ba3b3cf667e891b91a89c9acc36608fe65fb92e46869a46a6cfd8f1e28bc99ed4614d3426aa3ebf0ea2eb4a38415e2612e26445e971c6a82c1774e1fa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d43251391d2ef92c21ccec0fd9fa117da04c2c07b30c25cba9ef979fa78a50fc1e582ccad8224a037c9b121ffa3eddf28dbb7ef76c8658ec5d7f72bb15a8b47"} build_url:https://queue.taskcluster.net/v1/task/XJKtJC_hRAiYw-sPeEFOlw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011095 build_url: 'https://queue.taskcluster.net/v1/task/XJKtJC_hRAiYw-sPeEFOlw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5603051ba3b3cf667e891b91a89c9acc36608fe65fb92e46869a46a6cfd8f1e28bc99ed4614d3426aa3ebf0ea2eb4a38415e2612e26445e971c6a82c1774e1fa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d43251391d2ef92c21ccec0fd9fa117da04c2c07b30c25cba9ef979fa78a50fc1e582ccad8224a037c9b121ffa3eddf28dbb7ef76c8658ec5d7f72bb15a8b47"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-29 06:37:58.035089) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 06:37:58.035440) ========= 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.1pjgOOO7N6/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.nmiEokDztP/Listeners TMPDIR=/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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.004968 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 06:37:58.085164) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-29 06:37:58.085467) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-29 06:37:58.085860) ========= ========= Total master_lag: 18.05 =========