builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0095 starttime: 1456041599.99 results: success (0) buildid: 20160220192510 builduid: 77e95ae228c242d7ac5150490927e9a5 revision: 7eb1382d6cef49a27f7ced970a2b135f0f20f014 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-20 23:59:59.985783) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-20 23:59:59.986222) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-20 23:59:59.986534) ========= 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.4Y4Zftvke6/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.dy9D7OfwaM/Listeners TMPDIR=/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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.005869 basedir: '/builds/slave/test' ========= master_lag: 0.12 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-21 00:00:00.109296) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-21 00:00:00.109645) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-21 00:00:00.391638) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-21 00:00:00.391922) ========= 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.4Y4Zftvke6/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.dy9D7OfwaM/Listeners TMPDIR=/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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.005500 ========= master_lag: 0.12 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-21 00:00:00.512623) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-21 00:00:00.512920) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-21 00:00:00.513339) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-21 00:00:00.513643) ========= 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.4Y4Zftvke6/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.dy9D7OfwaM/Listeners TMPDIR=/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-02-21 00:00:00-- 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% 200M=0s 2016-02-21 00:00:01 (200 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.486147 ========= master_lag: 0.11 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-21 00:00:01.114182) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-21 00:00:01.114979) ========= 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.4Y4Zftvke6/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.dy9D7OfwaM/Listeners TMPDIR=/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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.026556 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-21 00:00:01.208450) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-21 00:00:01.208791) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7eb1382d6cef49a27f7ced970a2b135f0f20f014 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 7eb1382d6cef49a27f7ced970a2b135f0f20f014 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4Y4Zftvke6/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.dy9D7OfwaM/Listeners TMPDIR=/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-02-21 00:00:01,296 truncating revision to first 12 chars 2016-02-21 00:00:01,297 Setting DEBUG logging. 2016-02-21 00:00:01,297 attempt 1/10 2016-02-21 00:00:01,297 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7eb1382d6cef?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-21 00:00:02,906 unpacking tar archive at: fx-team-7eb1382d6cef/testing/mozharness/ program finished with exit code 0 elapsedTime=1.856518 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-21 00:00:03.094551) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-21 00:00:03.094982) ========= echo 7eb1382d6cef49a27f7ced970a2b135f0f20f014 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'7eb1382d6cef49a27f7ced970a2b135f0f20f014'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4Y4Zftvke6/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.dy9D7OfwaM/Listeners TMPDIR=/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 7eb1382d6cef49a27f7ced970a2b135f0f20f014 program finished with exit code 0 elapsedTime=0.005962 script_repo_revision: '7eb1382d6cef49a27f7ced970a2b135f0f20f014' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-21 00:00:03.149350) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-21 00:00:03.149747) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-21 00:00:03.189685) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-02-21 00:00:03.190049) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4Y4Zftvke6/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.dy9D7OfwaM/Listeners TMPDIR=/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 00:00:03 INFO - MultiFileLogger online at 20160221 00:00:03 in /builds/slave/test 00:00:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 00:00:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:00:03 INFO - {'append_to_log': False, 00:00:03 INFO - 'base_work_dir': '/builds/slave/test', 00:00:03 INFO - 'blob_upload_branch': 'Fx-Team', 00:00:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:00:03 INFO - 'branch': 'Fx-Team', 00:00:03 INFO - 'buildbot_json_path': 'buildprops.json', 00:00:03 INFO - 'config_files': ('talos/mac_config.py',), 00:00:03 INFO - 'default_actions': ('clobber', 00:00:03 INFO - 'read-buildbot-config', 00:00:03 INFO - 'download-and-extract', 00:00:03 INFO - 'populate-webroot', 00:00:03 INFO - 'create-virtualenv', 00:00:03 INFO - 'install', 00:00:03 INFO - 'run-tests'), 00:00:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:00:03 INFO - 'download_minidump_stackwalk': True, 00:00:03 INFO - 'download_symbols': 'ondemand', 00:00:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:00:03 INFO - 'tooltool.py': '/tools/tooltool.py', 00:00:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:00:03 INFO - '/tools/misc-python/virtualenv.py')}, 00:00:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:00:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:00:03 INFO - 'installer_path': 'installer.exe', 00:00:03 INFO - 'log_level': 'info', 00:00:03 INFO - 'log_name': 'talos', 00:00:03 INFO - 'log_to_console': True, 00:00:03 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 00:00:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 00:00:03 INFO - 'opt_config_files': (), 00:00:03 INFO - 'pip_index': False, 00:00:03 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:00:03 INFO - 'cmd': ('bash', 00:00:03 INFO - '-c', 00:00:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:00:03 INFO - 'enabled': True, 00:00:03 INFO - 'halt_on_failure': False, 00:00:03 INFO - 'name': 'check_screen_resolution'},), 00:00:03 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:00:03 INFO - 'cmd': ('bash', 00:00:03 INFO - '-c', 00:00:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:00:03 INFO - 'enabled': True, 00:00:03 INFO - 'halt_on_failure': False, 00:00:03 INFO - 'name': 'check_screen_resolution'},), 00:00:03 INFO - 'run_cmd_checks_enabled': True, 00:00:03 INFO - 'sps_profile': False, 00:00:03 INFO - 'sps_profile_interval': 0, 00:00:03 INFO - 'suite': 'dromaeojs', 00:00:03 INFO - 'system_bits': '32', 00:00:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:00:03 INFO - 'title': 't-yosemite-r7-0095', 00:00:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:00:03 INFO - 'use_talos_json': True, 00:00:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:00:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:00:03 INFO - 'work_dir': 'build'} 00:00:03 INFO - ##### 00:00:03 INFO - ##### Running clobber step. 00:00:03 INFO - ##### 00:00:03 INFO - Running pre-action listener: _resource_record_pre_action 00:00:03 INFO - Running main action method: clobber 00:00:03 INFO - rmtree: /builds/slave/test/build 00:00:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:00:05 INFO - Running post-action listener: _resource_record_post_action 00:00:05 INFO - ##### 00:00:05 INFO - ##### Running read-buildbot-config step. 00:00:05 INFO - ##### 00:00:05 INFO - Running pre-action listener: _resource_record_pre_action 00:00:05 INFO - Running main action method: read_buildbot_config 00:00:05 INFO - Using buildbot properties: 00:00:05 INFO - { 00:00:05 INFO - "project": "", 00:00:05 INFO - "product": "firefox", 00:00:05 INFO - "script_repo_revision": "production", 00:00:05 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 00:00:05 INFO - "repository": "", 00:00:05 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 00:00:05 INFO - "buildid": "20160220192510", 00:00:05 INFO - "pgo_build": "False", 00:00:05 INFO - "basedir": "/builds/slave/test", 00:00:05 INFO - "buildnumber": 396, 00:00:05 INFO - "slavename": "t-yosemite-r7-0095", 00:00:05 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 00:00:05 INFO - "platform": "yosemite_r7", 00:00:05 INFO - "scheduler": "tests-fx-team-macosx64-talos", 00:00:05 INFO - "branch": "fx-team", 00:00:05 INFO - "repo_path": "integration/fx-team", 00:00:05 INFO - "revision": "7eb1382d6cef49a27f7ced970a2b135f0f20f014", 00:00:05 INFO - "stage_platform": "macosx64", 00:00:05 INFO - "builduid": "77e95ae228c242d7ac5150490927e9a5", 00:00:05 INFO - "slavebuilddir": "test" 00:00:05 INFO - } 00:00:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/W8731TS4RGyiuBWgRXoNYQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 00:00:05 INFO - Running post-action listener: _resource_record_post_action 00:00:05 INFO - ##### 00:00:05 INFO - ##### Running download-and-extract step. 00:00:05 INFO - ##### 00:00:05 INFO - Running pre-action listener: _resource_record_pre_action 00:00:05 INFO - Running main action method: download_and_extract 00:00:05 INFO - mkdir: /builds/slave/test/build/tests 00:00:05 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')]} 00:00:05 INFO - https://queue.taskcluster.net/v1/task/W8731TS4RGyiuBWgRXoNYQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 00:00:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8731TS4RGyiuBWgRXoNYQ/artifacts/public/build/test_packages.json 00:00:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8731TS4RGyiuBWgRXoNYQ/artifacts/public/build/test_packages.json 00:00:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8731TS4RGyiuBWgRXoNYQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 00:00:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8731TS4RGyiuBWgRXoNYQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 00:00:12 INFO - Downloaded 1277 bytes. 00:00:12 INFO - Reading from file /builds/slave/test/build/test_packages.json 00:00:12 INFO - Using the following test package requirements: 00:00:12 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 00:00:12 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 00:00:12 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 00:00:12 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 00:00:12 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 00:00:12 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 00:00:12 INFO - u'jsshell-mac.zip'], 00:00:12 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 00:00:12 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 00:00:12 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 00:00:12 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 00:00:12 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 00:00:12 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 00:00:12 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 00:00:12 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 00:00:12 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 00:00:12 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 00:00:12 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 00:00:12 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 00:00:12 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 00:00:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:00:12 INFO - https://queue.taskcluster.net/v1/task/W8731TS4RGyiuBWgRXoNYQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 00:00:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8731TS4RGyiuBWgRXoNYQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 00:00:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8731TS4RGyiuBWgRXoNYQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 00:00:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8731TS4RGyiuBWgRXoNYQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 00:00:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8731TS4RGyiuBWgRXoNYQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 00:00:14 INFO - Downloaded 17825287 bytes. 00:00:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:00:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 00:00:17 INFO - Return code: 0 00:00:17 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 00:00:17 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')]} 00:00:17 INFO - https://queue.taskcluster.net/v1/task/W8731TS4RGyiuBWgRXoNYQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 00:00:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8731TS4RGyiuBWgRXoNYQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 00:00:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8731TS4RGyiuBWgRXoNYQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 00:00:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8731TS4RGyiuBWgRXoNYQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 00:00:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8731TS4RGyiuBWgRXoNYQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 00:00:25 INFO - Downloaded 17825287 bytes. 00:00:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:00:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 00:00:28 INFO - Return code: 0 00:00: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')]} 00:00:28 INFO - https://queue.taskcluster.net/v1/task/W8731TS4RGyiuBWgRXoNYQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 00:00:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8731TS4RGyiuBWgRXoNYQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 00:00:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8731TS4RGyiuBWgRXoNYQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 00:00:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8731TS4RGyiuBWgRXoNYQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 00:00:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8731TS4RGyiuBWgRXoNYQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 00:00:29 INFO - Downloaded 10707015 bytes. 00:00:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:00:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 00:00:29 INFO - Return code: 0 00:00:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:00:29 INFO - https://queue.taskcluster.net/v1/task/W8731TS4RGyiuBWgRXoNYQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 00:00:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8731TS4RGyiuBWgRXoNYQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 00:00:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8731TS4RGyiuBWgRXoNYQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 00:00:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8731TS4RGyiuBWgRXoNYQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 00:00:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8731TS4RGyiuBWgRXoNYQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 00:00:32 INFO - Downloaded 111277901 bytes. 00:00:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/W8731TS4RGyiuBWgRXoNYQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 00:00:32 INFO - mkdir: /builds/slave/test/properties 00:00:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:00:32 INFO - Writing to file /builds/slave/test/properties/build_url 00:00:32 INFO - Contents: 00:00:32 INFO - build_url:https://queue.taskcluster.net/v1/task/W8731TS4RGyiuBWgRXoNYQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 00:00:34 INFO - Running post-action listener: _resource_record_post_action 00:00:34 INFO - Running post-action listener: set_extra_try_arguments 00:00:34 INFO - ##### 00:00:34 INFO - ##### Running populate-webroot step. 00:00:34 INFO - ##### 00:00:34 INFO - Running pre-action listener: _resource_record_pre_action 00:00:34 INFO - Running main action method: populate_webroot 00:00:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:00:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:00:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:00:34 INFO - '--tppagecycles', 00:00:34 INFO - '7'], 00:00:34 INFO - 'tests': ['tsvgm']}}, 00:00:34 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 00:00:34 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 00:00:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:00:34 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 00:00:34 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 00:00:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:00:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:00:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:00:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:00:34 INFO - 'talos_options': ['--e10s'], 00:00:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:00:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:00:34 INFO - 'tests': ['damp', 'tps']}, 00:00:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:00:34 INFO - 'talos_options': ['--e10s'], 00:00:34 INFO - 'tests': ['damp', 'tps']}, 00:00:34 INFO - 'g3': {'tests': ['dromaeo_dom']}, 00:00:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:00:34 INFO - 'other': {'tests': ['a11yr', 00:00:34 INFO - 'ts_paint', 00:00:34 INFO - 'tpaint', 00:00:34 INFO - 'sessionrestore', 00:00:34 INFO - 'sessionrestore_no_auto_restore']}, 00:00:34 INFO - 'other-e10s': {'talos_options': ['--e10s'], 00:00:34 INFO - 'tests': ['a11yr', 00:00:34 INFO - 'ts_paint', 00:00:34 INFO - 'tpaint', 00:00:34 INFO - 'sessionrestore', 00:00:34 INFO - 'sessionrestore_no_auto_restore']}, 00:00:34 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 00:00:34 INFO - 'tests': ['a11yr', 00:00:34 INFO - 'ts_paint', 00:00:34 INFO - 'tpaint', 00:00:34 INFO - 'sessionrestore', 00:00:34 INFO - 'sessionrestore_no_auto_restore']}, 00:00:34 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 00:00:34 INFO - 'tests': ['a11yr', 00:00:34 INFO - 'ts_paint', 00:00:34 INFO - 'tpaint', 00:00:34 INFO - 'sessionrestore', 00:00:34 INFO - 'sessionrestore_no_auto_restore']}, 00:00:34 INFO - 'other_l64': {'tests': ['a11yr', 00:00:34 INFO - 'ts_paint', 00:00:34 INFO - 'tpaint', 00:00:34 INFO - 'sessionrestore', 00:00:34 INFO - 'sessionrestore_no_auto_restore']}, 00:00:34 INFO - 'other_nol64': {'tests': ['a11yr', 00:00:34 INFO - 'ts_paint', 00:00:34 INFO - 'tpaint', 00:00:34 INFO - 'sessionrestore', 00:00:34 INFO - 'sessionrestore_no_auto_restore']}, 00:00:34 INFO - 'svgr': {'tests': ['tsvgx', 00:00:34 INFO - 'tsvgr_opacity', 00:00:34 INFO - 'tart', 00:00:34 INFO - 'tscrollx', 00:00:34 INFO - 'cart']}, 00:00:34 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 00:00:34 INFO - 'tests': ['tsvgx', 00:00:34 INFO - 'tsvgr_opacity', 00:00:34 INFO - 'tart', 00:00:34 INFO - 'tscrollx', 00:00:34 INFO - 'cart']}, 00:00:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:00:34 INFO - 'tests': ['tp5o']}, 00:00:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:00:34 INFO - 'talos_options': ['--e10s'], 00:00:34 INFO - 'tests': ['tp5o']}, 00:00:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:00:34 INFO - 'talos_options': ['--xperf_path', 00:00:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:00:34 INFO - 'tests': ['tp5n']}, 00:00:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:00:34 INFO - 'talos_options': ['--e10s', 00:00:34 INFO - '--xperf_path', 00:00:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:00:34 INFO - 'tests': ['tp5n']}}, 00:00:34 INFO - 'talos.zip': {'path': '', 00:00:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:00:34 INFO - Running post-action listener: _resource_record_post_action 00:00:34 INFO - ##### 00:00:34 INFO - ##### Running create-virtualenv step. 00:00:34 INFO - ##### 00:00:34 INFO - Running pre-action listener: _resource_record_pre_action 00:00:34 INFO - Running main action method: create_virtualenv 00:00:34 INFO - Creating virtualenv /builds/slave/test/build/venv 00:00:34 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 00:00:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:00:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:00:34 INFO - Using real prefix '/tools/python27' 00:00:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:00:35 INFO - Installing distribute.............................................................................................................................................................................................done. 00:00:38 INFO - Installing pip.................done. 00:00:38 INFO - Return code: 0 00:00:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:00: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')]} 00:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:00:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:00: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')]} 00:00:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:00:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:00: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105852a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10585a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff33959e1e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056f6d30>, '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 0x10551adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1056edb20>, '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.4Y4Zftvke6/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.dy9D7OfwaM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 00:00: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', 'pip>=1.5'] in /builds/slave/test/build 00:00: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 pip>=1.5 00:00:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4Y4Zftvke6/Render', 00:00:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:00:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:00:38 INFO - 'HOME': '/Users/cltbld', 00:00:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:00:38 INFO - 'LOGNAME': 'cltbld', 00:00:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:00:38 INFO - 'MOZ_NO_REMOTE': '1', 00:00:38 INFO - 'NO_EM_RESTART': '1', 00:00:38 INFO - 'PAGER': '/bin/cat', 00:00:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:00:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:00:38 INFO - 'PWD': '/builds/slave/test', 00:00:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:00:38 INFO - 'SHELL': '/bin/bash', 00:00:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dy9D7OfwaM/Listeners', 00:00:38 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 00:00:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:00:38 INFO - 'USER': 'cltbld', 00:00:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:00:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:00:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:00:38 INFO - 'XPC_FLAGS': '0x0', 00:00:38 INFO - 'XPC_SERVICE_NAME': '0', 00:00:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:00:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:00:38 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 00:00:38 INFO - Cleaning up... 00:00:38 INFO - Return code: 0 00:00:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 00:00: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')]} 00:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:00:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:00: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')]} 00:00:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:00:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:00: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', '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 0x105852a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10585a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff33959e1e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056f6d30>, '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 0x10551adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1056edb20>, '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.4Y4Zftvke6/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.dy9D7OfwaM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 00:00: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', 'psutil>=0.7.1'] in /builds/slave/test/build 00:00: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 psutil>=0.7.1 00:00:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4Y4Zftvke6/Render', 00:00:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:00:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:00:38 INFO - 'HOME': '/Users/cltbld', 00:00:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:00:38 INFO - 'LOGNAME': 'cltbld', 00:00:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:00:38 INFO - 'MOZ_NO_REMOTE': '1', 00:00:38 INFO - 'NO_EM_RESTART': '1', 00:00:38 INFO - 'PAGER': '/bin/cat', 00:00:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:00:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:00:38 INFO - 'PWD': '/builds/slave/test', 00:00:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:00:38 INFO - 'SHELL': '/bin/bash', 00:00:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dy9D7OfwaM/Listeners', 00:00:38 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 00:00:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:00:38 INFO - 'USER': 'cltbld', 00:00:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:00:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:00:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:00:38 INFO - 'XPC_FLAGS': '0x0', 00:00:38 INFO - 'XPC_SERVICE_NAME': '0', 00:00:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:00:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:00:38 INFO - Downloading/unpacking psutil>=0.7.1 00:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:00:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:00:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:00:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:00:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:00:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:00:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:00:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:00:42 INFO - Installing collected packages: psutil 00:00:42 INFO - Running setup.py install for psutil 00:00:42 INFO - building 'psutil._psutil_osx' extension 00:00:42 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 00:00:42 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 00:00:42 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 00:00:42 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 00:00:42 INFO - building 'psutil._psutil_posix' extension 00:00:42 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 00:00:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 00:00:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 00:00:43 INFO - ^ 00:00:43 INFO - 1 warning generated. 00:00:43 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 00:00:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:00:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:00:43 INFO - Successfully installed psutil 00:00:43 INFO - Cleaning up... 00:00:43 INFO - Return code: 0 00:00:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 00:00:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:00:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:00:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:00:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:00:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:00:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:00:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105852a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10585a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff33959e1e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056f6d30>, '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 0x10551adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1056edb20>, '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.4Y4Zftvke6/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.dy9D7OfwaM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 00:00:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 00:00:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 00:00:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4Y4Zftvke6/Render', 00:00:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:00:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:00:43 INFO - 'HOME': '/Users/cltbld', 00:00:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:00:43 INFO - 'LOGNAME': 'cltbld', 00:00:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:00:43 INFO - 'MOZ_NO_REMOTE': '1', 00:00:43 INFO - 'NO_EM_RESTART': '1', 00:00:43 INFO - 'PAGER': '/bin/cat', 00:00:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:00:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:00:43 INFO - 'PWD': '/builds/slave/test', 00:00:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:00:43 INFO - 'SHELL': '/bin/bash', 00:00:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dy9D7OfwaM/Listeners', 00:00:43 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 00:00:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:00:43 INFO - 'USER': 'cltbld', 00:00:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:00:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:00:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:00:43 INFO - 'XPC_FLAGS': '0x0', 00:00:43 INFO - 'XPC_SERVICE_NAME': '0', 00:00:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:00:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:00:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 00:00:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:00:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:00:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:00:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:00:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:00:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:00:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 00:00:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:00:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 00:00:45 INFO - Installing collected packages: mozsystemmonitor 00:00:45 INFO - Running setup.py install for mozsystemmonitor 00:00:46 INFO - Successfully installed mozsystemmonitor 00:00:46 INFO - Cleaning up... 00:00:46 INFO - Return code: 0 00:00:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:00:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:00:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:00:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:00:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105852a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10585a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff33959e1e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056f6d30>, '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 0x10551adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1056edb20>, '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.4Y4Zftvke6/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.dy9D7OfwaM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 00:00:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 00:00:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 00:00:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4Y4Zftvke6/Render', 00:00:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:00:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:00:46 INFO - 'HOME': '/Users/cltbld', 00:00:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:00:46 INFO - 'LOGNAME': 'cltbld', 00:00:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:00:46 INFO - 'MOZ_NO_REMOTE': '1', 00:00:46 INFO - 'NO_EM_RESTART': '1', 00:00:46 INFO - 'PAGER': '/bin/cat', 00:00:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:00:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:00:46 INFO - 'PWD': '/builds/slave/test', 00:00:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:00:46 INFO - 'SHELL': '/bin/bash', 00:00:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dy9D7OfwaM/Listeners', 00:00:46 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 00:00:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:00:46 INFO - 'USER': 'cltbld', 00:00:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:00:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:00:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:00:46 INFO - 'XPC_FLAGS': '0x0', 00:00:46 INFO - 'XPC_SERVICE_NAME': '0', 00:00:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:00:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:00:46 INFO - Downloading/unpacking blobuploader==1.2.4 00:00: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 00:00: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 00:00: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 00:00: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 00:00: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 00:00: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 00:00:48 INFO - Downloading blobuploader-1.2.4.tar.gz 00:00:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:00:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:00:48 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 00:00:48 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 00:00:48 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 00:00:48 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 00:00:48 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 00:00:48 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 00:00:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:00:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:00:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:00:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:00:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:00:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:00:49 INFO - Downloading docopt-0.6.1.tar.gz 00:00:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:00:49 INFO - Installing collected packages: blobuploader, requests, docopt 00:00:49 INFO - Running setup.py install for blobuploader 00:00:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:00:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:00:50 INFO - Running setup.py install for requests 00:00:50 INFO - Running setup.py install for docopt 00:00:50 INFO - Successfully installed blobuploader requests docopt 00:00:50 INFO - Cleaning up... 00:00:50 INFO - Return code: 0 00:00:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:00:50 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')]} 00:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:00:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:00:50 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')]} 00:00:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:00:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:00:50 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 0x105852a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10585a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff33959e1e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056f6d30>, '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 0x10551adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1056edb20>, '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.4Y4Zftvke6/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.dy9D7OfwaM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 00:00:50 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 00:00:50 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 00:00:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4Y4Zftvke6/Render', 00:00:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:00:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:00:50 INFO - 'HOME': '/Users/cltbld', 00:00:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:00:50 INFO - 'LOGNAME': 'cltbld', 00:00:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:00:50 INFO - 'MOZ_NO_REMOTE': '1', 00:00:50 INFO - 'NO_EM_RESTART': '1', 00:00:50 INFO - 'PAGER': '/bin/cat', 00:00:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:00:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:00:50 INFO - 'PWD': '/builds/slave/test', 00:00:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:00:50 INFO - 'SHELL': '/bin/bash', 00:00:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dy9D7OfwaM/Listeners', 00:00:50 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 00:00:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:00:50 INFO - 'USER': 'cltbld', 00:00:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:00:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:00:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:00:50 INFO - 'XPC_FLAGS': '0x0', 00:00:50 INFO - 'XPC_SERVICE_NAME': '0', 00:00:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:00:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:00:51 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-Et2OGH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:00:51 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-zbcxMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:00:51 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-oPDmPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:00:51 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-EhAxeo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:00:51 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-KRB5du-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:00:51 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-ICFJ8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:00:51 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-bR3lxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:00:51 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-pLWwXB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:00:51 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-XzqPpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:00:52 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-5xTSvJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:00:52 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-QbA12s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:00:52 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-yN8YGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:00:52 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-tDq1R9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:00:52 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-2mAL6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:00:52 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-mzQN0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:00:52 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-iORZTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:00:52 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-RpbVTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:00:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:00:52 INFO - Running setup.py install for manifestparser 00:00:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:00:52 INFO - Running setup.py install for mozcrash 00:00:53 INFO - Running setup.py install for mozdebug 00:00:53 INFO - Running setup.py install for mozdevice 00:00:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:00:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:00:53 INFO - Running setup.py install for mozfile 00:00:53 INFO - Running setup.py install for mozhttpd 00:00:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:00:53 INFO - Running setup.py install for mozinfo 00:00:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:00:53 INFO - Running setup.py install for mozInstall 00:00:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:00:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:00:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:00:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:00:53 INFO - Running setup.py install for mozleak 00:00:54 INFO - Running setup.py install for mozlog 00:00:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:00:54 INFO - Running setup.py install for moznetwork 00:00:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:00:54 INFO - Running setup.py install for mozprocess 00:00:54 INFO - Running setup.py install for mozprofile 00:00:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:00:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:00:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:00:54 INFO - Running setup.py install for mozrunner 00:00:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:00:54 INFO - Running setup.py install for mozscreenshot 00:00:55 INFO - Running setup.py install for moztest 00:00:55 INFO - Running setup.py install for mozversion 00:00:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:00:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:00:55 INFO - Cleaning up... 00:00:55 INFO - Return code: 0 00:00:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:00: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')]} 00:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:00:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:00: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')]} 00:00:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:00:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:00:55 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 0x105852a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10585a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff33959e1e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056f6d30>, '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 0x10551adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1056edb20>, '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.4Y4Zftvke6/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.dy9D7OfwaM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 00:00:55 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 00:00:55 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 00:00:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4Y4Zftvke6/Render', 00:00:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:00:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:00:55 INFO - 'HOME': '/Users/cltbld', 00:00:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:00:55 INFO - 'LOGNAME': 'cltbld', 00:00:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:00:55 INFO - 'MOZ_NO_REMOTE': '1', 00:00:55 INFO - 'NO_EM_RESTART': '1', 00:00:55 INFO - 'PAGER': '/bin/cat', 00:00:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:00:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:00:55 INFO - 'PWD': '/builds/slave/test', 00:00:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:00:55 INFO - 'SHELL': '/bin/bash', 00:00:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dy9D7OfwaM/Listeners', 00:00:55 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 00:00:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:00:55 INFO - 'USER': 'cltbld', 00:00:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:00:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:00:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:00:55 INFO - 'XPC_FLAGS': '0x0', 00:00:55 INFO - 'XPC_SERVICE_NAME': '0', 00:00:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:00:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:00:55 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-UQJvwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:00:55 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)) 00:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:00:55 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-YduShZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:00:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:00:55 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-vUjRoa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:00:55 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)) 00:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:00:55 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-h0cnMP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:00:56 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)) 00:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:00:56 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-QAt5Tq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:00:56 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)) 00:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:00:56 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-RUnLmE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:00:56 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)) 00:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:00:56 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-mZaCH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:00:56 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)) 00:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:00:56 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-NejFny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:00:56 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)) 00:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:00:56 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-o5TQJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:00:56 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)) 00:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:00:56 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-h5qzDP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:00:56 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)) 00:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:00:56 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-in3z0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:00:56 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)) 00:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:00:56 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-Z0QPWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:00:56 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)) 00:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:00:56 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-aXrQfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:00:57 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)) 00:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:00:57 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-kmLcsX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:00:57 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)) 00:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:00:57 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-eD0o7K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:00:57 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)) 00:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:00:57 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-tiH3Ot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:00:57 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)) 00:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:00:57 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-3OKfET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:00:57 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)) 00:00:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:00:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:00:57 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)) 00:00:57 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)) 00:00:57 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)) 00:00:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:00:57 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 00:00:57 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 00:00:57 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 00:00:57 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 00:00:57 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 00:00:57 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 00:00:59 INFO - Downloading blessings-1.6.tar.gz 00:00:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:00:59 INFO - Installing collected packages: blessings 00:00:59 INFO - Running setup.py install for blessings 00:01:00 INFO - Successfully installed blessings 00:01:00 INFO - Cleaning up... 00:01:00 INFO - Return code: 0 00:01:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:01:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:01:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:01:00 INFO - Reading from file tmpfile_stdout 00:01:00 INFO - Current package versions: 00:01:00 INFO - blessings == 1.6 00:01:00 INFO - blobuploader == 1.2.4 00:01:00 INFO - docopt == 0.6.1 00:01:00 INFO - manifestparser == 1.1 00:01:00 INFO - mozInstall == 1.12 00:01:00 INFO - mozcrash == 0.16 00:01:00 INFO - mozdebug == 0.1 00:01:00 INFO - mozdevice == 0.48 00:01:00 INFO - mozfile == 1.2 00:01:00 INFO - mozhttpd == 0.7 00:01:00 INFO - mozinfo == 0.9 00:01:00 INFO - mozleak == 0.1 00:01:00 INFO - mozlog == 3.1 00:01:00 INFO - moznetwork == 0.27 00:01:00 INFO - mozprocess == 0.22 00:01:00 INFO - mozprofile == 0.28 00:01:00 INFO - mozrunner == 6.11 00:01:00 INFO - mozscreenshot == 0.1 00:01:00 INFO - mozsystemmonitor == 0.0 00:01:00 INFO - moztest == 0.7 00:01:00 INFO - mozversion == 1.4 00:01:00 INFO - psutil == 3.1.1 00:01:00 INFO - requests == 1.2.3 00:01:00 INFO - wsgiref == 0.1.2 00:01:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:01:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:01:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:01:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:01:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:01:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:01:00 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 0x105852a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10585a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff33959e1e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056f6d30>, '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 0x10551adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1056edb20>, '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.4Y4Zftvke6/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.dy9D7OfwaM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 00:01:00 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 00:01:00 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 00:01:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4Y4Zftvke6/Render', 00:01:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:01:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:01:00 INFO - 'HOME': '/Users/cltbld', 00:01:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:01:00 INFO - 'LOGNAME': 'cltbld', 00:01:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:01:00 INFO - 'MOZ_NO_REMOTE': '1', 00:01:00 INFO - 'NO_EM_RESTART': '1', 00:01:00 INFO - 'PAGER': '/bin/cat', 00:01:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:01:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:01:00 INFO - 'PWD': '/builds/slave/test', 00:01:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:01:00 INFO - 'SHELL': '/bin/bash', 00:01:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dy9D7OfwaM/Listeners', 00:01:00 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 00:01:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:01:00 INFO - 'USER': 'cltbld', 00:01:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:01:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:01:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:01:00 INFO - 'XPC_FLAGS': '0x0', 00:01:00 INFO - 'XPC_SERVICE_NAME': '0', 00:01:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:01:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:01:00 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)) 00:01:00 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)) 00:01:00 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)) 00:01:00 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)) 00:01:00 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)) 00:01:00 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)) 00:01:00 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)) 00:01:00 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)) 00:01:00 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)) 00:01:00 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)) 00:01:00 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)) 00:01:00 INFO - Cleaning up... 00:01:00 INFO - Return code: 0 00:01:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:01:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:01:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:01:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:01:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:01:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:01:00 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 0x105852a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10585a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff33959e1e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056f6d30>, '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 0x10551adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1056edb20>, '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.4Y4Zftvke6/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.dy9D7OfwaM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 00:01:00 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 00:01:00 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 00:01:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4Y4Zftvke6/Render', 00:01:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:01:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:01:00 INFO - 'HOME': '/Users/cltbld', 00:01:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:01:00 INFO - 'LOGNAME': 'cltbld', 00:01:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:01:00 INFO - 'MOZ_NO_REMOTE': '1', 00:01:00 INFO - 'NO_EM_RESTART': '1', 00:01:00 INFO - 'PAGER': '/bin/cat', 00:01:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:01:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:01:00 INFO - 'PWD': '/builds/slave/test', 00:01:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:01:00 INFO - 'SHELL': '/bin/bash', 00:01:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dy9D7OfwaM/Listeners', 00:01:00 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 00:01:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:01:00 INFO - 'USER': 'cltbld', 00:01:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:01:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:01:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:01:00 INFO - 'XPC_FLAGS': '0x0', 00:01:00 INFO - 'XPC_SERVICE_NAME': '0', 00:01:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:01:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:01:01 INFO - Downloading/unpacking jsonschema 00:01:01 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 00:01:01 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 00:01:01 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 00:01:01 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 00:01:01 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 00:01:01 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 00:01:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:01:03 INFO - Downloading/unpacking functools32 (from jsonschema) 00:01:03 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 00:01:03 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 00:01:03 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 00:01:03 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 00:01:03 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 00:01:03 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 00:01:03 INFO - Downloading functools32-3.2.3-2.tar.gz 00:01:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:01:03 INFO - warning: no files found matching '*.txt' 00:01:03 INFO - no previously-included directories found matching 'build' 00:01:03 INFO - no previously-included directories found matching 'dist' 00:01:03 INFO - no previously-included directories found matching '.git*' 00:01:03 INFO - Installing collected packages: jsonschema, functools32 00:01:03 INFO - Running setup.py install for functools32 00:01:04 INFO - warning: no files found matching '*.txt' 00:01:04 INFO - no previously-included directories found matching 'build' 00:01:04 INFO - no previously-included directories found matching 'dist' 00:01:04 INFO - no previously-included directories found matching '.git*' 00:01:04 INFO - Successfully installed jsonschema functools32 00:01:04 INFO - Cleaning up... 00:01:04 INFO - Return code: 0 00:01:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 00:01:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:01:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:01:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:01:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:01:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:01:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:01:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105852a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10585a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff33959e1e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056f6d30>, '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 0x10551adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1056edb20>, '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.4Y4Zftvke6/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.dy9D7OfwaM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 00:01:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 00:01:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 00:01:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4Y4Zftvke6/Render', 00:01:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:01:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:01:04 INFO - 'HOME': '/Users/cltbld', 00:01:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:01:04 INFO - 'LOGNAME': 'cltbld', 00:01:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:01:04 INFO - 'MOZ_NO_REMOTE': '1', 00:01:04 INFO - 'NO_EM_RESTART': '1', 00:01:04 INFO - 'PAGER': '/bin/cat', 00:01:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:01:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:01:04 INFO - 'PWD': '/builds/slave/test', 00:01:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:01:04 INFO - 'SHELL': '/bin/bash', 00:01:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dy9D7OfwaM/Listeners', 00:01:04 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 00:01:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:01:04 INFO - 'USER': 'cltbld', 00:01:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:01:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:01:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:01:04 INFO - 'XPC_FLAGS': '0x0', 00:01:04 INFO - 'XPC_SERVICE_NAME': '0', 00:01:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:01:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:01:04 INFO - Downloading/unpacking flake8 00:01:04 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 00:01:04 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 00:01:04 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 00:01:04 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 00:01:04 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 00:01:04 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 00:01:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 00:01:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 00:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:01:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:01:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:01:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:01:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:01:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 00:01:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 00:01:07 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 00:01:07 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 00:01:07 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 00:01:07 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 00:01:07 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 00:01:07 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 00:01:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 00:01:07 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 00:01:07 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 00:01:07 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 00:01:07 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 00:01:07 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 00:01:07 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 00:01:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 00:01:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:01:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:01:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:01:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:01:07 INFO - no previously-included directories found matching 'docs/_build' 00:01:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 00:01:08 INFO - Running setup.py install for pep8 00:01:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:01:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:01:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:01:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:01:08 INFO - no previously-included directories found matching 'docs/_build' 00:01:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 00:01:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 00:01:08 INFO - Cleaning up... 00:01:08 INFO - Return code: 0 00:01:08 INFO - Running post-action listener: _resource_record_post_action 00:01:08 INFO - Running post-action listener: _start_resource_monitoring 00:01:08 INFO - Starting resource monitoring. 00:01:08 INFO - ##### 00:01:08 INFO - ##### Running install step. 00:01:08 INFO - ##### 00:01:08 INFO - Running pre-action listener: _resource_record_pre_action 00:01:08 INFO - Running main action method: install 00:01:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:01:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:01:08 INFO - Reading from file tmpfile_stdout 00:01:08 INFO - Detecting whether we're running mozinstall >=1.0... 00:01:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:01:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:01:08 INFO - Reading from file tmpfile_stdout 00:01:08 INFO - Output received: 00:01:08 INFO - Usage: mozinstall [options] installer 00:01:08 INFO - Options: 00:01:08 INFO - -h, --help show this help message and exit 00:01:08 INFO - -d DEST, --destination=DEST 00:01:08 INFO - Directory to install application into. [default: 00:01:08 INFO - "/builds/slave/test"] 00:01:08 INFO - --app=APP Application being installed. [default: firefox] 00:01:08 INFO - mkdir: /builds/slave/test/build/application 00:01:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 00:01:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 00:01:42 INFO - Reading from file tmpfile_stdout 00:01:42 INFO - Output received: 00:01:42 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 00:01:42 INFO - Running post-action listener: _resource_record_post_action 00:01:42 INFO - ##### 00:01:42 INFO - ##### Running run-tests step. 00:01:42 INFO - ##### 00:01:42 INFO - Running pre-action listener: _resource_record_pre_action 00:01:42 INFO - Running main action method: run_tests 00:01:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:01:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:01:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:01:42 INFO - 2016-02-21 00:01:42.601 screenresolution[1666:10564] starting screenresolution argv=screenresolution get 00:01:42 INFO - 2016-02-21 00:01:42.604 screenresolution[1666:10564] Display 0: 1600x1200x32@60 00:01:42 INFO - 2016-02-21 00:01:42.609 screenresolution[1667:10566] starting screenresolution argv=screenresolution list 00:01:42 INFO - Available Modes on Display 0 00:01:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:01:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:01:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:01:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:01:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:01:42 INFO - Intel Iris: 00:01:42 INFO - Chipset Model: Intel Iris 00:01:42 INFO - Type: GPU 00:01:42 INFO - Bus: Built-In 00:01:42 INFO - VRAM (Dynamic, Max): 1536 MB 00:01:42 INFO - Vendor: Intel (0x8086) 00:01:42 INFO - Device ID: 0x0a2e 00:01:42 INFO - Revision ID: 0x0009 00:01:42 INFO - Displays: 00:01:42 INFO - Display: 00:01:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:01:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:01:42 INFO - Display Serial Number: 1600x1200 60 00:01:42 INFO - Main Display: Yes 00:01:42 INFO - Mirror: Off 00:01:42 INFO - Online: Yes 00:01:42 INFO - Rotation: Supported 00:01:42 INFO - Return code: 0 00:01:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:01:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:01:42 INFO - Python 2.7.3 00:01:42 INFO - Return code: 0 00:01:42 INFO - grabbing minidump binary from tooltool 00:01: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')]} 00:01:42 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 0x1056f6d30>, '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 0x10551adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1056edb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:01:42 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 00:01:42 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 00:01:42 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:01:42 INFO - Return code: 0 00:01:42 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 00:01:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:01:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:01:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 00:01:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:01:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 00:01:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 00:01:44 INFO - Return code: 0 00:01:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W8731TS4RGyiuBWgRXoNYQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0095', '--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 00:01:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/W8731TS4RGyiuBWgRXoNYQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0095 --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 00:01:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4Y4Zftvke6/Render', 00:01:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:01:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:01:44 INFO - 'HOME': '/Users/cltbld', 00:01:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:01:44 INFO - 'LOGNAME': 'cltbld', 00:01:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:01:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 00:01:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:01:44 INFO - 'MOZ_NO_REMOTE': '1', 00:01:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:01:44 INFO - 'NO_EM_RESTART': '1', 00:01:44 INFO - 'PAGER': '/bin/cat', 00:01:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:01:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:01:44 INFO - 'PWD': '/builds/slave/test', 00:01:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:01:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:01:44 INFO - 'SHELL': '/bin/bash', 00:01:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dy9D7OfwaM/Listeners', 00:01:44 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 00:01:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:01:44 INFO - 'USER': 'cltbld', 00:01:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:01:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:01:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:01:44 INFO - 'XPC_FLAGS': '0x0', 00:01:44 INFO - 'XPC_SERVICE_NAME': '0', 00:01:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:01:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W8731TS4RGyiuBWgRXoNYQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0095', '--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 00:01:44 INFO - mozversion application_buildid: 20160220192510 00:01:44 INFO - mozversion application_changeset: 7eb1382d6cef49a27f7ced970a2b135f0f20f014 00:01:44 INFO - mozversion application_display_name: Nightly 00:01:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:01:44 INFO - mozversion application_name: Firefox 00:01:44 INFO - mozversion application_remotingname: firefox 00:01:44 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 00:01:44 INFO - mozversion application_vendor: Mozilla 00:01:44 INFO - mozversion application_version: 47.0a1 00:01:44 INFO - mozversion platform_buildid: 20160220192510 00:01:44 INFO - mozversion platform_changeset: 7eb1382d6cef49a27f7ced970a2b135f0f20f014 00:01:44 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 00:01:44 INFO - mozversion platform_version: 47.0a1 00:01:44 INFO - using testdate: 1456041704 00:01:44 INFO - actual date: 1456041704 00:01:44 INFO - starting webserver on 'localhost:49279' 00:01:44 INFO - SUITE-START | Running 2 tests 00:01:44 INFO - TEST-START | dromaeo_css 00:01:44 INFO - operating with platform_type : mac_ 00:01:44 INFO - Initialising browser for dromaeo_css test... 00:01:44 INFO - TEST-INFO | started process 1685 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/tmp5fSs76/profile http://localhost:49279/getInfo.html) 00:01:47 INFO - PROCESS | 1685 | __metrics Screen width/height:1600/1200 00:01:47 INFO - PROCESS | 1685 | colorDepth:24 00:01:47 INFO - PROCESS | 1685 | Browser inner width/height: 1024/689 00:01:47 INFO - PROCESS | 1685 | __metrics 00:01:47 INFO - PROCESS | 1685 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 00:01:47 INFO - PROCESS | 1685 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:01:47 INFO - TEST-INFO | 1685: exit 0 00:01:47 INFO - Browser initialized. 00:01:47 INFO - Running cycle 1/1 for dromaeo_css test... 00:01:47 INFO - TEST-INFO | started process 1689 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/tmp5fSs76/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:01:59 INFO - PROCESS | 1689 | RSS: Main: 244273152 00:01:59 INFO - PROCESS | 1689 | 00:02:50 INFO - PROCESS | 1689 | 1456041770803 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] 00:05:01 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49279/tests/dromaeo/cssquery-ext.html) 00:05:02 INFO - PROCESS | 1689 | RSS: Main: 340672512 00:05:02 INFO - PROCESS | 1689 | 00:08:05 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-ext.html (next: http://localhost:49279/tests/dromaeo/cssquery-jquery.html) 00:08:05 INFO - PROCESS | 1689 | RSS: Main: 378208256 00:08:05 INFO - PROCESS | 1689 | 00:11:08 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49279/tests/dromaeo/cssquery-mootools.html) 00:11:08 INFO - PROCESS | 1689 | RSS: Main: 337829888 00:11:08 INFO - PROCESS | 1689 | 00:14:10 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49279/tests/dromaeo/cssquery-prototype.html) 00:14:11 INFO - PROCESS | 1689 | RSS: Main: 337448960 00:14:11 INFO - PROCESS | 1689 | 00:17:14 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49279/tests/dromaeo/cssquery-yui.html) 00:17:15 INFO - PROCESS | 1689 | RSS: Main: 337907712 00:17:15 INFO - PROCESS | 1689 | 00:20:17 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-yui.html (next: http://localhost:49279/tests/dromaeo/cssquery-dojo.html) 00:20:18 INFO - PROCESS | 1689 | RSS: Main: 405680128 00:20:18 INFO - PROCESS | 1689 | 00:20:18 INFO - PROCESS | 1689 | __start_tp_report 00:20:18 INFO - PROCESS | 1689 | _x_x_mozilla_page_load 00:20:18 INFO - PROCESS | 1689 | _x_x_mozilla_page_load_details 00:20:18 INFO - PROCESS | 1689 | |i|pagename|runs| 00:20:18 INFO - PROCESS | 1689 | |0;dojo.html;2877.194385572038;3395.609504906936;3496.3182179475007;3509.438489841626;3556.2354093869812;5495.670259784416;5622.83131506055;5626.324841019078;5633.6338138021;5648.74580643871;5618.859528511789;5663.801766938148;5679.261695979517;5775.36470988192;5786.826395208151;5067.569256613192;5092.77082531286;5114.718690472023;5123.257127716479;5248.658837175591;5212.739363031852;5222;5251.973740131294;5278.604104692145;5314.681119132845;4164.68764842635;5094.261332106842;5202.557782588466;5227.45111763267;5239.21411788231;5140.357455318085;5146.665466744687;5172.612054095958;5175.275461435402;5178.792848286064;4167.83328666853;5140.511651393112;5161.845144645629;5174.197999310075;5208;4988.800447982077;5491.2312276281355;5516.227728118067;5606.55147588192;5637;5899.528037756969;6199.163112979735;6214.161088253073;6222.191115155046;6229.439350458435;6200.410960958701;6216.595921265149;6238.750449982041;6239.500839932794;6258.687065646745;5605.7197140142825;5671.886562268773;5714.714264286769;5721.656700597978;5766.481016708516;5996.550258730613;6266.154069200599;6277.8744425111245;6290.056491526216;6324.08300796382;5950.672713000827;6057.878842423127;6095.664738439428;6127.938720612737;6137.294211165684;6100.755969761249;6100.883963092903;6149.877002460015;6232.906506402408;6258.342873998165;6154.446099851035;6159.84600384985;6163.568550201443;6164.137020817089;6168.444839964424;6077.878442431127;6160.722767475474;6171.783987560414;6178.104174894615;6194.132821405007;4788.162071637449;4865.294532292868;4873.463918968911;4884.902301953941;4885.462599114095;4277.828886844553;4387.319965405367;4447.599716025573;4454.57681520255;4455.532169122261;5762.538996880239;5776.104703770922;5782.537397008229;5800.0429929062075;5840;6249.375062493714;6251.874962500725;6253;6256.562040657111;6260.217472815898;5639.661620302795;5698.202251684767;5754.6547207167705;5782.190493330937;5789.797357092566;5328.733563321818;5333.6533125347505;5377.5429088527135;5397.27136836522;5428.5114339708825;6300.21247344082;6310.842228944313;6315.242170939517;6322.71547780351;6341.048842673636;6024.608400453956;6130.233720784902;6188.938110618837;6250.406211409909;6258.468030217483;6248.593841400295;6287.528435367274;6321.936780632135;6335.144755458138;6360.809175724736;6113.755449782137;6119.602225855483;6120.8775824484155;6127.816165515042;6137.7851775187655;6121.540884433596;6203.472704820141;6214.2853571838;6247.094171345038;6256.7810126645345;5955.315138758925;5970.492508136857;6010.429009244115;6043.939560604338;6067.757289708539;5911.527077833849;5964.850878728066;5991.3409524953095;6002.7298771554515;6010;4944.851654450372;5535.059039963136;5855.2973643163095;5880.323762767165;5883.323417807007;4644.512326205835;6009.729562169626;6043.667598282137;6068.089786532056;6103.7253323601435;5819.185314056121;5855.443732845373;5865.706714664335;5870.148828419769;5898.8230353089475 00:20:18 INFO - PROCESS | 1689 | |1;ext.html;460.14413191463893;513.0252520211598;574.7040274258758;582.1878479521068;616.5776443136452;36954.630453695456;37317.626823731756;37341;37414.43878341827;37427.43858842116;40046.799766001204;40456.39315410271;40561.59438405615;40566;40630.187396252055;9545.04549545047;9766.316357854954;9768.023197680246;9777.706668799947;9789.412635241873;9589.136977672008;9730.367526110815;9740.074692904163;9836.606535738561;9854.113129818315;9779.364341317827;9865.60537578496;9880.110790028895;9881.604735810559;9909.851352229687;9806.460644664541;9863.950680246553;9876.90123098767;9887.110160085627;9920;9638.180754635865;9782.804343913082;9791.265655075898;9803.019698030212;9822.361546499455;39065.41401878974;39553.40669889954;39559.40660890089;39569.20861582752;39574.406383904265;3179.284660951291;3333.1333853198103;3454.3264063507627;3644.344018076745;3794.6015668354976;28575.14274571766;29057.56413653797;29512.70487295121;29890.70109298901;29995.400091998257;2791.260316016257;2800.8739606717745;2831.065748303055;2897.826130432181;2960.5115155999233;506780;508508.3723744147;508828;509618;509630;44263.55736442659;44349.77825110854;44448.55551444509;44627.55372446234;62707;44729;45254.86862828456;45632.543674563494;45652;45705;15717.21413929299;15903.840961590467;15926.61100834884;15938.203089845461;15941.840581594268;12728.554500592434;12811.871881281255;12814.167079139826;12816.166949148275;12943.676408089874;14340.856591434162;14422.855771442151;14451.91610629207;14495.420183192766;14507.492237771627;6236.18929539157;6260.40526150015;6275.466585340298;6313.747450101944;6323.620582765049;979.2851218610311;991.4249735153594;1008.5007921079113;1072.6942821295893;1131.4173200801595;27825.721742782313;27881.16356509308;28487.430251394857;28555.857765689554;28593.28516787097;964.4261664309724;1058.9894101059044;1073.1682945716975;1124.3254047571554;1162.128403697227;15921.761173582405;15951.361945522049;16039.518814435585;16135.83864161367;16163.515094547183;656908;665245;672912;674168;674749;51488.712782179995;59362;59742.40257597456;59939.501512462535;59991.10013349803;1419.2194293138732;1429.3925081840177;1439.2803598200899;1444.104655113836;1553.852384023516;28821.84712611472;32735;32782;33900;33910.491342629386;55968;56656.43343566677;57394.7130264346;57425;57562.712186440476;498992;503297;503775;504270;504430;37804.81097594494;45398;46048.769756152346;46944.29583556181;47548;36077.639223607424;45321.77339113283;45832;46100.538994609626;46110;34796.82601586976;35165.120871978404;35928.82035589805;36680.81659591792;37891.431628525046;37239;37471.62528374681;37528.114597599066;37783.43324850075;38964.610353896096;38572.03569910662;39261.80369098136;39582.80208598939;39649.603503964594;39678.60321396749;31175.532367014966;32531.349373011933;33240.83379583087;35056.82471587626;35057.82471087628;24634.13780517673;25012;25621.743782561934;25696.486070278865;25935.740642594086 00:20:18 INFO - PROCESS | 1689 | |2;jquery.html;336.5826375294634;362.06406439354265;365.5467220646398;366.0774847384591;374.3916136278547;15435.228238588083;16158.272877720501;19359.612807743837;20002.49993750157;20791.480212994684;16083.437079702213;17166.742498862528;20138.194472221094;20179.69730454041;20196.091175897083;4907.50924907509;5127.692338459686;5164.819231326905;5177.715225662587;5183.688978661274;3834.926220658206;4041.717079804415;5151.4333423323405;5200.557952574036;5205.6616319939085;4028.8187031583648;4030.717849750519;4528.366028755977;5818.243628328311;5828.417158284159;5540.86147846303;5781.508571771405;5787.13193021046;5794.565407594426;5807.04183809673;5498.395176530578;5523.171524271352;5531.723413829292;5533.889322213573;5547.72261386929;13003.869961300361;13427.731445371135;19193.80806191948;25056.624150637756;25144.87427562869;2043.3052762060822;2048.9180432782673;2079.2930403662826;2116.164115174513;2171.5873983943;9429.575669094907;9511.857322140173;9673.516324183762;9911.801763964753;10105;1665.383807991039;1701.9914900425542;1768.9911550442293;1786.8213178682158;1800.5048611631776;81300;81963;94371.0562894369;96525;104823.42764858533;10906.182036347305;10965.451727413598;10985.340879547253;11101.44492775358;11146.219764616399;11572.47923843429;13440.663983400298;13598.04813663054;13598.456061757617;13610.795838062437;8305.792355191168;8440.915590844135;8450.112738162527;8504;8504.23461888433;6890.138732658418;6947.478939079489;8514.914850851535;8519.361047921308;8531.445456045338;4422;4458.331250312479;4474.485434175046;4481.641468682497;4513.887152821206;1550;1816.637521858606;1862.7485289486017;1865.1047497201419;1866.16955454824;863.3450896627068;903.5482258870564;954.5895265036102;965.6234068713208;1030.8247597908223;15142;19568.608627827365;20122.69815952762;20190.495237619176;20388;908.7818923458454;938.8452203789241;969.1665167955553;979.6913972098766;982.9557669904872;10723.195760318007;11035.95158459945;11063.668089957315;11073.05879000294;11090.500927458284;451593;458726;601429;624362;631247;72953.99999999894;109683;112892;115002;117078;966.2028826218258;988.5452691761726;999.7800483893532;1000.9349392289623;1002.9297949143636;13338.799918001043;14474.565763027125;17721.645567088843;17756.46730598084;18034.729479058085;37941.62058379381;50759;50776;52390.738046309525;52637.7368113157;68262.9760553602;70515;70844;77060.61469692616;77149;7888.132305446282;8088.757337279891;8207.671693132208;8288.792780180544;8412.242898139197;6815.250322464624;9550.713478595653;11249.325040497597;13119.8192162702;13563.254021028939;11281.09751219884;11678.766424671629;11879.821802672794;11930.582429614922;11941;11334.773304533699;11371.20401571882;11371.601993930173;11654.359010254517;11720.531178752753;11720.589779357682;11753.09180924791;11794.469248883992;11951.701207469883;11954.76090478203;8154.14381489935;8176.100628930932;8208.261256486945;8231.09457959636;8416.074231834617;9836.163926066365;11077.224594278323;11766.705832354259;11777.998870096138;11890.821637675268 00:20:18 INFO - PROCESS | 1689 | |3;mootools.html;1525.1306755149565;1540.9306581203846;1783.6789377911978;1904.8476121910248;1943.0090653766574;7859.646315915783;8012.879806802903;8594.011688655806;8765.641325594535;8785.780355491115;8310.293625041879;8380.161983801618;8525.91474085259;8530.402871798977;8536.743897683064;2455.459798844256;2490.066225165563;2491.7632824881607;2492.4890397468475;2496.251124662603;2189.868607883524;2254.5040091179912;2419.0323870451784;2420.5884999550117;2478.7397323281066;2443.609022556391;2444.291155564893;2463.5688754467988;2478.8016958643357;2479.1570865905587;2443.9755602443925;2468.1114798672465;2470.1354525915967;2472.814538909571;2477.7398373170736;2472.3571871313407;2497.425592113806;2497.887595058227;2499.9250022499355;2501.6372625969316;8709.56452177395;8716.041235464094;8717.30261579072;8724.171203735636;8758.167974042519;5314.760835762361;5402.405735369106;5418.729063546807;5460.672359658433;5469.425710300441;3617.656322649344;3644.4853051394452;3726.850925962958;3739.7569158004917;3753.8498460061564;1064.3401091323428;1075.1828610256184;1097.314178638351;1103.3269705479652;1105.1269497097283;11863.169578129535;11885.465154068088;11902.940485297604;11903.64289071338;11912.523499060027;4860.586850117709;4904.288878112654;4921.335619691367;4982.177940639826;5022.347094877642;9915.058069483388;9915.65295214664;9972.252081093948;10011.199104071657;10011.549480273405;5439.619226654176;5439.673619582838;5449.3188351456065;5450.618456707993;5458.8908221835345;4954.47977962316;4961.231009193581;4964.205727083649;4966.279889416014;4967.975160124176;3330.8001519908885;3687.2072504411144;3929.233799409145;4051.108756073659;4051.2707712612014;1066.8293073108266;1106.9280496767685;1309.0443975897458;1320.221069568959;1329.7274058817918;1310.0305773727373;1317.841858976929;1334.252818421687;1339.0827283310964;1363.0526783885302;8013.919860801434;8044.678212871537;8049.879251811228;8086.555239461768;8116.472429292196;1162.9127815413879;1168.2756690851727;1200.6038007457519;1205.9035277177804;1211.2974474804591;6200.162977998003;6286.528510361742;6298.590591611531;6315.905261421082;6331.050342448578;9799.951000244953;10008.349457285252;11076.778464430827;11081.722956926142;11086.334819910831;10426.843597346045;10825;10923.235373523936;10929.398883061349;10948.576685030896;7002.684879180449;8239.752807415787;8443.282321002784;8469.11074337198;8470.66117355299;7750;7883.84232315362;7895.289423951872;7898.68405263783;8215;9583.952080239555;9603.135717785433;9644.987276335884;9696.612135514782;9847.556859941464;9414.482203478874;9713.805723885624;9923.801523969336;10152.39085654863;10155.593776249163;7395.741149059757;7435.256474352522;7501.699932002659;7523;7540.981967434326;7298.452616053711;7502.549847009197;8096.83806323882;8134.63394147253;8139.389545784208;6525.1517302750335;7364.5581265124265;7400.48196626231;7409;7538.509996850187;7264.854702906018;7401.111866576045;7463.402927765875;7512.586807725627;7581.583012934341;7528.548287102572;7665.731699390718;7687.231276872268;7742.845143097219;7821;6941.93058069433;6958;7004.264552221944;7018.192907815666;7020.613866237201;7052.894206587008;7100.502964792415;7114.822129446805;7134.001239826533;7139.750108746169 00:20:18 INFO - PROCESS | 1689 | |4;prototype.html;323.15978456014363;328.0944592923532;330.6924560159051;334.3613697837131;337.182332842856;5313.777831098845;6583.308752580976;6589.5057870659775;6667.699953502092;6683.933160668398;6575.243846957601;6579.7697080602065;6592.307807680197;6603.174603174603;6603.636799976;4888.046830867973;4895.800528870432;4904.828331008415;4910.656254062217;4921.80312787488;4912.606991440694;4913.8771530711665;4920.655554111214;4921.557059864629;4924.409070911478;4429.712068715539;4618.330342100394;4798.992211635543;4863.19757240055;4866.975665121669;4759.143354196243;4777.044591081798;4794.760261986921;4799.592034677056;4824.782884770176;3373.291608762163;4100.34394496879;4105.6920730945;4120.237756015117;4133.545310015926;6020.939790602081;6182.69086545671;6232;6338.492920566344;6357.268914074894;5630.943690563083;5638.4925356718095;5648.152777083429;5648.406917273668;5653.293338332708;5585.804496842591;6994.230634630187;7019.929800701979;7020.508564400494;7030.578165310047;4599.862004139881;4611.654125940534;4613.21575332191;4619.74591397473;4622.283546050334;5295.4704529547125;7355.8896616550255;7370.5946172961;7399;7422;4683.016566521001;4736.005438857878;4737.6683632146105;4739.990106282536;4743.28850672395;4799.784009719571;4808.807647694123;4825.638077144158;4832.806687732451;4843.467218605951;5698.145278208219;5709.74306156224;5712.457316555004;5718.542516598662;5720.8283751487525;7031.191412987572;7036;7051.612161331176;7052.483716001085;7056.894146587805;1376.779715245556;1587.777711120444;1646.2756387189838;1649.6370798424327;1668.5911951571943;1086.315621158665;1097.533548241994;1104.5471356743697;1106.115107913666;1110.900208793305;5425.484578964992;6598.997456157437;6629.801105966829;6638.601683898982;6650.401463868275;6996.475264355194;7184.317489838457;7236.457265705093;7264.273572642799;7275.308845659654;6552.3775241352;6658.700358483879;6672.86654266912;6677.833054173684;6686.765963191362;3841.8079096045085;3891.766494010312;3891.9805400972814;3894.123822139996;3897.4348719435525;7732.110807257238;7738.806529836686;7742.729004484929;7743.225677432211;7746.961265193638;7274.709011639475;7560;7566.167721550625;7568.167501574822;7622.58075805836;7685.193054729285;7707.267809558083;7717.112532058773;7730.652120654584;7731.110922243902;5369.436209198134;6841.973703944448;7308.342249197598;7331.156916954618;7333.266673332624;7182.35358817688;7199.208087110518;7203.135623725187;7203.171635262012;7220.566765994057;7410.96294518524;7552.13150487679;7697.692092316244;7769;7775.222477752406;4729.243321068612;4763.309320148628;4767.427908650984;4773.451053128934;4781.187198176249;5212.791488340424;5856.94143058581;7279.888832238592;7289.1981881994;7304.233055529093;6273.839339722166;6489.513286503437;7033.613151276729;7056;7095.432365410651;6744.393004629607;6959.4432445405255;7022.367986881205;7026.1217347831525;7039.577625342496;6875.759348422781;6899.551529150589;6900.6204658744255;6903.275156108536;6922.307769223037;7045.11936007999;7046.541974771623;7052.695251378512;7057.788266352018;7096.680649370687;6913.89629155553;6915.6887940043825;6928.584284942919;6931.1682598088555;6935.271796461299 00:20:18 INFO - PROCESS | 1689 | |5;yui.html;682.7405585877367;742.5804420502416;746.7013194722114;761.7638532055065;792.8810678398244;13995.650108747286;17016.74474882876;17305.22126504307;17369.47891563255;17382.391616293433;15641;15679.921600391983;15743.685126297467;15760.921195394036;15784;705.4814711187273;710.6659869861157;866.8569686001803;871.7689812199773;873.0789017586444;855.8202777416719;871.4684042733927;872.5986046418654;875.8817559629432;876.9210771030606;899.2356496977582;926.6571368593629;927.5779520318273;928.3872644054925;928.5032507608431;736.6905899522213;902.5487256371814;911.1526280559077;917.0508523677995;918.9218916392115;668.5420486966443;671.6977360187935;674.4604316546792;676.9898451523231;677.5257319876057;15038.54884353471;15051.247437628184;15076.698466030617;15079.472218472301;15098.396064157421;12074.879251207463;12200.511979520808;12361.07291953107;12418.689532761662;12427.689307767378;10150.847737283946;10159.593616255415;10201.43892085935;10269;10897.564097436092;3440.690337869604;3489.7731647442833;3506.6142724300307;3508.912277193065;3680.337539242962;77830.6108469454;78952.60523697345;79463.60268198622;79659.8051029235;80044.59977700132;7769.417293702882;9211.723648290563;9231.630734770533;9349.345545811864;9409.670661526814;20264.392068237976;20482.487937801674;20485.59028819415;20494.795052049587;20510.179592816417;7390.667419966115;7398.260173982559;7401.962990185122;7448.366888814511;7570.772876813704;4174.853880114181;4180.038591124058;4192.140611174702;4236.131593023423;4265;3473.3400653875683;3503.211777350127;3518.8592456301462;3523.6652518010746;3536.1159710072484;630.609022406102;632.4624069540945;636.1475622665557;638.4605008767584;645.8127143128534;511.2152845382395;549.198170670817;581.3895409819672;590.5865893874305;636.8471566823929;8380.958095209486;8521.181065147559;8536.573171341408;8584;8654.610542525601;507.8146476536038;532.9546988505942;594.378874076591;610.334735138692;613.923259592551;3772.6227377262603;3850.133719912997;3921.313770090223;4041.8585349512628;4090.9181816363507;75382.62308688421;77709.22290777019;87022.12977870267;87343.12656873478;87360.1263987352;73551;74277.51444971071;74406;74983;75567.62216188994;27694.446111077665;27839.582406263922;42801.571984279755;66413.33586664168;66875;7497.9250207497225;7671.578063206577;7758.3017528422715;7830.608469576612;7890.48711833729;47224.527754723385;47362.763186183845;47496.76251618858;47961;49167.01665966732;59520.70239648774;64441.67779161074;64522.67738661465;64976.675116624116;65599.34400655932;9787.657431989846;9800.852987205055;9842.901570984199;9941.353812002197;10503.689188378545;11867.050635949276;11999.580014699444;12115.394230288273;12420.875791241971;12786.87213127894;8284.668613255402;10232.5397139801;11845.348505831917;12027.639170824888;12084.637460876187;11314.151438642299;11577.305361678325;11666.824997624874;11692.88307116952;12386.009119270257;10934.343939363664;10965.342079475256;11091.944540277247;11196.888031119584;11321.943390282995;9632.47021413829;9838.852417213891;9947;10060.547275372479;10172.338797978404;9181.127792859668;9187.954060229657;9367.906320936703;9688.273379496424;9705.466199359103 00:20:18 INFO - PROCESS | 1689 | __end_tp_report 00:20:18 INFO - PROCESS | 1689 | __start_cc_report 00:20:18 INFO - PROCESS | 1689 | _x_x_mozilla_cycle_collect,994 00:20:18 INFO - PROCESS | 1689 | __end_cc_report 00:20:18 INFO - PROCESS | 1689 | __startTimestamp1456042818090__endTimestamp 00:20:18 INFO - PROCESS | 1689 | 00:20:18 INFO - PROCESS | 1689 | ------- Summary: start ------- 00:20:18 INFO - PROCESS | 1689 | Number of tests: 6 00:20:18 INFO - PROCESS | 1689 | 00:20:18 INFO - PROCESS | 1689 | [#0] dojo.html Cycles:165 Average:5675.48 Median:5870.15 stddev:660.72 (11.3%) stddev-sans-first:625.21 00:20:18 INFO - PROCESS | 1689 | Values: 2877.2 3395.6 3496.3 3509.4 3556.2 5495.7 5622.8 5626.3 5633.6 5648.7 5618.9 5663.8 5679.3 5775.4 5786.8 5067.6 5092.8 5114.7 5123.3 5248.7 5212.7 5222.0 5252.0 5278.6 5314.7 4164.7 5094.3 5202.6 5227.5 5239.2 5140.4 5146.7 5172.6 5175.3 5178.8 4167.8 5140.5 5161.8 5174.2 5208.0 4988.8 5491.2 5516.2 5606.6 5637.0 5899.5 6199.2 6214.2 6222.2 6229.4 6200.4 6216.6 6238.8 6239.5 6258.7 5605.7 5671.9 5714.7 5721.7 5766.5 5996.6 6266.2 6277.9 6290.1 6324.1 5950.7 6057.9 6095.7 6127.9 6137.3 6100.8 6100.9 6149.9 6232.9 6258.3 6154.4 6159.8 6163.6 6164.1 6168.4 6077.9 6160.7 6171.8 6178.1 6194.1 4788.2 4865.3 4873.5 4884.9 4885.5 4277.8 4387.3 4447.6 4454.6 4455.5 5762.5 5776.1 5782.5 5800.0 5840.0 6249.4 6251.9 6253.0 6256.6 6260.2 5639.7 5698.2 5754.7 5782.2 5789.8 5328.7 5333.7 5377.5 5397.3 5428.5 6300.2 6310.8 6315.2 6322.7 6341.0 6024.6 6130.2 6188.9 6250.4 6258.5 6248.6 6287.5 6321.9 6335.1 6360.8 6113.8 6119.6 6120.9 6127.8 6137.8 6121.5 6203.5 6214.3 6247.1 6256.8 5955.3 5970.5 6010.4 6043.9 6067.8 5911.5 5964.9 5991.3 6002.7 6010.0 4944.9 5535.1 5855.3 5880.3 5883.3 4644.5 6009.7 6043.7 6068.1 6103.7 5819.2 5855.4 5865.7 5870.1 5898.8 00:20:18 INFO - PROCESS | 1689 | 00:20:18 INFO - PROCESS | 1689 | [#1] ext.html Cycles:180 Average:68941.61 Median:39578.60 stddev:151135.29 (381.9%) stddev-sans-first:151471.80 00:20:18 INFO - PROCESS | 1689 | Values: 460.1 513.0 574.7 582.2 616.6 36954.6 37317.6 37341.0 37414.4 37427.4 40046.8 40456.4 40561.6 40566.0 40630.2 9545.0 9766.3 9768.0 9777.7 9789.4 9589.1 9730.4 9740.1 9836.6 9854.1 9779.4 9865.6 9880.1 9881.6 9909.9 9806.5 9864.0 9876.9 9887.1 9920.0 9638.2 9782.8 9791.3 9803.0 9822.4 39065.4 39553.4 39559.4 39569.2 39574.4 3179.3 3333.1 3454.3 3644.3 3794.6 28575.1 29057.6 29512.7 29890.7 29995.4 2791.3 2800.9 2831.1 2897.8 2960.5 506780.0 508508.4 508828.0 509618.0 509630.0 44263.6 44349.8 44448.6 44627.6 62707.0 44729.0 45254.9 45632.5 45652.0 45705.0 15717.2 15903.8 15926.6 15938.2 15941.8 12728.6 12811.9 12814.2 12816.2 12943.7 14340.9 14422.9 14451.9 14495.4 14507.5 6236.2 6260.4 6275.5 6313.7 6323.6 979.3 991.4 1008.5 1072.7 1131.4 27825.7 27881.2 28487.4 28555.9 28593.3 964.4 1059.0 1073.2 1124.3 1162.1 15921.8 15951.4 16039.5 16135.8 16163.5 656908.0 665245.0 672912.0 674168.0 674749.0 51488.7 59362.0 59742.4 59939.5 59991.1 1419.2 1429.4 1439.3 1444.1 1553.9 28821.8 32735.0 32782.0 33900.0 33910.5 55968.0 56656.4 57394.7 57425.0 57562.7 498992.0 503297.0 503775.0 504270.0 504430.0 37804.8 45398.0 46048.8 46944.3 47548.0 36077.6 45321.8 45832.0 46100.5 46110.0 34796.8 35165.1 35928.8 36680.8 37891.4 37239.0 37471.6 37528.1 37783.4 38964.6 38572.0 39261.8 39582.8 39649.6 39678.6 31175.5 32531.3 33240.8 35056.8 35057.8 24634.1 25012.0 25621.7 25696.5 25935.7 00:20:18 INFO - PROCESS | 1689 | 00:20:18 INFO - PROCESS | 1689 | [#2] jquery.html Cycles:180 Average:31616.11 Median:19158.01 stddev:92735.46 (484.1%) stddev-sans-first:92965.86 00:20:18 INFO - PROCESS | 1689 | Values: 336.6 362.1 365.5 366.1 374.4 15435.2 16158.3 19359.6 20002.5 20791.5 16083.4 17166.7 20138.2 20179.7 20196.1 4907.5 5127.7 5164.8 5177.7 5183.7 3834.9 4041.7 5151.4 5200.6 5205.7 4028.8 4030.7 4528.4 5818.2 5828.4 5540.9 5781.5 5787.1 5794.6 5807.0 5498.4 5523.2 5531.7 5533.9 5547.7 13003.9 13427.7 19193.8 25056.6 25144.9 2043.3 2048.9 2079.3 2116.2 2171.6 9429.6 9511.9 9673.5 9911.8 10105.0 1665.4 1702.0 1769.0 1786.8 1800.5 81300.0 81963.0 94371.1 96525.0 104823.4 10906.2 10965.5 10985.3 11101.4 11146.2 11572.5 13440.7 13598.0 13598.5 13610.8 8305.8 8440.9 8450.1 8504.0 8504.2 6890.1 6947.5 8514.9 8519.4 8531.4 4422.0 4458.3 4474.5 4481.6 4513.9 1550.0 1816.6 1862.7 1865.1 1866.2 863.3 903.5 954.6 965.6 1030.8 15142.0 19568.6 20122.7 20190.5 20388.0 908.8 938.8 969.2 979.7 983.0 10723.2 11036.0 11063.7 11073.1 11090.5 451593.0 458726.0 601429.0 624362.0 631247.0 72954.0 109683.0 112892.0 115002.0 117078.0 966.2 988.5 999.8 1000.9 1002.9 13338.8 14474.6 17721.6 17756.5 18034.7 37941.6 50759.0 50776.0 52390.7 52637.7 68263.0 70515.0 70844.0 77060.6 77149.0 7888.1 8088.8 8207.7 8288.8 8412.2 6815.3 9550.7 11249.3 13119.8 13563.3 11281.1 11678.8 11879.8 11930.6 11941.0 11334.8 11371.2 11371.6 11654.4 11720.5 11720.6 11753.1 11794.5 11951.7 11954.8 8154.1 8176.1 8208.3 8231.1 8416.1 9836.2 11077.2 11766.7 11778.0 11890.8 00:20:18 INFO - PROCESS | 1689 | 00:20:18 INFO - PROCESS | 1689 | [#3] mootools.html Cycles:180 Average:6047.58 Median:5429.17 stddev:3156.24 (58.1%) stddev-sans-first:3146.78 00:20:18 INFO - PROCESS | 1689 | Values: 1525.1 1540.9 1783.7 1904.8 1943.0 7859.6 8012.9 8594.0 8765.6 8785.8 8310.3 8380.2 8525.9 8530.4 8536.7 2455.5 2490.1 2491.8 2492.5 2496.3 2189.9 2254.5 2419.0 2420.6 2478.7 2443.6 2444.3 2463.6 2478.8 2479.2 2444.0 2468.1 2470.1 2472.8 2477.7 2472.4 2497.4 2497.9 2499.9 2501.6 8709.6 8716.0 8717.3 8724.2 8758.2 5314.8 5402.4 5418.7 5460.7 5469.4 3617.7 3644.5 3726.9 3739.8 3753.8 1064.3 1075.2 1097.3 1103.3 1105.1 11863.2 11885.5 11902.9 11903.6 11912.5 4860.6 4904.3 4921.3 4982.2 5022.3 9915.1 9915.7 9972.3 10011.2 10011.5 5439.6 5439.7 5449.3 5450.6 5458.9 4954.5 4961.2 4964.2 4966.3 4968.0 3330.8 3687.2 3929.2 4051.1 4051.3 1066.8 1106.9 1309.0 1320.2 1329.7 1310.0 1317.8 1334.3 1339.1 1363.1 8013.9 8044.7 8049.9 8086.6 8116.5 1162.9 1168.3 1200.6 1205.9 1211.3 6200.2 6286.5 6298.6 6315.9 6331.1 9800.0 10008.3 11076.8 11081.7 11086.3 10426.8 10825.0 10923.2 10929.4 10948.6 7002.7 8239.8 8443.3 8469.1 8470.7 7750.0 7883.8 7895.3 7898.7 8215.0 9584.0 9603.1 9645.0 9696.6 9847.6 9414.5 9713.8 9923.8 10152.4 10155.6 7395.7 7435.3 7501.7 7523.0 7541.0 7298.5 7502.5 8096.8 8134.6 8139.4 6525.2 7364.6 7400.5 7409.0 7538.5 7264.9 7401.1 7463.4 7512.6 7581.6 7528.5 7665.7 7687.2 7742.8 7821.0 6941.9 6958.0 7004.3 7018.2 7020.6 7052.9 7100.5 7114.8 7134.0 7139.8 00:20:18 INFO - PROCESS | 1689 | 00:20:18 INFO - PROCESS | 1689 | [#4] prototype.html Cycles:180 Average:5736.46 Median:6577.51 stddev:1830.75 (27.8%) stddev-sans-first:1790.23 00:20:18 INFO - PROCESS | 1689 | Values: 323.2 328.1 330.7 334.4 337.2 5313.8 6583.3 6589.5 6667.7 6683.9 6575.2 6579.8 6592.3 6603.2 6603.6 4888.0 4895.8 4904.8 4910.7 4921.8 4912.6 4913.9 4920.7 4921.6 4924.4 4429.7 4618.3 4799.0 4863.2 4867.0 4759.1 4777.0 4794.8 4799.6 4824.8 3373.3 4100.3 4105.7 4120.2 4133.5 6020.9 6182.7 6232.0 6338.5 6357.3 5630.9 5638.5 5648.2 5648.4 5653.3 5585.8 6994.2 7019.9 7020.5 7030.6 4599.9 4611.7 4613.2 4619.7 4622.3 5295.5 7355.9 7370.6 7399.0 7422.0 4683.0 4736.0 4737.7 4740.0 4743.3 4799.8 4808.8 4825.6 4832.8 4843.5 5698.1 5709.7 5712.5 5718.5 5720.8 7031.2 7036.0 7051.6 7052.5 7056.9 1376.8 1587.8 1646.3 1649.6 1668.6 1086.3 1097.5 1104.5 1106.1 1110.9 5425.5 6599.0 6629.8 6638.6 6650.4 6996.5 7184.3 7236.5 7264.3 7275.3 6552.4 6658.7 6672.9 6677.8 6686.8 3841.8 3891.8 3892.0 3894.1 3897.4 7732.1 7738.8 7742.7 7743.2 7747.0 7274.7 7560.0 7566.2 7568.2 7622.6 7685.2 7707.3 7717.1 7730.7 7731.1 5369.4 6842.0 7308.3 7331.2 7333.3 7182.4 7199.2 7203.1 7203.2 7220.6 7411.0 7552.1 7697.7 7769.0 7775.2 4729.2 4763.3 4767.4 4773.5 4781.2 5212.8 5856.9 7279.9 7289.2 7304.2 6273.8 6489.5 7033.6 7056.0 7095.4 6744.4 6959.4 7022.4 7026.1 7039.6 6875.8 6899.6 6900.6 6903.3 6922.3 7045.1 7046.5 7052.7 7057.8 7096.7 6913.9 6915.7 6928.6 6931.2 6935.3 00:20:18 INFO - PROCESS | 1689 | 00:20:18 INFO - PROCESS | 1689 | [#5] yui.html Cycles:180 Average:17084.13 Median:631.54 stddev:23417.29 (3708.0%) stddev-sans-first:23450.60 00:20:18 INFO - PROCESS | 1689 | Values: 682.7 742.6 746.7 761.8 792.9 13995.7 17016.7 17305.2 17369.5 17382.4 15641.0 15679.9 15743.7 15760.9 15784.0 705.5 710.7 866.9 871.8 873.1 855.8 871.5 872.6 875.9 876.9 899.2 926.7 927.6 928.4 928.5 736.7 902.5 911.2 917.1 918.9 668.5 671.7 674.5 677.0 677.5 15038.5 15051.2 15076.7 15079.5 15098.4 12074.9 12200.5 12361.1 12418.7 12427.7 10150.8 10159.6 10201.4 10269.0 10897.6 3440.7 3489.8 3506.6 3508.9 3680.3 77830.6 78952.6 79463.6 79659.8 80044.6 7769.4 9211.7 9231.6 9349.3 9409.7 20264.4 20482.5 20485.6 20494.8 20510.2 7390.7 7398.3 7402.0 7448.4 7570.8 4174.9 4180.0 4192.1 4236.1 4265.0 3473.3 3503.2 3518.9 3523.7 3536.1 630.6 632.5 636.1 638.5 645.8 511.2 549.2 581.4 590.6 636.8 8381.0 8521.2 8536.6 8584.0 8654.6 507.8 533.0 594.4 610.3 613.9 3772.6 3850.1 3921.3 4041.9 4090.9 75382.6 77709.2 87022.1 87343.1 87360.1 73551.0 74277.5 74406.0 74983.0 75567.6 27694.4 27839.6 42801.6 66413.3 66875.0 7497.9 7671.6 7758.3 7830.6 7890.5 47224.5 47362.8 47496.8 47961.0 49167.0 59520.7 64441.7 64522.7 64976.7 65599.3 9787.7 9800.9 9842.9 9941.4 10503.7 11867.1 11999.6 12115.4 12420.9 12786.9 8284.7 10232.5 11845.3 12027.6 12084.6 11314.2 11577.3 11666.8 11692.9 12386.0 10934.3 10965.3 11091.9 11196.9 11321.9 9632.5 9838.9 9947.0 10060.5 10172.3 9181.1 9188.0 9367.9 9688.3 9705.5 00:20:18 INFO - PROCESS | 1689 | -------- Summary: end -------- 00:20:18 INFO - PROCESS | 1689 | 00:20:18 INFO - TEST-INFO | 1689: exit 0 00:20:18 INFO - TEST-OK | dromaeo_css | took 1113941ms 00:20:18 INFO - TEST-START | kraken 00:20:18 INFO - operating with platform_type : mac_ 00:20:18 INFO - Initialising browser for kraken test... 00:20:18 INFO - TEST-INFO | started process 1694 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/tmpdP0EAQ/profile http://localhost:49279/getInfo.html) 00:20:20 INFO - PROCESS | 1694 | __metrics Screen width/height:1600/1200 00:20:20 INFO - PROCESS | 1694 | colorDepth:24 00:20:20 INFO - PROCESS | 1694 | Browser inner width/height: 1024/689 00:20:20 INFO - PROCESS | 1694 | __metrics 00:20:21 INFO - PROCESS | 1694 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 00:20:21 INFO - PROCESS | 1694 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:20:21 INFO - TEST-INFO | 1694: exit 0 00:20:21 INFO - Browser initialized. 00:20:21 INFO - Running cycle 1/1 for kraken test... 00:20:21 INFO - TEST-INFO | started process 1696 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/tmpdP0EAQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:20:33 INFO - PROCESS | 1696 | RSS: Main: 242917376 00:20:33 INFO - PROCESS | 1696 | 00:20:36 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection) 00:20:37 INFO - PROCESS | 1696 | RSS: Main: 291520512 00:20:37 INFO - PROCESS | 1696 | 00:20:39 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-dft) 00:20:40 INFO - PROCESS | 1696 | RSS: Main: 303443968 00:20:40 INFO - PROCESS | 1696 | 00:20:43 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-fft) 00:20:44 INFO - PROCESS | 1696 | RSS: Main: 286105600 00:20:44 INFO - PROCESS | 1696 | 00:20:46 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator) 00:20:46 INFO - PROCESS | 1696 | RSS: Main: 286617600 00:20:46 INFO - PROCESS | 1696 | 00:20:48 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:20:49 INFO - PROCESS | 1696 | RSS: Main: 288083968 00:20:49 INFO - PROCESS | 1696 | 00:20:51 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom) 00:20:52 INFO - PROCESS | 1696 | RSS: Main: 289435648 00:20:52 INFO - PROCESS | 1696 | 00:20:55 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate) 00:20:55 INFO - PROCESS | 1696 | RSS: Main: 288731136 00:20:55 INFO - PROCESS | 1696 | 00:20:58 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial) 00:20:59 INFO - PROCESS | 1696 | RSS: Main: 290942976 00:20:59 INFO - PROCESS | 1696 | 00:21:00 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:21:01 INFO - PROCESS | 1696 | RSS: Main: 326189056 00:21:01 INFO - PROCESS | 1696 | 00:21:03 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:21:03 INFO - PROCESS | 1696 | RSS: Main: 324931584 00:21:03 INFO - PROCESS | 1696 | 00:21:05 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:21:06 INFO - PROCESS | 1696 | RSS: Main: 332783616 00:21:06 INFO - PROCESS | 1696 | 00:21:08 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:21:09 INFO - PROCESS | 1696 | RSS: Main: 333332480 00:21:09 INFO - PROCESS | 1696 | 00:21:12 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:21:12 INFO - PROCESS | 1696 | RSS: Main: 333361152 00:21:12 INFO - PROCESS | 1696 | 00:21:14 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49279/tests/kraken/driver.html?testName=ai-astar) 00:21:14 INFO - PROCESS | 1696 | RSS: Main: 394022912 00:21:14 INFO - PROCESS | 1696 | 00:21:14 INFO - PROCESS | 1696 | __start_tp_report 00:21:14 INFO - PROCESS | 1696 | _x_x_mozilla_page_load 00:21:14 INFO - PROCESS | 1696 | _x_x_mozilla_page_load_details 00:21:14 INFO - PROCESS | 1696 | |i|pagename|runs| 00:21:14 INFO - PROCESS | 1696 | |0;ai-astar;110;109;110;111;112;110;115;111;114;159 00:21:14 INFO - PROCESS | 1696 | |1;audio-beat-detection;158;122;143;159;121;141;140;119;158;130 00:21:14 INFO - PROCESS | 1696 | |2;audio-dft;184;183;182;186;185;182;183;182;179;181 00:21:14 INFO - PROCESS | 1696 | |3;audio-fft;78;74;83;79;55;57;58;79;79;73 00:21:14 INFO - PROCESS | 1696 | |4;audio-oscillator;97;103;123;79;78;80;112;78;78;111 00:21:14 INFO - PROCESS | 1696 | |5;imaging-gaussian-blur;85;91;84;91;84;90;88;91;72;83 00:21:14 INFO - PROCESS | 1696 | |6;imaging-darkroom;93;93;94;93;94;93;93;93;94;112 00:21:14 INFO - PROCESS | 1696 | |7;imaging-desaturate;86;85;86;85;86;87;86;86;85;85 00:21:14 INFO - PROCESS | 1696 | |8;json-parse-financial;56;55;53;53;56;54;55;64;53;52 00:21:14 INFO - PROCESS | 1696 | |9;json-stringify-tinderbox;63;70;79;73;70;67;67;67;67;67 00:21:14 INFO - PROCESS | 1696 | |10;stanford-crypto-aes;83;84;82;85;97;106;106;83;84;83 00:21:14 INFO - PROCESS | 1696 | |11;stanford-crypto-ccm;127;125;122;126;128;130;128;114;123;122 00:21:14 INFO - PROCESS | 1696 | |12;stanford-crypto-pbkdf2;140;127;141;139;141;127;140;138;137;137 00:21:14 INFO - PROCESS | 1696 | |13;stanford-crypto-sha256-iterative;67;67;67;67;66;65;67;67;67;64 00:21:14 INFO - PROCESS | 1696 | __end_tp_report 00:21:14 INFO - PROCESS | 1696 | __start_cc_report 00:21:14 INFO - PROCESS | 1696 | _x_x_mozilla_cycle_collect,1173 00:21:14 INFO - PROCESS | 1696 | __end_cc_report 00:21:14 INFO - PROCESS | 1696 | __startTimestamp1456042874553__endTimestamp 00:21:14 INFO - PROCESS | 1696 | 00:21:14 INFO - PROCESS | 1696 | ------- Summary: start ------- 00:21:14 INFO - PROCESS | 1696 | Number of tests: 14 00:21:14 INFO - PROCESS | 1696 | 00:21:14 INFO - PROCESS | 1696 | [#0] ai-astar Cycles:10 Average:116.10 Median:111.50 stddev:15.19 (13.6%) stddev-sans-first:15.95 00:21:14 INFO - PROCESS | 1696 | Values: 110.0 109.0 110.0 111.0 112.0 110.0 115.0 111.0 114.0 159.0 00:21:14 INFO - PROCESS | 1696 | 00:21:14 INFO - PROCESS | 1696 | [#1] audio-beat-detection Cycles:10 Average:139.10 Median:142.00 stddev:15.77 (11.1%) stddev-sans-first:15.17 00:21:14 INFO - PROCESS | 1696 | Values: 158.0 122.0 143.0 159.0 121.0 141.0 140.0 119.0 158.0 130.0 00:21:14 INFO - PROCESS | 1696 | 00:21:14 INFO - PROCESS | 1696 | [#2] audio-dft Cycles:10 Average:182.70 Median:183.00 stddev:2.00 (1.1%) stddev-sans-first:2.07 00:21:14 INFO - PROCESS | 1696 | Values: 184.0 183.0 182.0 186.0 185.0 182.0 183.0 182.0 179.0 181.0 00:21:14 INFO - PROCESS | 1696 | 00:21:14 INFO - PROCESS | 1696 | [#3] audio-fft Cycles:10 Average:71.50 Median:78.50 stddev:10.63 (13.5%) stddev-sans-first:11.01 00:21:14 INFO - PROCESS | 1696 | Values: 78.0 74.0 83.0 79.0 55.0 57.0 58.0 79.0 79.0 73.0 00:21:14 INFO - PROCESS | 1696 | 00:21:14 INFO - PROCESS | 1696 | [#4] audio-oscillator Cycles:10 Average:93.90 Median:78.00 stddev:17.43 (22.3%) stddev-sans-first:18.45 00:21:14 INFO - PROCESS | 1696 | Values: 97.0 103.0 123.0 79.0 78.0 80.0 112.0 78.0 78.0 111.0 00:21:14 INFO - PROCESS | 1696 | 00:21:14 INFO - PROCESS | 1696 | [#5] imaging-gaussian-blur Cycles:10 Average:85.90 Median:89.00 stddev:5.86 (6.6%) stddev-sans-first:6.20 00:21:14 INFO - PROCESS | 1696 | Values: 85.0 91.0 84.0 91.0 84.0 90.0 88.0 91.0 72.0 83.0 00:21:14 INFO - PROCESS | 1696 | 00:21:14 INFO - PROCESS | 1696 | [#6] imaging-darkroom Cycles:10 Average:95.20 Median:93.00 stddev:5.92 (6.4%) stddev-sans-first:6.23 00:21:14 INFO - PROCESS | 1696 | Values: 93.0 93.0 94.0 93.0 94.0 93.0 93.0 93.0 94.0 112.0 00:21:14 INFO - PROCESS | 1696 | 00:21:14 INFO - PROCESS | 1696 | [#7] imaging-desaturate Cycles:10 Average:85.70 Median:86.00 stddev:0.67 (0.8%) stddev-sans-first:0.71 00:21:14 INFO - PROCESS | 1696 | Values: 86.0 85.0 86.0 85.0 86.0 87.0 86.0 86.0 85.0 85.0 00:21:14 INFO - PROCESS | 1696 | 00:21:14 INFO - PROCESS | 1696 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:55.00 stddev:3.41 (6.2%) stddev-sans-first:3.61 00:21:14 INFO - PROCESS | 1696 | Values: 56.0 55.0 53.0 53.0 56.0 54.0 55.0 64.0 53.0 52.0 00:21:14 INFO - PROCESS | 1696 | 00:21:14 INFO - PROCESS | 1696 | [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:68.50 stddev:4.40 (6.4%) stddev-sans-first:4.09 00:21:14 INFO - PROCESS | 1696 | Values: 63.0 70.0 79.0 73.0 70.0 67.0 67.0 67.0 67.0 67.0 00:21:14 INFO - PROCESS | 1696 | 00:21:14 INFO - PROCESS | 1696 | [#10] stanford-crypto-aes Cycles:10 Average:89.30 Median:83.50 stddev:9.80 (11.7%) stddev-sans-first:10.12 00:21:14 INFO - PROCESS | 1696 | Values: 83.0 84.0 82.0 85.0 97.0 106.0 106.0 83.0 84.0 83.0 00:21:14 INFO - PROCESS | 1696 | 00:21:14 INFO - PROCESS | 1696 | [#11] stanford-crypto-ccm Cycles:10 Average:124.50 Median:126.50 stddev:4.58 (3.6%) stddev-sans-first:4.76 00:21:14 INFO - PROCESS | 1696 | Values: 127.0 125.0 122.0 126.0 128.0 130.0 128.0 114.0 123.0 122.0 00:21:14 INFO - PROCESS | 1696 | 00:21:14 INFO - PROCESS | 1696 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.70 Median:139.50 stddev:5.31 (3.8%) stddev-sans-first:5.50 00:21:14 INFO - PROCESS | 1696 | Values: 140.0 127.0 141.0 139.0 141.0 127.0 140.0 138.0 137.0 137.0 00:21:14 INFO - PROCESS | 1696 | 00:21:14 INFO - PROCESS | 1696 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:67.00 stddev:1.07 (1.6%) stddev-sans-first:1.12 00:21:14 INFO - PROCESS | 1696 | Values: 67.0 67.0 67.0 67.0 66.0 65.0 67.0 67.0 67.0 64.0 00:21:14 INFO - PROCESS | 1696 | -------- Summary: end -------- 00:21:14 INFO - PROCESS | 1696 | 00:21:15 INFO - TEST-INFO | 1696: exit 0 00:21:15 INFO - TEST-OK | kraken | took 56548ms 00:21:15 INFO - SUITE-END | took 1170s 00:21:15 INFO - Completed test suite (00:19:30) 00:21:15 INFO - Working with test: dromaeo_css 00:21:15 INFO - Generating results file: dromaeo_css 00:21:15 INFO - Working with test: kraken 00:21:15 INFO - Generating results file: kraken 00:21:15 INFO - javascript benchmark 00:21:15 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:21:16 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 00:21:16 INFO - process_Request line: dromaeo_css 7444.06 graph.html#tests=[[72,64,59]] 00:21:16 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:21:16 INFO - process_Request line: kraken 1411.10 graph.html#tests=[[232,64,59]] 00:21:16 INFO - RETURN: dromaeo_css: 7444.06 00:21:16 INFO - RETURN: kraken: 1411.10 00:21:16 INFO - javascript benchmark 00:21:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2877.194385572038, 3395.609504906936, 3496.3182179475007, 3509.438489841626, 3556.2354093869812, 5495.670259784416, 5622.83131506055, 5626.324841019078, 5633.6338138021, 5648.74580643871, 5618.859528511789, 5663.801766938148, 5679.261695979517, 5775.36470988192, 5786.826395208151, 5067.569256613192, 5092.77082531286, 5114.718690472023, 5123.257127716479, 5248.658837175591, 5212.739363031852, 5222.0, 5251.973740131294, 5278.604104692145, 5314.681119132845, 4164.68764842635, 5094.261332106842, 5202.557782588466, 5227.45111763267, 5239.21411788231, 5140.357455318085, 5146.665466744687, 5172.612054095958, 5175.275461435402, 5178.792848286064, 4167.83328666853, 5140.511651393112, 5161.845144645629, 5174.197999310075, 5208.0, 4988.800447982077, 5491.2312276281355, 5516.227728118067, 5606.55147588192, 5637.0, 5899.528037756969, 6199.163112979735, 6214.161088253073, 6222.191115155046, 6229.439350458435, 6200.410960958701, 6216.595921265149, 6238.750449982041, 6239.500839932794, 6258.687065646745, 5605.7197140142825, 5671.886562268773, 5714.714264286769, 5721.656700597978, 5766.481016708516, 5996.550258730613, 6266.154069200599, 6277.8744425111245, 6290.056491526216, 6324.08300796382, 5950.672713000827, 6057.878842423127, 6095.664738439428, 6127.938720612737, 6137.294211165684, 6100.755969761249, 6100.883963092903, 6149.877002460015, 6232.906506402408, 6258.342873998165, 6154.446099851035, 6159.84600384985, 6163.568550201443, 6164.137020817089, 6168.444839964424, 6077.878442431127, 6160.722767475474, 6171.783987560414, 6178.104174894615, 6194.132821405007, 4788.162071637449, 4865.294532292868, 4873.463918968911, 4884.902301953941, 4885.462599114095, 4277.828886844553, 4387.319965405367, 4447.599716025573, 4454.57681520255, 4455.532169122261, 5762.538996880239, 5776.104703770922, 5782.537397008229, 5800.0429929062075, 5840.0, 6249.375062493714, 6251.874962500725, 6253.0, 6256.562040657111, 6260.217472815898, 5639.661620302795, 5698.202251684767, 5754.6547207167705, 5782.190493330937, 5789.797357092566, 5328.733563321818, 5333.6533125347505, 5377.5429088527135, 5397.27136836522, 5428.5114339708825, 6300.21247344082, 6310.842228944313, 6315.242170939517, 6322.71547780351, 6341.048842673636, 6024.608400453956, 6130.233720784902, 6188.938110618837, 6250.406211409909, 6258.468030217483, 6248.593841400295, 6287.528435367274, 6321.936780632135, 6335.144755458138, 6360.809175724736, 6113.755449782137, 6119.602225855483, 6120.8775824484155, 6127.816165515042, 6137.7851775187655, 6121.540884433596, 6203.472704820141, 6214.2853571838, 6247.094171345038, 6256.7810126645345, 5955.315138758925, 5970.492508136857, 6010.429009244115, 6043.939560604338, 6067.757289708539, 5911.527077833849, 5964.850878728066, 5991.3409524953095, 6002.7298771554515, 6010.0, 4944.851654450372, 5535.059039963136, 5855.2973643163095, 5880.323762767165, 5883.323417807007, 4644.512326205835, 6009.729562169626, 6043.667598282137, 6068.089786532056, 6103.7253323601435, 5819.185314056121, 5855.443732845373, 5865.706714664335, 5870.148828419769, 5898.8230353089475], "unit": "score", "name": "dojo.html", "value": 5633.6842582423515}, {"lowerIsBetter": false, "replicates": [460.14413191463893, 513.0252520211598, 574.7040274258758, 582.1878479521068, 616.5776443136452, 36954.630453695456, 37317.626823731756, 37341.0, 37414.43878341827, 37427.43858842116, 40046.799766001204, 40456.39315410271, 40561.59438405615, 40566.0, 40630.187396252055, 9545.04549545047, 9766.316357854954, 9768.023197680246, 9777.706668799947, 9789.412635241873, 9589.136977672008, 9730.367526110815, 9740.074692904163, 9836.606535738561, 9854.113129818315, 9779.364341317827, 9865.60537578496, 9880.110790028895, 9881.604735810559, 9909.851352229687, 9806.460644664541, 9863.950680246553, 9876.90123098767, 9887.110160085627, 9920.0, 9638.180754635865, 9782.804343913082, 9791.265655075898, 9803.019698030212, 9822.361546499455, 39065.41401878974, 39553.40669889954, 39559.40660890089, 39569.20861582752, 39574.406383904265, 3179.284660951291, 3333.1333853198103, 3454.3264063507627, 3644.344018076745, 3794.6015668354976, 28575.14274571766, 29057.56413653797, 29512.70487295121, 29890.70109298901, 29995.400091998257, 2791.260316016257, 2800.8739606717745, 2831.065748303055, 2897.826130432181, 2960.5115155999233, 506780.0, 508508.3723744147, 508828.0, 509618.0, 509630.0, 44263.55736442659, 44349.77825110854, 44448.55551444509, 44627.55372446234, 62707.0, 44729.0, 45254.86862828456, 45632.543674563494, 45652.0, 45705.0, 15717.21413929299, 15903.840961590467, 15926.61100834884, 15938.203089845461, 15941.840581594268, 12728.554500592434, 12811.871881281255, 12814.167079139826, 12816.166949148275, 12943.676408089874, 14340.856591434162, 14422.855771442151, 14451.91610629207, 14495.420183192766, 14507.492237771627, 6236.18929539157, 6260.40526150015, 6275.466585340298, 6313.747450101944, 6323.620582765049, 979.2851218610311, 991.4249735153594, 1008.5007921079113, 1072.6942821295893, 1131.4173200801595, 27825.721742782313, 27881.16356509308, 28487.430251394857, 28555.857765689554, 28593.28516787097, 964.4261664309724, 1058.9894101059044, 1073.1682945716975, 1124.3254047571554, 1162.128403697227, 15921.761173582405, 15951.361945522049, 16039.518814435585, 16135.83864161367, 16163.515094547183, 656908.0, 665245.0, 672912.0, 674168.0, 674749.0, 51488.712782179995, 59362.0, 59742.40257597456, 59939.501512462535, 59991.10013349803, 1419.2194293138732, 1429.3925081840177, 1439.2803598200899, 1444.104655113836, 1553.852384023516, 28821.84712611472, 32735.0, 32782.0, 33900.0, 33910.491342629386, 55968.0, 56656.43343566677, 57394.7130264346, 57425.0, 57562.712186440476, 498992.0, 503297.0, 503775.0, 504270.0, 504430.0, 37804.81097594494, 45398.0, 46048.769756152346, 46944.29583556181, 47548.0, 36077.639223607424, 45321.77339113283, 45832.0, 46100.538994609626, 46110.0, 34796.82601586976, 35165.120871978404, 35928.82035589805, 36680.81659591792, 37891.431628525046, 37239.0, 37471.62528374681, 37528.114597599066, 37783.43324850075, 38964.610353896096, 38572.03569910662, 39261.80369098136, 39582.80208598939, 39649.603503964594, 39678.60321396749, 31175.532367014966, 32531.349373011933, 33240.83379583087, 35056.82471587626, 35057.82471087628, 24634.13780517673, 25012.0, 25621.743782561934, 25696.486070278865, 25935.740642594086], "unit": "score", "name": "ext.html", "value": 19732.996270647815}, {"lowerIsBetter": false, "replicates": [336.5826375294634, 362.06406439354265, 365.5467220646398, 366.0774847384591, 374.3916136278547, 15435.228238588083, 16158.272877720501, 19359.612807743837, 20002.49993750157, 20791.480212994684, 16083.437079702213, 17166.742498862528, 20138.194472221094, 20179.69730454041, 20196.091175897083, 4907.50924907509, 5127.692338459686, 5164.819231326905, 5177.715225662587, 5183.688978661274, 3834.926220658206, 4041.717079804415, 5151.4333423323405, 5200.557952574036, 5205.6616319939085, 4028.8187031583648, 4030.717849750519, 4528.366028755977, 5818.243628328311, 5828.417158284159, 5540.86147846303, 5781.508571771405, 5787.13193021046, 5794.565407594426, 5807.04183809673, 5498.395176530578, 5523.171524271352, 5531.723413829292, 5533.889322213573, 5547.72261386929, 13003.869961300361, 13427.731445371135, 19193.80806191948, 25056.624150637756, 25144.87427562869, 2043.3052762060822, 2048.9180432782673, 2079.2930403662826, 2116.164115174513, 2171.5873983943, 9429.575669094907, 9511.857322140173, 9673.516324183762, 9911.801763964753, 10105.0, 1665.383807991039, 1701.9914900425542, 1768.9911550442293, 1786.8213178682158, 1800.5048611631776, 81300.0, 81963.0, 94371.0562894369, 96525.0, 104823.42764858533, 10906.182036347305, 10965.451727413598, 10985.340879547253, 11101.44492775358, 11146.219764616399, 11572.47923843429, 13440.663983400298, 13598.04813663054, 13598.456061757617, 13610.795838062437, 8305.792355191168, 8440.915590844135, 8450.112738162527, 8504.0, 8504.23461888433, 6890.138732658418, 6947.478939079489, 8514.914850851535, 8519.361047921308, 8531.445456045338, 4422.0, 4458.331250312479, 4474.485434175046, 4481.641468682497, 4513.887152821206, 1550.0, 1816.637521858606, 1862.7485289486017, 1865.1047497201419, 1866.16955454824, 863.3450896627068, 903.5482258870564, 954.5895265036102, 965.6234068713208, 1030.8247597908223, 15142.0, 19568.608627827365, 20122.69815952762, 20190.495237619176, 20388.0, 908.7818923458454, 938.8452203789241, 969.1665167955553, 979.6913972098766, 982.9557669904872, 10723.195760318007, 11035.95158459945, 11063.668089957315, 11073.05879000294, 11090.500927458284, 451593.0, 458726.0, 601429.0, 624362.0, 631247.0, 72953.99999999894, 109683.0, 112892.0, 115002.0, 117078.0, 966.2028826218258, 988.5452691761726, 999.7800483893532, 1000.9349392289623, 1002.9297949143636, 13338.799918001043, 14474.565763027125, 17721.645567088843, 17756.46730598084, 18034.729479058085, 37941.62058379381, 50759.0, 50776.0, 52390.738046309525, 52637.7368113157, 68262.9760553602, 70515.0, 70844.0, 77060.61469692616, 77149.0, 7888.132305446282, 8088.757337279891, 8207.671693132208, 8288.792780180544, 8412.242898139197, 6815.250322464624, 9550.713478595653, 11249.325040497597, 13119.8192162702, 13563.254021028939, 11281.09751219884, 11678.766424671629, 11879.821802672794, 11930.582429614922, 11941.0, 11334.773304533699, 11371.20401571882, 11371.601993930173, 11654.359010254517, 11720.531178752753, 11720.589779357682, 11753.09180924791, 11794.469248883992, 11951.701207469883, 11954.76090478203, 8154.14381489935, 8176.100628930932, 8208.261256486945, 8231.09457959636, 8416.074231834617, 9836.163926066365, 11077.224594278323, 11766.705832354259, 11777.998870096138, 11890.821637675268], "unit": "score", "name": "jquery.html", "value": 8951.909707917433}, {"lowerIsBetter": false, "replicates": [1525.1306755149565, 1540.9306581203846, 1783.6789377911978, 1904.8476121910248, 1943.0090653766574, 7859.646315915783, 8012.879806802903, 8594.011688655806, 8765.641325594535, 8785.780355491115, 8310.293625041879, 8380.161983801618, 8525.91474085259, 8530.402871798977, 8536.743897683064, 2455.459798844256, 2490.066225165563, 2491.7632824881607, 2492.4890397468475, 2496.251124662603, 2189.868607883524, 2254.5040091179912, 2419.0323870451784, 2420.5884999550117, 2478.7397323281066, 2443.609022556391, 2444.291155564893, 2463.5688754467988, 2478.8016958643357, 2479.1570865905587, 2443.9755602443925, 2468.1114798672465, 2470.1354525915967, 2472.814538909571, 2477.7398373170736, 2472.3571871313407, 2497.425592113806, 2497.887595058227, 2499.9250022499355, 2501.6372625969316, 8709.56452177395, 8716.041235464094, 8717.30261579072, 8724.171203735636, 8758.167974042519, 5314.760835762361, 5402.405735369106, 5418.729063546807, 5460.672359658433, 5469.425710300441, 3617.656322649344, 3644.4853051394452, 3726.850925962958, 3739.7569158004917, 3753.8498460061564, 1064.3401091323428, 1075.1828610256184, 1097.314178638351, 1103.3269705479652, 1105.1269497097283, 11863.169578129535, 11885.465154068088, 11902.940485297604, 11903.64289071338, 11912.523499060027, 4860.586850117709, 4904.288878112654, 4921.335619691367, 4982.177940639826, 5022.347094877642, 9915.058069483388, 9915.65295214664, 9972.252081093948, 10011.199104071657, 10011.549480273405, 5439.619226654176, 5439.673619582838, 5449.3188351456065, 5450.618456707993, 5458.8908221835345, 4954.47977962316, 4961.231009193581, 4964.205727083649, 4966.279889416014, 4967.975160124176, 3330.8001519908885, 3687.2072504411144, 3929.233799409145, 4051.108756073659, 4051.2707712612014, 1066.8293073108266, 1106.9280496767685, 1309.0443975897458, 1320.221069568959, 1329.7274058817918, 1310.0305773727373, 1317.841858976929, 1334.252818421687, 1339.0827283310964, 1363.0526783885302, 8013.919860801434, 8044.678212871537, 8049.879251811228, 8086.555239461768, 8116.472429292196, 1162.9127815413879, 1168.2756690851727, 1200.6038007457519, 1205.9035277177804, 1211.2974474804591, 6200.162977998003, 6286.528510361742, 6298.590591611531, 6315.905261421082, 6331.050342448578, 9799.951000244953, 10008.349457285252, 11076.778464430827, 11081.722956926142, 11086.334819910831, 10426.843597346045, 10825.0, 10923.235373523936, 10929.398883061349, 10948.576685030896, 7002.684879180449, 8239.752807415787, 8443.282321002784, 8469.11074337198, 8470.66117355299, 7750.0, 7883.84232315362, 7895.289423951872, 7898.68405263783, 8215.0, 9583.952080239555, 9603.135717785433, 9644.987276335884, 9696.612135514782, 9847.556859941464, 9414.482203478874, 9713.805723885624, 9923.801523969336, 10152.39085654863, 10155.593776249163, 7395.741149059757, 7435.256474352522, 7501.699932002659, 7523.0, 7540.981967434326, 7298.452616053711, 7502.549847009197, 8096.83806323882, 8134.63394147253, 8139.389545784208, 6525.1517302750335, 7364.5581265124265, 7400.48196626231, 7409.0, 7538.509996850187, 7264.854702906018, 7401.111866576045, 7463.402927765875, 7512.586807725627, 7581.583012934341, 7528.548287102572, 7665.731699390718, 7687.231276872268, 7742.845143097219, 7821.0, 6941.93058069433, 6958.0, 7004.264552221944, 7018.192907815666, 7020.613866237201, 7052.894206587008, 7100.502964792415, 7114.822129446805, 7134.001239826533, 7139.750108746169], "unit": "score", "name": "mootools.html", "value": 4955.759336904109}, {"lowerIsBetter": false, "replicates": [323.15978456014363, 328.0944592923532, 330.6924560159051, 334.3613697837131, 337.182332842856, 5313.777831098845, 6583.308752580976, 6589.5057870659775, 6667.699953502092, 6683.933160668398, 6575.243846957601, 6579.7697080602065, 6592.307807680197, 6603.174603174603, 6603.636799976, 4888.046830867973, 4895.800528870432, 4904.828331008415, 4910.656254062217, 4921.80312787488, 4912.606991440694, 4913.8771530711665, 4920.655554111214, 4921.557059864629, 4924.409070911478, 4429.712068715539, 4618.330342100394, 4798.992211635543, 4863.19757240055, 4866.975665121669, 4759.143354196243, 4777.044591081798, 4794.760261986921, 4799.592034677056, 4824.782884770176, 3373.291608762163, 4100.34394496879, 4105.6920730945, 4120.237756015117, 4133.545310015926, 6020.939790602081, 6182.69086545671, 6232.0, 6338.492920566344, 6357.268914074894, 5630.943690563083, 5638.4925356718095, 5648.152777083429, 5648.406917273668, 5653.293338332708, 5585.804496842591, 6994.230634630187, 7019.929800701979, 7020.508564400494, 7030.578165310047, 4599.862004139881, 4611.654125940534, 4613.21575332191, 4619.74591397473, 4622.283546050334, 5295.4704529547125, 7355.8896616550255, 7370.5946172961, 7399.0, 7422.0, 4683.016566521001, 4736.005438857878, 4737.6683632146105, 4739.990106282536, 4743.28850672395, 4799.784009719571, 4808.807647694123, 4825.638077144158, 4832.806687732451, 4843.467218605951, 5698.145278208219, 5709.74306156224, 5712.457316555004, 5718.542516598662, 5720.8283751487525, 7031.191412987572, 7036.0, 7051.612161331176, 7052.483716001085, 7056.894146587805, 1376.779715245556, 1587.777711120444, 1646.2756387189838, 1649.6370798424327, 1668.5911951571943, 1086.315621158665, 1097.533548241994, 1104.5471356743697, 1106.115107913666, 1110.900208793305, 5425.484578964992, 6598.997456157437, 6629.801105966829, 6638.601683898982, 6650.401463868275, 6996.475264355194, 7184.317489838457, 7236.457265705093, 7264.273572642799, 7275.308845659654, 6552.3775241352, 6658.700358483879, 6672.86654266912, 6677.833054173684, 6686.765963191362, 3841.8079096045085, 3891.766494010312, 3891.9805400972814, 3894.123822139996, 3897.4348719435525, 7732.110807257238, 7738.806529836686, 7742.729004484929, 7743.225677432211, 7746.961265193638, 7274.709011639475, 7560.0, 7566.167721550625, 7568.167501574822, 7622.58075805836, 7685.193054729285, 7707.267809558083, 7717.112532058773, 7730.652120654584, 7731.110922243902, 5369.436209198134, 6841.973703944448, 7308.342249197598, 7331.156916954618, 7333.266673332624, 7182.35358817688, 7199.208087110518, 7203.135623725187, 7203.171635262012, 7220.566765994057, 7410.96294518524, 7552.13150487679, 7697.692092316244, 7769.0, 7775.222477752406, 4729.243321068612, 4763.309320148628, 4767.427908650984, 4773.451053128934, 4781.187198176249, 5212.791488340424, 5856.94143058581, 7279.888832238592, 7289.1981881994, 7304.233055529093, 6273.839339722166, 6489.513286503437, 7033.613151276729, 7056.0, 7095.432365410651, 6744.393004629607, 6959.4432445405255, 7022.367986881205, 7026.1217347831525, 7039.577625342496, 6875.759348422781, 6899.551529150589, 6900.6204658744255, 6903.275156108536, 6922.307769223037, 7045.11936007999, 7046.541974771623, 7052.695251378512, 7057.788266352018, 7096.680649370687, 6913.89629155553, 6915.6887940043825, 6928.584284942919, 6931.1682598088555, 6935.271796461299], "unit": "score", "name": "prototype.html", "value": 5130.302993145775}, {"lowerIsBetter": false, "replicates": [682.7405585877367, 742.5804420502416, 746.7013194722114, 761.7638532055065, 792.8810678398244, 13995.650108747286, 17016.74474882876, 17305.22126504307, 17369.47891563255, 17382.391616293433, 15641.0, 15679.921600391983, 15743.685126297467, 15760.921195394036, 15784.0, 705.4814711187273, 710.6659869861157, 866.8569686001803, 871.7689812199773, 873.0789017586444, 855.8202777416719, 871.4684042733927, 872.5986046418654, 875.8817559629432, 876.9210771030606, 899.2356496977582, 926.6571368593629, 927.5779520318273, 928.3872644054925, 928.5032507608431, 736.6905899522213, 902.5487256371814, 911.1526280559077, 917.0508523677995, 918.9218916392115, 668.5420486966443, 671.6977360187935, 674.4604316546792, 676.9898451523231, 677.5257319876057, 15038.54884353471, 15051.247437628184, 15076.698466030617, 15079.472218472301, 15098.396064157421, 12074.879251207463, 12200.511979520808, 12361.07291953107, 12418.689532761662, 12427.689307767378, 10150.847737283946, 10159.593616255415, 10201.43892085935, 10269.0, 10897.564097436092, 3440.690337869604, 3489.7731647442833, 3506.6142724300307, 3508.912277193065, 3680.337539242962, 77830.6108469454, 78952.60523697345, 79463.60268198622, 79659.8051029235, 80044.59977700132, 7769.417293702882, 9211.723648290563, 9231.630734770533, 9349.345545811864, 9409.670661526814, 20264.392068237976, 20482.487937801674, 20485.59028819415, 20494.795052049587, 20510.179592816417, 7390.667419966115, 7398.260173982559, 7401.962990185122, 7448.366888814511, 7570.772876813704, 4174.853880114181, 4180.038591124058, 4192.140611174702, 4236.131593023423, 4265.0, 3473.3400653875683, 3503.211777350127, 3518.8592456301462, 3523.6652518010746, 3536.1159710072484, 630.609022406102, 632.4624069540945, 636.1475622665557, 638.4605008767584, 645.8127143128534, 511.2152845382395, 549.198170670817, 581.3895409819672, 590.5865893874305, 636.8471566823929, 8380.958095209486, 8521.181065147559, 8536.573171341408, 8584.0, 8654.610542525601, 507.8146476536038, 532.9546988505942, 594.378874076591, 610.334735138692, 613.923259592551, 3772.6227377262603, 3850.133719912997, 3921.313770090223, 4041.8585349512628, 4090.9181816363507, 75382.62308688421, 77709.22290777019, 87022.12977870267, 87343.12656873478, 87360.1263987352, 73551.0, 74277.51444971071, 74406.0, 74983.0, 75567.62216188994, 27694.446111077665, 27839.582406263922, 42801.571984279755, 66413.33586664168, 66875.0, 7497.9250207497225, 7671.578063206577, 7758.3017528422715, 7830.608469576612, 7890.48711833729, 47224.527754723385, 47362.763186183845, 47496.76251618858, 47961.0, 49167.01665966732, 59520.70239648774, 64441.67779161074, 64522.67738661465, 64976.675116624116, 65599.34400655932, 9787.657431989846, 9800.852987205055, 9842.901570984199, 9941.353812002197, 10503.689188378545, 11867.050635949276, 11999.580014699444, 12115.394230288273, 12420.875791241971, 12786.87213127894, 8284.668613255402, 10232.5397139801, 11845.348505831917, 12027.639170824888, 12084.637460876187, 11314.151438642299, 11577.305361678325, 11666.824997624874, 11692.88307116952, 12386.009119270257, 10934.343939363664, 10965.342079475256, 11091.944540277247, 11196.888031119584, 11321.943390282995, 9632.47021413829, 9838.852417213891, 9947.0, 10060.547275372479, 10172.338797978404, 9181.127792859668, 9187.954060229657, 9367.906320936703, 9688.273379496424, 9705.466199359103], "unit": "score", "name": "yui.html", "value": 6724.642443157826}], "name": "dromaeo_css", "value": 7444.056820082031}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 111.0, 112.0, 110.0, 115.0, 111.0, 114.0, 159.0], "unit": "score", "name": "ai-astar", "value": 116.1}, {"lowerIsBetter": true, "replicates": [158.0, 122.0, 143.0, 159.0, 121.0, 141.0, 140.0, 119.0, 158.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 139.1}, {"lowerIsBetter": true, "replicates": [184.0, 183.0, 182.0, 186.0, 185.0, 182.0, 183.0, 182.0, 179.0, 181.0], "unit": "score", "name": "audio-dft", "value": 182.7}, {"lowerIsBetter": true, "replicates": [78.0, 74.0, 83.0, 79.0, 55.0, 57.0, 58.0, 79.0, 79.0, 73.0], "unit": "score", "name": "audio-fft", "value": 71.5}, {"lowerIsBetter": true, "replicates": [97.0, 103.0, 123.0, 79.0, 78.0, 80.0, 112.0, 78.0, 78.0, 111.0], "unit": "score", "name": "audio-oscillator", "value": 93.9}, {"lowerIsBetter": true, "replicates": [85.0, 91.0, 84.0, 91.0, 84.0, 90.0, 88.0, 91.0, 72.0, 83.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 85.9}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 94.0, 93.0, 94.0, 93.0, 93.0, 93.0, 94.0, 112.0], "unit": "score", "name": "imaging-darkroom", "value": 95.2}, {"lowerIsBetter": true, "replicates": [86.0, 85.0, 86.0, 85.0, 86.0, 87.0, 86.0, 86.0, 85.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 85.7}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 53.0, 53.0, 56.0, 54.0, 55.0, 64.0, 53.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 55.1}, {"lowerIsBetter": true, "replicates": [63.0, 70.0, 79.0, 73.0, 70.0, 67.0, 67.0, 67.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.0}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 82.0, 85.0, 97.0, 106.0, 106.0, 83.0, 84.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 89.3}, {"lowerIsBetter": true, "replicates": [127.0, 125.0, 122.0, 126.0, 128.0, 130.0, 128.0, 114.0, 123.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.5}, {"lowerIsBetter": true, "replicates": [140.0, 127.0, 141.0, 139.0, 141.0, 127.0, 140.0, 138.0, 137.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.7}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 67.0, 66.0, 65.0, 67.0, 67.0, 67.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.4}], "name": "kraken", "value": 1411.1000000000001}]} 00:21:16 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1411.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7444.06"}}} 00:21:16 INFO - Return code: 0 00:21:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 00:21:16 INFO - # TBPL SUCCESS # 00:21:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:21:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:21:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:21:16 INFO - 2016-02-21 00:21:16.416 screenresolution[1700:12755] starting screenresolution argv=screenresolution get 00:21:16 INFO - 2016-02-21 00:21:16.419 screenresolution[1700:12755] Display 0: 1600x1200x32@60 00:21:16 INFO - 2016-02-21 00:21:16.424 screenresolution[1701:12758] starting screenresolution argv=screenresolution list 00:21:16 INFO - Available Modes on Display 0 00:21:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:21:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:21:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:21:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:21:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:21:16 INFO - Intel Iris: 00:21:16 INFO - Chipset Model: Intel Iris 00:21:16 INFO - Type: GPU 00:21:16 INFO - Bus: Built-In 00:21:16 INFO - VRAM (Dynamic, Max): 1536 MB 00:21:16 INFO - Vendor: Intel (0x8086) 00:21:16 INFO - Device ID: 0x0a2e 00:21:16 INFO - Revision ID: 0x0009 00:21:16 INFO - Displays: 00:21:16 INFO - Display: 00:21:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:21:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:21:16 INFO - Display Serial Number: 1600x1200 60 00:21:16 INFO - Main Display: Yes 00:21:16 INFO - Mirror: Off 00:21:16 INFO - Online: Yes 00:21:16 INFO - Rotation: Supported 00:21:16 INFO - Return code: 0 00:21:16 INFO - Running post-action listener: _resource_record_post_action 00:21:16 INFO - Running post-run listener: _resource_record_post_run 00:21:17 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 33848832; Write bytes: 708500992; Read time: 467; Write time: 2366 00:21:17 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 403634688; Write bytes: 397858816; Read time: 30229; Write time: 749 00:21:17 INFO - run-tests - Wall time: 1174s; CPU: 52.0%; Read bytes: 32067072; Write bytes: 301172224; Read time: 449; Write time: 1585 00:21:17 INFO - Running post-run listener: _upload_blobber_files 00:21:17 INFO - Blob upload gear active. 00:21:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:21:17 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 00:21:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:21:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:21:18 INFO - (blobuploader) - INFO - Open directory for files ... 00:21:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:21:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:21:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:21:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:21:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:21:19 INFO - (blobuploader) - INFO - Done attempting. 00:21:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:21:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:21:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:21:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:21:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:21:20 INFO - (blobuploader) - INFO - Done attempting. 00:21:20 INFO - (blobuploader) - INFO - Iteration through files over. 00:21:20 INFO - Return code: 0 00:21:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:21:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:21:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4409bced3f0cd724aa6d644731cc3758147be0e9ad9add248e9557c9f8e96ed4dad2445df157716caca8d6b60dec54cc27fb319ec54d260ed2eb50f21fc7ff5e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bedcea11a7490c1252c29bd83bb539750a6932231fca012bdeed3b70cf682649f364a90c5159f43206fa13ae99dc07d63939fb5b057f0eafbbe07f89f2d0cf3e"} 00:21:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:21:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:21:20 INFO - Contents: 00:21:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4409bced3f0cd724aa6d644731cc3758147be0e9ad9add248e9557c9f8e96ed4dad2445df157716caca8d6b60dec54cc27fb319ec54d260ed2eb50f21fc7ff5e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bedcea11a7490c1252c29bd83bb539750a6932231fca012bdeed3b70cf682649f364a90c5159f43206fa13ae99dc07d63939fb5b057f0eafbbe07f89f2d0cf3e"} 00:21:20 INFO - Running post-run listener: copy_logs_to_upload_dir 00:21:20 INFO - Copying logs to upload dir... 00:21:20 INFO - mkdir: /builds/slave/test/build/upload/logs 00:21:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.304874 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-02-21 00:21:20.524820) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-21 00:21:20.529190) ========= 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.4Y4Zftvke6/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.dy9D7OfwaM/Listeners TMPDIR=/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4409bced3f0cd724aa6d644731cc3758147be0e9ad9add248e9557c9f8e96ed4dad2445df157716caca8d6b60dec54cc27fb319ec54d260ed2eb50f21fc7ff5e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bedcea11a7490c1252c29bd83bb539750a6932231fca012bdeed3b70cf682649f364a90c5159f43206fa13ae99dc07d63939fb5b057f0eafbbe07f89f2d0cf3e"} build_url:https://queue.taskcluster.net/v1/task/W8731TS4RGyiuBWgRXoNYQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010992 build_url: 'https://queue.taskcluster.net/v1/task/W8731TS4RGyiuBWgRXoNYQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4409bced3f0cd724aa6d644731cc3758147be0e9ad9add248e9557c9f8e96ed4dad2445df157716caca8d6b60dec54cc27fb319ec54d260ed2eb50f21fc7ff5e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bedcea11a7490c1252c29bd83bb539750a6932231fca012bdeed3b70cf682649f364a90c5159f43206fa13ae99dc07d63939fb5b057f0eafbbe07f89f2d0cf3e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-21 00:21:20.556608) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-21 00:21:20.557007) ========= 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.4Y4Zftvke6/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.dy9D7OfwaM/Listeners TMPDIR=/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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.005096 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-21 00:21:20.606720) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-21 00:21:20.607018) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-21 00:21:20.607439) ========= ========= Total master_lag: 0.58 =========