builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0084 starttime: 1457500860.98 results: success (0) buildid: 20160308202514 builduid: 80c073a4e7ec463eb34bedb8851abc54 revision: 893ca601352abf582cb64e1cfbcec68dcc06871a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-08 21:21:00.984186) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-08 21:21:00.984872) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-08 21:21:00.985378) ========= 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.2fYdLJmjEG/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.erlyQd39C3/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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.005565 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-08 21:21:01.012957) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-08 21:21:01.013429) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-08 21:21:01.033103) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 21:21:01.033751) ========= 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.2fYdLJmjEG/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.erlyQd39C3/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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.005464 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 21:21:01.084934) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-08 21:21:01.085476) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-08 21:21:01.086104) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 21:21:01.086633) ========= 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.2fYdLJmjEG/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.erlyQd39C3/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-08 21:21:01-- 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% 193M=0s 2016-03-08 21:21:01 (193 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104373 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 21:21:01.209249) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 21:21:01.209678) ========= 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.2fYdLJmjEG/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.erlyQd39C3/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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.033331 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 21:21:01.259377) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 21:21:01.259742) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 893ca601352abf582cb64e1cfbcec68dcc06871a --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 893ca601352abf582cb64e1cfbcec68dcc06871a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2fYdLJmjEG/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.erlyQd39C3/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-08 21:21:01,339 truncating revision to first 12 chars 2016-03-08 21:21:01,339 Setting DEBUG logging. 2016-03-08 21:21:01,339 attempt 1/10 2016-03-08 21:21:01,339 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/893ca601352a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-08 21:21:02,034 unpacking tar archive at: fx-team-893ca601352a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.935182 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 21:21:02.213255) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-08 21:21:02.213853) ========= echo 893ca601352abf582cb64e1cfbcec68dcc06871a in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'893ca601352abf582cb64e1cfbcec68dcc06871a'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2fYdLJmjEG/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.erlyQd39C3/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 893ca601352abf582cb64e1cfbcec68dcc06871a program finished with exit code 0 elapsedTime=0.005571 script_repo_revision: '893ca601352abf582cb64e1cfbcec68dcc06871a' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-08 21:21:02.265128) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-08 21:21:02.265462) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-08 21:21:02.279667) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-03-08 21:21:02.280071) ========= /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.2fYdLJmjEG/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.erlyQd39C3/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 21:21:02 INFO - MultiFileLogger online at 20160308 21:21:02 in /builds/slave/test 21:21:02 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 21:21:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:21:02 INFO - {'append_to_log': False, 21:21:02 INFO - 'base_work_dir': '/builds/slave/test', 21:21:02 INFO - 'blob_upload_branch': 'Fx-Team', 21:21:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:21:02 INFO - 'branch': 'Fx-Team', 21:21:02 INFO - 'buildbot_json_path': 'buildprops.json', 21:21:02 INFO - 'config_files': ('talos/mac_config.py',), 21:21:02 INFO - 'default_actions': ('clobber', 21:21:02 INFO - 'read-buildbot-config', 21:21:02 INFO - 'download-and-extract', 21:21:02 INFO - 'populate-webroot', 21:21:02 INFO - 'create-virtualenv', 21:21:02 INFO - 'install', 21:21:02 INFO - 'run-tests'), 21:21:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:21:02 INFO - 'download_minidump_stackwalk': True, 21:21:02 INFO - 'download_symbols': 'ondemand', 21:21:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:21:02 INFO - 'tooltool.py': '/tools/tooltool.py', 21:21:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:21:02 INFO - '/tools/misc-python/virtualenv.py')}, 21:21:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:21:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:21:02 INFO - 'installer_path': 'installer.exe', 21:21:02 INFO - 'log_level': 'info', 21:21:02 INFO - 'log_name': 'talos', 21:21:02 INFO - 'log_to_console': True, 21:21:02 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:21:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:21:02 INFO - 'opt_config_files': (), 21:21:02 INFO - 'pip_index': False, 21:21:02 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:21:02 INFO - 'cmd': ('bash', 21:21:02 INFO - '-c', 21:21:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:21:02 INFO - 'enabled': True, 21:21:02 INFO - 'halt_on_failure': False, 21:21:02 INFO - 'name': 'check_screen_resolution'},), 21:21:02 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:21:02 INFO - 'cmd': ('bash', 21:21:02 INFO - '-c', 21:21:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:21:02 INFO - 'enabled': True, 21:21:02 INFO - 'halt_on_failure': False, 21:21:02 INFO - 'name': 'check_screen_resolution'},), 21:21:02 INFO - 'run_cmd_checks_enabled': True, 21:21:02 INFO - 'sps_profile': False, 21:21:02 INFO - 'sps_profile_interval': 0, 21:21:02 INFO - 'suite': 'dromaeojs', 21:21:02 INFO - 'system_bits': '32', 21:21:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:21:02 INFO - 'title': 't-yosemite-r7-0084', 21:21:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:21:02 INFO - 'use_talos_json': True, 21:21:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:21:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:21:02 INFO - 'work_dir': 'build'} 21:21:02 INFO - ##### 21:21:02 INFO - ##### Running clobber step. 21:21:02 INFO - ##### 21:21:02 INFO - Running pre-action listener: _resource_record_pre_action 21:21:02 INFO - Running main action method: clobber 21:21:02 INFO - rmtree: /builds/slave/test/build 21:21:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:21:04 INFO - Running post-action listener: _resource_record_post_action 21:21:04 INFO - ##### 21:21:04 INFO - ##### Running read-buildbot-config step. 21:21:04 INFO - ##### 21:21:04 INFO - Running pre-action listener: _resource_record_pre_action 21:21:04 INFO - Running main action method: read_buildbot_config 21:21:04 INFO - Using buildbot properties: 21:21:04 INFO - { 21:21:04 INFO - "project": "", 21:21:04 INFO - "product": "firefox", 21:21:04 INFO - "script_repo_revision": "production", 21:21:04 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 21:21:04 INFO - "repository": "", 21:21:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 21:21:04 INFO - "buildid": "20160308202514", 21:21:04 INFO - "pgo_build": "False", 21:21:04 INFO - "basedir": "/builds/slave/test", 21:21:04 INFO - "buildnumber": 513, 21:21:04 INFO - "slavename": "t-yosemite-r7-0084", 21:21:04 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 21:21:04 INFO - "platform": "yosemite_r7", 21:21:04 INFO - "scheduler": "tests-fx-team-macosx64-talos", 21:21:04 INFO - "branch": "fx-team", 21:21:04 INFO - "repo_path": "integration/fx-team", 21:21:04 INFO - "revision": "893ca601352abf582cb64e1cfbcec68dcc06871a", 21:21:04 INFO - "stage_platform": "macosx64", 21:21:04 INFO - "builduid": "80c073a4e7ec463eb34bedb8851abc54", 21:21:04 INFO - "slavebuilddir": "test" 21:21:04 INFO - } 21:21:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/MYQiA5a_TXS2JsozWhcFCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 21:21:04 INFO - Running post-action listener: _resource_record_post_action 21:21:04 INFO - ##### 21:21:04 INFO - ##### Running download-and-extract step. 21:21:04 INFO - ##### 21:21:04 INFO - Running pre-action listener: _resource_record_pre_action 21:21:04 INFO - Running main action method: download_and_extract 21:21:04 INFO - mkdir: /builds/slave/test/build/tests 21:21: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')]} 21:21:04 INFO - https://queue.taskcluster.net/v1/task/MYQiA5a_TXS2JsozWhcFCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 21:21:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYQiA5a_TXS2JsozWhcFCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 21:21:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYQiA5a_TXS2JsozWhcFCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 21:21:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYQiA5a_TXS2JsozWhcFCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 21:21:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYQiA5a_TXS2JsozWhcFCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 21:21:04 INFO - Downloaded 1199 bytes. 21:21:04 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 21:21:04 INFO - Using the following test package requirements: 21:21:04 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 21:21:04 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 21:21:04 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 21:21:04 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 21:21:04 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 21:21:04 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 21:21:04 INFO - u'jsshell-mac.zip'], 21:21:04 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 21:21:04 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 21:21:04 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 21:21:04 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 21:21:04 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 21:21:04 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 21:21:04 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 21:21:04 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 21:21:04 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 21:21:04 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 21:21:04 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 21:21:04 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 21:21: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')]} 21:21:04 INFO - https://queue.taskcluster.net/v1/task/MYQiA5a_TXS2JsozWhcFCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 21:21:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYQiA5a_TXS2JsozWhcFCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 21:21:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYQiA5a_TXS2JsozWhcFCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 21:21:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYQiA5a_TXS2JsozWhcFCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 21:21:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYQiA5a_TXS2JsozWhcFCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:21:05 INFO - Downloaded 17867237 bytes. 21:21:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:21:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 21:21:08 INFO - Return code: 0 21:21:08 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 21:21:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:21:08 INFO - https://queue.taskcluster.net/v1/task/MYQiA5a_TXS2JsozWhcFCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 21:21:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYQiA5a_TXS2JsozWhcFCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 21:21:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYQiA5a_TXS2JsozWhcFCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 21:21:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYQiA5a_TXS2JsozWhcFCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 21:21:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYQiA5a_TXS2JsozWhcFCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:21:09 INFO - Downloaded 17867237 bytes. 21:21:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:21:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 21:21:13 INFO - Return code: 0 21:21:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:21:13 INFO - https://queue.taskcluster.net/v1/task/MYQiA5a_TXS2JsozWhcFCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 21:21:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYQiA5a_TXS2JsozWhcFCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 21:21:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYQiA5a_TXS2JsozWhcFCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 21:21:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYQiA5a_TXS2JsozWhcFCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 21:21:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYQiA5a_TXS2JsozWhcFCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 21:21:14 INFO - Downloaded 10845161 bytes. 21:21:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:21:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 21:21:14 INFO - Return code: 0 21:21:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:21:14 INFO - https://queue.taskcluster.net/v1/task/MYQiA5a_TXS2JsozWhcFCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 21:21:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYQiA5a_TXS2JsozWhcFCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 21:21:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYQiA5a_TXS2JsozWhcFCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 21:21:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYQiA5a_TXS2JsozWhcFCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 21:21:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYQiA5a_TXS2JsozWhcFCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 21:21:18 INFO - Downloaded 110753450 bytes. 21:21:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MYQiA5a_TXS2JsozWhcFCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 21:21:18 INFO - mkdir: /builds/slave/test/properties 21:21:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:21:18 INFO - Writing to file /builds/slave/test/properties/build_url 21:21:18 INFO - Contents: 21:21:18 INFO - build_url:https://queue.taskcluster.net/v1/task/MYQiA5a_TXS2JsozWhcFCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 21:21:19 INFO - Running post-action listener: _resource_record_post_action 21:21:19 INFO - Running post-action listener: set_extra_try_arguments 21:21:19 INFO - ##### 21:21:19 INFO - ##### Running populate-webroot step. 21:21:19 INFO - ##### 21:21:19 INFO - Running pre-action listener: _resource_record_pre_action 21:21:19 INFO - Running main action method: populate_webroot 21:21:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:21:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:21:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:21:19 INFO - '--tppagecycles', 21:21:19 INFO - '7'], 21:21:19 INFO - 'tests': ['tsvgm']}}, 21:21:19 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:21:19 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:21:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:21:19 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 21:21:19 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:21:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:21:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:21:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:21:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:21:19 INFO - 'talos_options': ['--e10s'], 21:21:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:21:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:21:19 INFO - 'tests': ['damp', 'tps']}, 21:21:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:21:19 INFO - 'talos_options': ['--e10s'], 21:21:19 INFO - 'tests': ['damp', 'tps']}, 21:21:19 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:21:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:21:19 INFO - 'other': {'tests': ['a11yr', 21:21:19 INFO - 'ts_paint', 21:21:19 INFO - 'tpaint', 21:21:19 INFO - 'sessionrestore', 21:21:19 INFO - 'sessionrestore_no_auto_restore', 21:21:19 INFO - 'tabpaint']}, 21:21:19 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:21:19 INFO - 'tests': ['a11yr', 21:21:19 INFO - 'ts_paint', 21:21:19 INFO - 'tpaint', 21:21:19 INFO - 'sessionrestore', 21:21:19 INFO - 'sessionrestore_no_auto_restore', 21:21:19 INFO - 'tabpaint']}, 21:21:19 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:21:19 INFO - 'tests': ['a11yr', 21:21:19 INFO - 'ts_paint', 21:21:19 INFO - 'tpaint', 21:21:19 INFO - 'sessionrestore', 21:21:19 INFO - 'sessionrestore_no_auto_restore', 21:21:19 INFO - 'tabpaint']}, 21:21:19 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:21:19 INFO - 'tests': ['a11yr', 21:21:19 INFO - 'ts_paint', 21:21:19 INFO - 'tpaint', 21:21:19 INFO - 'sessionrestore', 21:21:19 INFO - 'sessionrestore_no_auto_restore', 21:21:19 INFO - 'tabpaint']}, 21:21:19 INFO - 'other_l64': {'tests': ['a11yr', 21:21:19 INFO - 'ts_paint', 21:21:19 INFO - 'tpaint', 21:21:19 INFO - 'sessionrestore', 21:21:19 INFO - 'sessionrestore_no_auto_restore', 21:21:19 INFO - 'tabpaint']}, 21:21:19 INFO - 'other_nol64': {'tests': ['a11yr', 21:21:19 INFO - 'ts_paint', 21:21:19 INFO - 'tpaint', 21:21:19 INFO - 'sessionrestore', 21:21:19 INFO - 'sessionrestore_no_auto_restore', 21:21:19 INFO - 'tabpaint']}, 21:21:19 INFO - 'svgr': {'tests': ['tsvgx', 21:21:19 INFO - 'tsvgr_opacity', 21:21:19 INFO - 'tart', 21:21:19 INFO - 'tscrollx', 21:21:19 INFO - 'cart']}, 21:21:19 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:21:19 INFO - 'tests': ['tsvgx', 21:21:19 INFO - 'tsvgr_opacity', 21:21:19 INFO - 'tart', 21:21:19 INFO - 'tscrollx', 21:21:19 INFO - 'cart']}, 21:21:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:21:19 INFO - 'tests': ['tp5o']}, 21:21:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:21:19 INFO - 'talos_options': ['--e10s'], 21:21:19 INFO - 'tests': ['tp5o']}, 21:21:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:21:19 INFO - 'talos_options': ['--xperf_path', 21:21:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:21:19 INFO - 'tests': ['tp5n']}, 21:21:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:21:19 INFO - 'talos_options': ['--e10s', 21:21:19 INFO - '--xperf_path', 21:21:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:21:19 INFO - 'tests': ['tp5n']}}, 21:21:19 INFO - 'talos.zip': {'path': '', 21:21:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:21:19 INFO - Running post-action listener: _resource_record_post_action 21:21:19 INFO - ##### 21:21:19 INFO - ##### Running create-virtualenv step. 21:21:19 INFO - ##### 21:21:19 INFO - Running pre-action listener: _resource_record_pre_action 21:21:19 INFO - Running main action method: create_virtualenv 21:21:19 INFO - Creating virtualenv /builds/slave/test/build/venv 21:21:19 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 21:21:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:21:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:21:19 INFO - Using real prefix '/tools/python27' 21:21:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:21:20 INFO - Installing distribute.............................................................................................................................................................................................done. 21:21:23 INFO - Installing pip.................done. 21:21:23 INFO - Return code: 0 21:21:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:21:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:21:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:21:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:21:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:21:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:23 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 0x10a4dba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4e34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9859da3640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a37fd30>, '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 0x10a1a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a376b20>, '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.2fYdLJmjEG/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.erlyQd39C3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 21:21:23 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 21:21:23 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 21:21:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2fYdLJmjEG/Render', 21:21:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:21:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:21:23 INFO - 'HOME': '/Users/cltbld', 21:21:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:21:23 INFO - 'LOGNAME': 'cltbld', 21:21:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:21:23 INFO - 'MOZ_NO_REMOTE': '1', 21:21:23 INFO - 'NO_EM_RESTART': '1', 21:21:23 INFO - 'PAGER': '/bin/cat', 21:21:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:21:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:21:23 INFO - 'PWD': '/builds/slave/test', 21:21:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:21:23 INFO - 'SHELL': '/bin/bash', 21:21:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.erlyQd39C3/Listeners', 21:21:23 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 21:21:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:21:23 INFO - 'USER': 'cltbld', 21:21:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:21:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:21:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:21:23 INFO - 'XPC_FLAGS': '0x0', 21:21:23 INFO - 'XPC_SERVICE_NAME': '0', 21:21:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:21:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:21:23 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 21:21:23 INFO - Cleaning up... 21:21:23 INFO - Return code: 0 21:21:23 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 21:21:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:21:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:21:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:21:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:21:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:23 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 0x10a4dba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4e34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9859da3640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a37fd30>, '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 0x10a1a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a376b20>, '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.2fYdLJmjEG/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.erlyQd39C3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 21:21:23 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 21:21:23 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 21:21:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2fYdLJmjEG/Render', 21:21:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:21:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:21:23 INFO - 'HOME': '/Users/cltbld', 21:21:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:21:23 INFO - 'LOGNAME': 'cltbld', 21:21:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:21:23 INFO - 'MOZ_NO_REMOTE': '1', 21:21:23 INFO - 'NO_EM_RESTART': '1', 21:21:23 INFO - 'PAGER': '/bin/cat', 21:21:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:21:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:21:23 INFO - 'PWD': '/builds/slave/test', 21:21:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:21:23 INFO - 'SHELL': '/bin/bash', 21:21:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.erlyQd39C3/Listeners', 21:21:23 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 21:21:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:21:23 INFO - 'USER': 'cltbld', 21:21:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:21:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:21:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:21:23 INFO - 'XPC_FLAGS': '0x0', 21:21:23 INFO - 'XPC_SERVICE_NAME': '0', 21:21:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:21:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:21:23 INFO - Downloading/unpacking psutil>=0.7.1 21:21:23 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 21:21:23 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 21:21:23 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 21:21:23 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 21:21:23 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 21:21:23 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 21:21:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:21:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:21:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:21:26 INFO - Installing collected packages: psutil 21:21:26 INFO - Running setup.py install for psutil 21:21:27 INFO - building 'psutil._psutil_osx' extension 21:21:27 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 21:21:27 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 21:21:27 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 21:21:27 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 21:21:27 INFO - building 'psutil._psutil_posix' extension 21:21:27 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 21:21:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:21:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:21:27 INFO - ^ 21:21:27 INFO - 1 warning generated. 21:21:27 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 21:21:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:21:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:21:28 INFO - Successfully installed psutil 21:21:28 INFO - Cleaning up... 21:21:28 INFO - Return code: 0 21:21:28 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 21:21: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')]} 21:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:21:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21: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')]} 21:21:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:21:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a4dba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4e34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9859da3640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a37fd30>, '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 0x10a1a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a376b20>, '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.2fYdLJmjEG/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.erlyQd39C3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 21:21:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 21:21:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 21:21:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2fYdLJmjEG/Render', 21:21:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:21:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:21:28 INFO - 'HOME': '/Users/cltbld', 21:21:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:21:28 INFO - 'LOGNAME': 'cltbld', 21:21:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:21:28 INFO - 'MOZ_NO_REMOTE': '1', 21:21:28 INFO - 'NO_EM_RESTART': '1', 21:21:28 INFO - 'PAGER': '/bin/cat', 21:21:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:21:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:21:28 INFO - 'PWD': '/builds/slave/test', 21:21:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:21:28 INFO - 'SHELL': '/bin/bash', 21:21:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.erlyQd39C3/Listeners', 21:21:28 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 21:21:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:21:28 INFO - 'USER': 'cltbld', 21:21:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:21:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:21:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:21:28 INFO - 'XPC_FLAGS': '0x0', 21:21:28 INFO - 'XPC_SERVICE_NAME': '0', 21:21:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:21:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:21:28 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:21:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:21:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:21:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:21:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:21:30 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:21:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:21:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:21:30 INFO - Installing collected packages: mozsystemmonitor 21:21:30 INFO - Running setup.py install for mozsystemmonitor 21:21:31 INFO - Successfully installed mozsystemmonitor 21:21:31 INFO - Cleaning up... 21:21:31 INFO - Return code: 0 21:21:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:21:31 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')]} 21:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:21:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:31 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')]} 21:21:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:21:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:31 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 0x10a4dba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4e34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9859da3640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a37fd30>, '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 0x10a1a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a376b20>, '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.2fYdLJmjEG/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.erlyQd39C3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 21:21:31 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 21:21:31 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 21:21:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2fYdLJmjEG/Render', 21:21:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:21:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:21:31 INFO - 'HOME': '/Users/cltbld', 21:21:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:21:31 INFO - 'LOGNAME': 'cltbld', 21:21:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:21:31 INFO - 'MOZ_NO_REMOTE': '1', 21:21:31 INFO - 'NO_EM_RESTART': '1', 21:21:31 INFO - 'PAGER': '/bin/cat', 21:21:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:21:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:21:31 INFO - 'PWD': '/builds/slave/test', 21:21:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:21:31 INFO - 'SHELL': '/bin/bash', 21:21:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.erlyQd39C3/Listeners', 21:21:31 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 21:21:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:21:31 INFO - 'USER': 'cltbld', 21:21:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:21:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:21:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:21:31 INFO - 'XPC_FLAGS': '0x0', 21:21:31 INFO - 'XPC_SERVICE_NAME': '0', 21:21:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:21:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:21:31 INFO - Downloading/unpacking blobuploader==1.2.4 21:21:31 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 21:21:31 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 21:21:31 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 21:21:31 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 21:21:31 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 21:21:31 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 21:21:33 INFO - Downloading blobuploader-1.2.4.tar.gz 21:21:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:21:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:21:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:21:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:21:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:21:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:21:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:21:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:21:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:21:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:21:34 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 21:21:34 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 21:21:34 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 21:21:34 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 21:21:34 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 21:21:34 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 21:21:34 INFO - Downloading docopt-0.6.1.tar.gz 21:21:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:21:35 INFO - Installing collected packages: blobuploader, requests, docopt 21:21:35 INFO - Running setup.py install for blobuploader 21:21:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:21:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:21:35 INFO - Running setup.py install for requests 21:21:35 INFO - Running setup.py install for docopt 21:21:35 INFO - Successfully installed blobuploader requests docopt 21:21:35 INFO - Cleaning up... 21:21:35 INFO - Return code: 0 21:21:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:21:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:21:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:21:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:21:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:21:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:35 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 0x10a4dba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4e34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9859da3640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a37fd30>, '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 0x10a1a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a376b20>, '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.2fYdLJmjEG/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.erlyQd39C3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 21:21:35 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 21:21:35 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 21:21:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2fYdLJmjEG/Render', 21:21:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:21:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:21:35 INFO - 'HOME': '/Users/cltbld', 21:21:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:21:35 INFO - 'LOGNAME': 'cltbld', 21:21:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:21:35 INFO - 'MOZ_NO_REMOTE': '1', 21:21:35 INFO - 'NO_EM_RESTART': '1', 21:21:35 INFO - 'PAGER': '/bin/cat', 21:21:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:21:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:21:35 INFO - 'PWD': '/builds/slave/test', 21:21:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:21:35 INFO - 'SHELL': '/bin/bash', 21:21:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.erlyQd39C3/Listeners', 21:21:35 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 21:21:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:21:35 INFO - 'USER': 'cltbld', 21:21:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:21:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:21:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:21:35 INFO - 'XPC_FLAGS': '0x0', 21:21:35 INFO - 'XPC_SERVICE_NAME': '0', 21:21:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:21:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:21:36 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-I1oTVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:21:36 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-uqonrB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:21:36 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-0WG_vD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:21:36 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-95mwvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:21:36 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-MPBVII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:21:36 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-wpGpWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:21:36 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-0Cvfk2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:21:36 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-amnIqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:21:36 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-cNM9Ij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:21:37 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-4po1wA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:21:37 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-odadUr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:21:37 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-Zk52C5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:21:37 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-4du459-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:21:37 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-nKh4wW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:21:37 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-cCzHew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:21:37 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-f1E02J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:21:37 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-JAH_Fb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:21:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:21:37 INFO - Running setup.py install for manifestparser 21:21:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:21:38 INFO - Running setup.py install for mozcrash 21:21:38 INFO - Running setup.py install for mozdebug 21:21:38 INFO - Running setup.py install for mozdevice 21:21:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:21:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:21:38 INFO - Running setup.py install for mozfile 21:21:38 INFO - Running setup.py install for mozhttpd 21:21:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:21:38 INFO - Running setup.py install for mozinfo 21:21:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:21:38 INFO - Running setup.py install for mozInstall 21:21:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:21:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:21:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:21:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:21:39 INFO - Running setup.py install for mozleak 21:21:39 INFO - Running setup.py install for mozlog 21:21:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:21:39 INFO - Running setup.py install for moznetwork 21:21:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:21:39 INFO - Running setup.py install for mozprocess 21:21:39 INFO - Running setup.py install for mozprofile 21:21:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:21:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:21:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:21:39 INFO - Running setup.py install for mozrunner 21:21:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:21:40 INFO - Running setup.py install for mozscreenshot 21:21:40 INFO - Running setup.py install for moztest 21:21:40 INFO - Running setup.py install for mozversion 21:21:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:21:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:21:40 INFO - Cleaning up... 21:21:40 INFO - Return code: 0 21:21:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:21:40 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')]} 21:21:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:21:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:40 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')]} 21:21:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:21:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:40 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 0x10a4dba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4e34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9859da3640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a37fd30>, '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 0x10a1a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a376b20>, '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.2fYdLJmjEG/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.erlyQd39C3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 21:21:40 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 21:21:40 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 21:21:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2fYdLJmjEG/Render', 21:21:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:21:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:21:40 INFO - 'HOME': '/Users/cltbld', 21:21:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:21:40 INFO - 'LOGNAME': 'cltbld', 21:21:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:21:40 INFO - 'MOZ_NO_REMOTE': '1', 21:21:40 INFO - 'NO_EM_RESTART': '1', 21:21:40 INFO - 'PAGER': '/bin/cat', 21:21:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:21:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:21:40 INFO - 'PWD': '/builds/slave/test', 21:21:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:21:40 INFO - 'SHELL': '/bin/bash', 21:21:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.erlyQd39C3/Listeners', 21:21:40 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 21:21:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:21:40 INFO - 'USER': 'cltbld', 21:21:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:21:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:21:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:21:40 INFO - 'XPC_FLAGS': '0x0', 21:21:40 INFO - 'XPC_SERVICE_NAME': '0', 21:21:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:21:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:21:40 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-ltI_C3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:21:40 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)) 21:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:21:40 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-81mnGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:21:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:21:40 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-gDTc0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:21:41 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)) 21:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:21:41 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-X0uWTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:21:41 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)) 21:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:21:41 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-inAcRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:21:41 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)) 21:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:21:41 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-fvnf6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:21:41 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)) 21:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:21:41 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-UWaVi1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:21:41 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)) 21:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:21:41 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-AwHfIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:21:41 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)) 21:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:21:41 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-zMCzEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:21:41 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)) 21:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:21:41 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-ch9lv2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:21:41 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)) 21:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:21:41 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-CGyVBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:21:41 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)) 21:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:21:41 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-wKO5yP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:21:41 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)) 21:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:21:41 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-JhITVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:21:42 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)) 21:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:21:42 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-q2NFZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:21:42 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)) 21:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:21:42 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-TOlyAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:21:42 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)) 21:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:21:42 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-KbbzF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:21:42 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)) 21:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:21:42 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-jhhKQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:21:42 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)) 21:21:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:21:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:21:42 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)) 21:21:42 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)) 21:21:42 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)) 21:21:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:21:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:21:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:21:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:21:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:21:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:21:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:21:44 INFO - Downloading blessings-1.6.tar.gz 21:21:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:21:44 INFO - Installing collected packages: blessings 21:21:44 INFO - Running setup.py install for blessings 21:21:45 INFO - Successfully installed blessings 21:21:45 INFO - Cleaning up... 21:21:45 INFO - Return code: 0 21:21:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:21:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:21:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:21:45 INFO - Reading from file tmpfile_stdout 21:21:45 INFO - Current package versions: 21:21:45 INFO - blessings == 1.6 21:21:45 INFO - blobuploader == 1.2.4 21:21:45 INFO - docopt == 0.6.1 21:21:45 INFO - manifestparser == 1.1 21:21:45 INFO - mozInstall == 1.12 21:21:45 INFO - mozcrash == 0.17 21:21:45 INFO - mozdebug == 0.1 21:21:45 INFO - mozdevice == 0.48 21:21:45 INFO - mozfile == 1.2 21:21:45 INFO - mozhttpd == 0.7 21:21:45 INFO - mozinfo == 0.9 21:21:45 INFO - mozleak == 0.1 21:21:45 INFO - mozlog == 3.1 21:21:45 INFO - moznetwork == 0.27 21:21:45 INFO - mozprocess == 0.22 21:21:45 INFO - mozprofile == 0.28 21:21:45 INFO - mozrunner == 6.11 21:21:45 INFO - mozscreenshot == 0.1 21:21:45 INFO - mozsystemmonitor == 0.0 21:21:45 INFO - moztest == 0.7 21:21:45 INFO - mozversion == 1.4 21:21:45 INFO - psutil == 3.1.1 21:21:45 INFO - requests == 1.2.3 21:21:45 INFO - wsgiref == 0.1.2 21:21:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:21:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:21:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:21:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:21:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:45 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 0x10a4dba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4e34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9859da3640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a37fd30>, '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 0x10a1a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a376b20>, '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.2fYdLJmjEG/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.erlyQd39C3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 21:21:45 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 21:21:45 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 21:21:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2fYdLJmjEG/Render', 21:21:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:21:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:21:45 INFO - 'HOME': '/Users/cltbld', 21:21:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:21:45 INFO - 'LOGNAME': 'cltbld', 21:21:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:21:45 INFO - 'MOZ_NO_REMOTE': '1', 21:21:45 INFO - 'NO_EM_RESTART': '1', 21:21:45 INFO - 'PAGER': '/bin/cat', 21:21:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:21:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:21:45 INFO - 'PWD': '/builds/slave/test', 21:21:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:21:45 INFO - 'SHELL': '/bin/bash', 21:21:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.erlyQd39C3/Listeners', 21:21:45 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 21:21:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:21:45 INFO - 'USER': 'cltbld', 21:21:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:21:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:21:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:21:45 INFO - 'XPC_FLAGS': '0x0', 21:21:45 INFO - 'XPC_SERVICE_NAME': '0', 21:21:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:21:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:21:45 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)) 21:21:45 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)) 21:21:45 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)) 21:21:45 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)) 21:21:45 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)) 21:21:45 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)) 21:21:45 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)) 21:21:45 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)) 21:21:45 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)) 21:21:45 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)) 21:21:45 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)) 21:21:45 INFO - Cleaning up... 21:21:45 INFO - Return code: 0 21:21:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:21:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:21:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:21:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:21:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:45 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 0x10a4dba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4e34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9859da3640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a37fd30>, '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 0x10a1a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a376b20>, '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.2fYdLJmjEG/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.erlyQd39C3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 21:21:45 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 21:21:45 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 21:21:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2fYdLJmjEG/Render', 21:21:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:21:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:21:45 INFO - 'HOME': '/Users/cltbld', 21:21:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:21:45 INFO - 'LOGNAME': 'cltbld', 21:21:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:21:45 INFO - 'MOZ_NO_REMOTE': '1', 21:21:45 INFO - 'NO_EM_RESTART': '1', 21:21:45 INFO - 'PAGER': '/bin/cat', 21:21:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:21:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:21:45 INFO - 'PWD': '/builds/slave/test', 21:21:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:21:45 INFO - 'SHELL': '/bin/bash', 21:21:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.erlyQd39C3/Listeners', 21:21:45 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 21:21:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:21:45 INFO - 'USER': 'cltbld', 21:21:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:21:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:21:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:21:45 INFO - 'XPC_FLAGS': '0x0', 21:21:45 INFO - 'XPC_SERVICE_NAME': '0', 21:21:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:21:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:21:45 INFO - Downloading/unpacking jsonschema 21:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:21:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:21:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:21:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:21:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:21:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:21:48 INFO - Downloading/unpacking functools32 (from jsonschema) 21:21: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 21:21: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 21:21: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 21:21: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 21:21: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 21:21: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 21:21:48 INFO - Downloading functools32-3.2.3-2.tar.gz 21:21:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:21:48 INFO - warning: no files found matching '*.txt' 21:21:48 INFO - no previously-included directories found matching 'build' 21:21:48 INFO - no previously-included directories found matching 'dist' 21:21:48 INFO - no previously-included directories found matching '.git*' 21:21:48 INFO - Installing collected packages: jsonschema, functools32 21:21:48 INFO - Running setup.py install for functools32 21:21:48 INFO - warning: no files found matching '*.txt' 21:21:48 INFO - no previously-included directories found matching 'build' 21:21:48 INFO - no previously-included directories found matching 'dist' 21:21:48 INFO - no previously-included directories found matching '.git*' 21:21:48 INFO - Successfully installed jsonschema functools32 21:21:48 INFO - Cleaning up... 21:21:49 INFO - Return code: 0 21:21:49 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 21:21:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:21:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:21:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:21:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:21:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a4dba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4e34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9859da3640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a37fd30>, '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 0x10a1a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a376b20>, '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.2fYdLJmjEG/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.erlyQd39C3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 21:21:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 21:21:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 21:21:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2fYdLJmjEG/Render', 21:21:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:21:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:21:49 INFO - 'HOME': '/Users/cltbld', 21:21:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:21:49 INFO - 'LOGNAME': 'cltbld', 21:21:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:21:49 INFO - 'MOZ_NO_REMOTE': '1', 21:21:49 INFO - 'NO_EM_RESTART': '1', 21:21:49 INFO - 'PAGER': '/bin/cat', 21:21:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:21:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:21:49 INFO - 'PWD': '/builds/slave/test', 21:21:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:21:49 INFO - 'SHELL': '/bin/bash', 21:21:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.erlyQd39C3/Listeners', 21:21:49 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 21:21:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:21:49 INFO - 'USER': 'cltbld', 21:21:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:21:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:21:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:21:49 INFO - 'XPC_FLAGS': '0x0', 21:21:49 INFO - 'XPC_SERVICE_NAME': '0', 21:21:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:21:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:21:49 INFO - Downloading/unpacking flake8 21:21: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 21:21: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 21:21: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 21:21: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 21:21: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 21:21: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 21:21:51 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:21:51 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:21:51 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 21:21:51 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 21:21:51 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 21:21:51 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 21:21:51 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 21:21:51 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 21:21:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:21:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:21:51 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 21:21:51 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 21:21:51 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 21:21:51 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 21:21:51 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 21:21:51 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 21:21:52 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:21:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:21:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:21:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:21:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:21:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 21:21:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:21:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:21:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:21:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:21:52 INFO - no previously-included directories found matching 'docs/_build' 21:21:52 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:21:52 INFO - Running setup.py install for pep8 21:21:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:21:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:21:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:21:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:21:53 INFO - no previously-included directories found matching 'docs/_build' 21:21:53 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 21:21:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:21:53 INFO - Cleaning up... 21:21:53 INFO - Return code: 0 21:21:53 INFO - Running post-action listener: _resource_record_post_action 21:21:53 INFO - Running post-action listener: _start_resource_monitoring 21:21:53 INFO - Starting resource monitoring. 21:21:53 INFO - ##### 21:21:53 INFO - ##### Running install step. 21:21:53 INFO - ##### 21:21:53 INFO - Running pre-action listener: _resource_record_pre_action 21:21:53 INFO - Running main action method: install 21:21:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:21:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:21:53 INFO - Reading from file tmpfile_stdout 21:21:53 INFO - Detecting whether we're running mozinstall >=1.0... 21:21:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:21:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:21:53 INFO - Reading from file tmpfile_stdout 21:21:53 INFO - Output received: 21:21:53 INFO - Usage: mozinstall [options] installer 21:21:53 INFO - Options: 21:21:53 INFO - -h, --help show this help message and exit 21:21:53 INFO - -d DEST, --destination=DEST 21:21:53 INFO - Directory to install application into. [default: 21:21:53 INFO - "/builds/slave/test"] 21:21:53 INFO - --app=APP Application being installed. [default: firefox] 21:21:53 INFO - mkdir: /builds/slave/test/build/application 21:21:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 21:21:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 21:22:27 INFO - Reading from file tmpfile_stdout 21:22:27 INFO - Output received: 21:22:27 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 21:22:27 INFO - Running post-action listener: _resource_record_post_action 21:22:27 INFO - ##### 21:22:27 INFO - ##### Running run-tests step. 21:22:27 INFO - ##### 21:22:27 INFO - Running pre-action listener: _resource_record_pre_action 21:22:27 INFO - Running main action method: run_tests 21:22:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:22:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:22:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:22:27 INFO - 2016-03-08 21:22:27.549 screenresolution[1646:7593] starting screenresolution argv=screenresolution get 21:22:27 INFO - 2016-03-08 21:22:27.552 screenresolution[1646:7593] Display 0: 1600x1200x32@60 21:22:27 INFO - 2016-03-08 21:22:27.557 screenresolution[1647:7595] starting screenresolution argv=screenresolution list 21:22:27 INFO - Available Modes on Display 0 21:22:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:22:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:22:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:22:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:22:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:22:27 INFO - Intel Iris: 21:22:27 INFO - Chipset Model: Intel Iris 21:22:27 INFO - Type: GPU 21:22:27 INFO - Bus: Built-In 21:22:27 INFO - VRAM (Dynamic, Max): 1536 MB 21:22:27 INFO - Vendor: Intel (0x8086) 21:22:27 INFO - Device ID: 0x0a2e 21:22:27 INFO - Revision ID: 0x0009 21:22:27 INFO - Displays: 21:22:27 INFO - Display: 21:22:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:22:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:22:27 INFO - Display Serial Number: 1600x1200 60 21:22:27 INFO - Main Display: Yes 21:22:27 INFO - Mirror: Off 21:22:27 INFO - Online: Yes 21:22:27 INFO - Rotation: Supported 21:22:27 INFO - Return code: 0 21:22:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:22:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:22:27 INFO - Python 2.7.3 21:22:27 INFO - Return code: 0 21:22:27 INFO - grabbing minidump binary from tooltool 21:22:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:22:27 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 0x10a37fd30>, '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 0x10a1a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a376b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:22:27 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 21:22:27 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 21:22:27 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:22:27 INFO - Return code: 0 21:22:27 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:22:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:22:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:22:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:22:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:22:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 21:22:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 21:22:29 INFO - Return code: 0 21:22:29 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/MYQiA5a_TXS2JsozWhcFCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0084', '--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 21:22:29 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/MYQiA5a_TXS2JsozWhcFCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0084 --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 21:22:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2fYdLJmjEG/Render', 21:22:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:22:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:22:29 INFO - 'HOME': '/Users/cltbld', 21:22:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:22:29 INFO - 'LOGNAME': 'cltbld', 21:22:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:22:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:22:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:22:29 INFO - 'MOZ_NO_REMOTE': '1', 21:22:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:22:29 INFO - 'NO_EM_RESTART': '1', 21:22:29 INFO - 'PAGER': '/bin/cat', 21:22:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:22:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:22:29 INFO - 'PWD': '/builds/slave/test', 21:22:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:22:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:22:29 INFO - 'SHELL': '/bin/bash', 21:22:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.erlyQd39C3/Listeners', 21:22:29 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 21:22:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:22:29 INFO - 'USER': 'cltbld', 21:22:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:22:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:22:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:22:29 INFO - 'XPC_FLAGS': '0x0', 21:22:29 INFO - 'XPC_SERVICE_NAME': '0', 21:22:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:22:29 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/MYQiA5a_TXS2JsozWhcFCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0084', '--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 21:22:29 INFO - mozversion application_buildid: 20160308202514 21:22:29 INFO - mozversion application_changeset: 893ca601352abf582cb64e1cfbcec68dcc06871a 21:22:29 INFO - mozversion application_display_name: Nightly 21:22:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:22:29 INFO - mozversion application_name: Firefox 21:22:29 INFO - mozversion application_remotingname: firefox 21:22:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 21:22:29 INFO - mozversion application_vendor: Mozilla 21:22:29 INFO - mozversion application_version: 48.0a1 21:22:29 INFO - mozversion platform_buildid: 20160308202514 21:22:29 INFO - mozversion platform_changeset: 893ca601352abf582cb64e1cfbcec68dcc06871a 21:22:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 21:22:29 INFO - mozversion platform_version: 48.0a1 21:22:29 INFO - using testdate: 1457500949 21:22:29 INFO - actual date: 1457500949 21:22:29 INFO - starting webserver on 'localhost:49275' 21:22:29 INFO - SUITE-START | Running 2 tests 21:22:29 INFO - TEST-START | dromaeo_css 21:22:29 INFO - operating with platform_type : mac_ 21:22:29 INFO - Initialising browser for dromaeo_css test... 21:22:29 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmpabI0ea/profile http://localhost:49275/getInfo.html) 21:22:31 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 21:22:31 INFO - PROCESS | 1665 | colorDepth:24 21:22:31 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 21:22:31 INFO - PROCESS | 1665 | __metrics 21:22:31 INFO - PROCESS | 1665 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:22:31 ERROR - PROCESS | 1665 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 21:22:32 INFO - TEST-INFO | 1665: exit 0 21:22:32 INFO - Browser initialized. 21:22:32 INFO - Running cycle 1/1 for dromaeo_css test... 21:22:32 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmpabI0ea/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:22:44 INFO - PROCESS | 1668 | RSS: Main: 243032064 21:22:44 INFO - PROCESS | 1668 | 21:23:35 INFO - PROCESS | 1668 | 1457501015313 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] 21:25:45 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 21:25:46 INFO - PROCESS | 1668 | RSS: Main: 342700032 21:25:46 INFO - PROCESS | 1668 | 21:28:49 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 21:28:49 INFO - PROCESS | 1668 | RSS: Main: 371748864 21:28:49 INFO - PROCESS | 1668 | 21:31:51 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 21:31:52 INFO - PROCESS | 1668 | RSS: Main: 373997568 21:31:52 INFO - PROCESS | 1668 | 21:34:54 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 21:34:54 INFO - PROCESS | 1668 | RSS: Main: 331386880 21:34:54 INFO - PROCESS | 1668 | 21:37:58 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 21:37:58 INFO - PROCESS | 1668 | RSS: Main: 334327808 21:37:58 INFO - PROCESS | 1668 | 21:41:01 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 21:41:01 INFO - PROCESS | 1668 | RSS: Main: 390909952 21:41:01 INFO - PROCESS | 1668 | 21:41:01 INFO - PROCESS | 1668 | __start_tp_report 21:41:01 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 21:41:01 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 21:41:01 INFO - PROCESS | 1668 | |i|pagename|runs| 21:41:01 INFO - PROCESS | 1668 | |0;dojo.html;2777.527820270554;3465.9826700866506;3497.2830569733205;3507.9298414031737;3554.4668299755035;5640.407757185498;5647.37878833328;5663.546916246701;5668.773249070032;5671.659700417973;5571.582131340146;5647.604667673265;5651.491365777079;5663.801766938158;5671.432856714327;5108.8978220435665;5143.971205758863;5160.354955630546;5170.224466330043;5215.895682086375;5197.896042079156;5211.1922651989;5220.92168617471;5224.216367544861;5233.502817232356;5125.384953805548;5172.974135129319;5192.71440070796;5197.58419326453;5204.245384419257;5191.480851914816;5221.216817477409;5233.528982391565;5253.238280449352;5282.894342113136;5058.570021548173;5089.770960306795;5098.719570423626;5131.153359695646;5165.405978312505;5561.666300021971;5563.054280772279;5643.887122257573;5654.434556544354;5685.857853553694;6221.502279817649;6255.6872156392;6263.123162757218;6273.05904114382;6290.245170579514;6134.754609815602;6140.925338065866;6247.4377306042215;6303.936960630427;6329.208848893888;5789.218455508494;5790.160426738099;5802.332731735904;5809.7676092956235;5847.532197424196;6309.558330916791;6314.463270622048;6330.240371155491;6330.303666596671;6350.364963503613;5939.10913362999;6053.45518903292;6087.1173679816175;6141.723622437001;6145.569810113249;6157.230346206724;6249.875022495903;6254.3745625437095;6262.12330273762;6285.96857015712;6121.989871671213;6182.783602573888;6183.227096612924;6190.0405437157315;6192.938070619326;6093.146959425684;6140.2281855057;6259.374062593704;6270.968645156745;6276.560640755195;4186.162767446462;4893.290472881412;4899.265110233494;4900.558949694545;4937.654364194472;4247.299195632686;4392.209402307615;4401.977990110093;4409.096135292258;4478.193925093449;5678.432156784371;5680.744366503517;5744.482996530249;5746.913796293059;5772.422757724194;5774.642958904654;6275.717592708339;6300.59046161998;6308.653024083719;6314.652694101868;5434.673919564839;5594.216809646653;5729.942700573024;5732.512736417368;5756.251687280626;4557.475890272594;5354.303940487712;5358.946410535923;5409.215663728737;5428.240046393508;6278.748850046039;6289.7484100635465;6290.559660823698;6292.716827742855;6295.24457065146;6101.217066730222;6254.937450625617;6269.905951410641;6294.842628934313;6295.401936815995;6217.658028808459;6256.655883926428;6287.811365659038;6294.5593808434805;6307.211598550181;6166.506679465721;6167.259928808572;6172.290186628596;6174.722137503913;6180.289266734203;6119.228375855631;6129.141920131275;6243.687815609293;6272.09054687077;6272.278687950761;6070.7875224366935;6102.852830488404;6109.236345456818;6110.923300256584;6144.262688477412;6044.002739548101;6065.090236464565;6082.239720034996;6089.604175728564;6116.3272040076445;5769.567282453749;5861.912071318849;5918.467337939606;5926.436988486087;5952.226210592596;6060.363661815446;6084.543659225487;6100.359462256399;6105.481034111973;6110.847228819315;5875.441833025856;5877.441643043904;5880.911786323294;5899.321578018411;5940.227770389822 21:41:01 INFO - PROCESS | 1668 | |1;ext.html;487.0915742140908;575.8474004388835;592.6191972703601;594.634299905558;635.3138610300875;30785;39231.80384098079;39513.01217469565;39580.80209598955;39742.20515589687;41831.37252941208;42253;42342.36486452698;42385.78807105968;42454.363184552254;9567.330286879904;9804.901950980506;9826.263030272723;9833.11501964823;9841.704748857546;9621.470819104981;9768.853467197998;9769.120779129877;9769.90230097697;9810.21518278536;9726.805463890718;9945.16014537313;9945.75135621608;9950.30347875649;9952.402855828637;9840.950795246014;9896.752581185456;9911.207103431709;9924.15644670204;9928.751781205456;9672.468014259213;9780.51097445132;9814.116729494379;9818.312718109735;9826.950865245699;38576.22847543033;38864.61135388666;38900.61099388998;38934.80532597347;38966.415503767465;3197.2486465680545;3332.2502436951736;3432.7253819694365;3663.7618554793853;3829.8468061277517;28626.427471450454;29002.27494312638;29787.957421490144;29794.40411191764;29805.10584682463;2685.946281074387;2737.603047558093;2762.875670594808;2825.5055365311196;2915.9708402915912;379607.1019644884;383558;411798;413005;414341;59802.70098649479;64067.679661601396;64603.03095453572;64652;64726;68451.65774171197;68590.65704671445;68666;68793;68848.6557567209;13997.5100871469;15570.299336529883;17056.48830535086;17271.827281727274;17281.740773888403;9803.215742740564;11862.22895511789;11865.762684746429;11911.880881191077;13046.152000119962;15656.757850210144;16463.34146634121;17257.65484690299;20669.276575319793;20671.896640517003;6984.685689144001;8183.386246031452;8336.208060234389;8450.154984501502;8547.529885856213;950.1780959470009;969.3021024862088;996.6113215845826;1014.9340292880939;1067.9839802402971;30073.548896766566;30077.699223007927;30468;30707.539386909215;30732.53901191484;1073.624231518962;1107.828286615576;1111.7331840358256;1112.4326593437243;1173.700706319883;15371.538853834403;15479.993800402937;15694.450694225647;15752.842471575366;15857.682846343008;660847.6957615277;662210;666930;667532;668453;56034.87930241454;57123;57310;57500.13749793756;57580;1335.4057444437326;1364.3042048555308;1366.3714691241942;1463.4000059975572;1502.346479281516;23322.65016024727;29769.255768605093;30388.84805575958;30594.541081884236;30881.073567792104;48228;58691.70654146702;59392.406075938685;59396;59400.108998365926;608485;612517;613111;613502;614128;35281.647183527835;44045.33931991087;44410.777946110065;45050.09899802051;45339.546604533534;42542.78728606337;43797.562024379346;45977.31034034559;46488;47983.76008119937;36349.27301454009;36746.26507469889;37174.44238336481;38162.61837381591;38835.805820970716;35315.29369412546;37274.63666290902;37587.436188456646;37852.432213516266;38264.42603361008;29029.709702903547;30279.69720302857;31723.491458829605;33053.17367065843;37768;30849.845750771103;31940.20149496281;31945.041648750575;31976;32079.67920320767;23989.76010239945;24171.395715107265;24324.27027189187;24620.384490387885;24810.751892481567 21:41:01 INFO - PROCESS | 1668 | |2;jquery.html;356.71641045368926;359.1326945426794;360.7853327270274;368.2689860626656;370.5386793442165;19785.703214451794;19987.800121998775;20747.688784668204;20767.96160191992;20802.791972080275;15889.841101588981;20591.27930522432;20929.47676308093;21127.47181320464;21129.47176320589;5848.736806843703;6017.7592896284095;6071.3625069367745;6074.149619053336;6076.058210977306;4264.23243816113;4525.389072475223;5986.491148252404;6593.208814942213;6601.2078550574;6454.096426500294;6512.446442052407;6515.804525864231;6520;6521.673916304189;6270.78052268173;6394.200724909387;6466.93533064668;6478.4169424752;6508.088867558546;5544.308985759341;5567.387587365387;5574.219609254707;5580.051391263495;5588.6646801192055;24001.87999060011;25213.739313034457;26376.73623263762;26719.599206011924;26767;2117.8623389479635;2194.2539536557647;2337.614293641547;2722.7005029446746;2895.811772234798;9527.285453591008;10054.145397641209;12720.300383478905;14568;15444.5366639001;1684.8904821186584;1687.561234079136;1722.1561434896935;1750.956226094345;1834.4680042787575;81910.72357105708;93044.53477732636;95093.52453237689;97212.027879721;98460.50769746177;10481.528331225114;11254.887451125547;11278.81572434899;11307.756146823844;11327.830082548768;12372.876271237352;13853.23807190594;13955.58133256004;13993.860061399459;13994.580162594935;8612.698555550525;8786;8820.603072861737;8880.111988801069;8880.600372983103;9035.186833185046;9060.275177985877;9068.682596109105;9149.039350868195;9170.174684278447;4399.780010999437;4467.352233926063;4486.304622783474;4539.273716205391;4548.226801443762;1815.5279627296998;1851.7407562941198;1858.4424672598436;1864.133178072203;1865.7854346750025;839.5802098950525;930.2232635749225;931.3852857114272;974.9512524373753;1019.5666841592293;20334.593308133753;20677.79322206789;20749.89625051865;20884.895575522027;20930;934.9439033658002;951.3578334624101;965.2663975378622;993.6919554937992;998.6654470752234;8031.317338026333;11025.117990560735;11139.164562657834;11158.972732094522;11241.66275011751;476652;484884;485543;540850;634185;95168;96436.55345169827;104400;119009.80990190161;121170;904.4754042655244;1006.6023920551341;1022.3150489172124;1043.639944219243;1051.9631812886664;16127.274272657523;16420.917895410446;18417.447476575726;18792.718109228645;18970.715439268148;37472;52805.7359713199;53110.46889531055;54230.45769542254;55191.344259672274;64679.67660161669;66575;75370;78596.2140378589;79177.60411197908;7822.843543129219;7836.92163078362;8091;8094.150114238156;8436.11420800807;10749.731256718645;12770.936145319585;13186.538471153464;13356.398962046926;13417.731645367234;11375.748667646718;11545.711357215801;11569.305841649528;11608;11739.413029348669;11221.326720396803;11261.549538018387;11293;11459.31244125355;11569.595064172714;11422.543098275975;11792.110932821513;12077.094217933514;12122.969547588202;12204.023678105908;7843.411744119328;8048.993875765529;8077.394195435249;8079.474834135997;8438.915610844058;8517.531535765593;11169.329840209613;11588.899054589801;11717.88282117168;11898.58354957607 21:41:01 INFO - PROCESS | 1668 | |3;mootools.html;1418.5460652591175;1580.5890468478196;1586.9127198004105;1867.2437662746584;1982.2566537548419;8158.428909976304;8378.413511054236;8380.83238335233;8395;8855;7750.8449831003345;8690.783290339357;8789.989151247608;8958.23854972328;9003.054679258665;2092.947676308097;2456.975430245697;2479.2562231330617;2484.3664865459373;2485.7762801347876;2170.815480684144;2410.783029527342;2465.716442609105;2466.851988880664;2469.4196863737006;2413.855168689884;2431.8054555635595;2432.4891772727747;2433.6714543536573;2441.3286346254745;2400.8319417640773;2455.6193789962585;2466.3957330453973;2469.6172093325563;2470.5800013997573;2370.3007612754277;2392.270357540949;2395.245497668229;2395.4610212702;2440.7437219091917;8978.910210897939;9069.093090690943;9070.365074444791;9084.545772711404;9087.318451116127;5426.810061647823;5584.91622625661;5616.466435688603;5620.241267428885;5621.381648018714;3408.4887266909914;3610.765300255475;3685.1708365617787;3751.1934933989323;3752.6622603965775;1009.0817356205818;1031.2729525684374;1049.4962418039308;1055.8152323343384;1063.4098075568056;11992.280463172237;12043.698907527381;12054.69863253417;12056.939715301367;12115.818262726067;4820.34925285082;4934.210526315772;4990.476000020019;5032.572231360302;5045.621578381562;10148.695539133838;10185.74535636615;10211.285210035374;10227.130693890953;10241.283110182365;4792.2332426811545;5605.1031834907035;5615.4946054854445;5616.747246373923;5628.577856660767;4476.171908196994;5047.87380315495;5091.9236211456855;5097.362829646294;5117.948820511821;3918.4710064141545;3987.5613682494904;4025.335819589735;4050.2709512287483;4052.959470405317;1318.1827267094463;1326.8606796286444;1334.2461509247244;1335.2389138191138;1349.3725417680826;1147.1625713229223;1147.73602071524;1150.6260465348628;1170.1399471388522;1172.038928078967;8047;8270.669173233004;8290.502569845828;8396;8397.580120994047;1028.7068185567077;1162.9825552616717;1227.404708716272;1231.4643130238376;1248.7752204603078;5431.592630552725;6409.070684750685;6486.027095935553;6487.3836985486305;6500.317466666026;10097.83874854401;10303.896961030443;10304.12414944723;10308.12380947628;10462.267641265038;10184.592616295413;10208.744781380525;10232.795344093076;10309.226807989431;10321.174306055498;8160.0207975042185;8309.626066827008;8330.625121869409;8384.287335576422;8408.411411201158;8212.876806847782;8220.876686849822;8253.133420990709;8322;8462.449940753831;9695.70912872615;9724.27067969891;9782.510874456106;9908.702738917844;9960.003999599981;9971.551280192263;10199.439030853375;10313.587456501657;10453.843192352273;10485.003924627148;6109.7861574844665;7514.849703006019;7530.585817780075;7597.392208623186;7622.3521000713345;8235.588220588827;8241.134680858424;8299.377546683902;8301.252887240178;8309.210624990616;7359.337659610661;7468.775936721907;7494.213107623839;7660.080790305199;7675.923240767521;7341;7349.8162545936775;7372.410207183305;7434.851302973802;7537.8115547111765;7781.805454863674;7814.413918955987;7850.2542258485355;7855.764327070197;7876.527408355288;7031.296870312928;7074.610896400747;7098.609576473137;7129;7130.607816570138;7170.784876453715;7195.208527062124;7229.855402892018;7237.674304656198;7239.638018099179 21:41:01 INFO - PROCESS | 1668 | |4;prototype.html;312.9374125174965;319.0858191281978;324.9593800774903;326.67169494657867;327.6199608454195;6448.7742928997495;6453.161089058422;6485.740570377179;6522.57603255788;6545.116409284745;6417.165768450095;6486.4162225399705;6490.415862572368;6503.317151699074;6506.479481641469;3657.9451308230396;4633.953660463403;4635.072985402916;4782.473927867932;4843.200871856148;4022.356422972325;4755.120302743986;4780.235162374021;4796.232602783555;4808.158572249842;4701.106789709961;4717.858464246078;4730.6925049871825;4745.6915300505525;4779.02030083832;4503.1218912312115;4601.700889442175;4694.178518759203;4711.7879695413785;4720.527947205286;4053.5743746906446;4055.878323650295;4068.532118806316;4069.837206511736;4074.653654439376;5024.773885175176;6134.69326533676;6171.166892469504;6230.501559875244;6255.437010669016;4927.310176575246;5284.207368894658;5593.32880054392;5597.468240517144;5603.579731520153;6849.452043836481;6861.210960739479;6867.587944723283;6884.759033433806;6908.481863860231;4253.128108737701;4432.556744325574;4441.555844415565;4455.487618923833;4465.754383508905;7082.256363081905;7247.927520724778;7249.238829922888;7265.200827908926;7268.4185265179185;4507.57178068083;4515.390422293014;4516.07420478801;4516.751578663139;4534.115847409724;4568.086382723469;4568.291914753152;4568.840090596813;4572.45130584332;4576.6109880660515;5450.345958484928;5454.427285135003;5455.399906010336;5457.727113644302;5457.945420545823;6638.369354911372;6757.763478278335;6874.346937040973;6885.449164066863;6912.861742765116;1564.452441645415;1570.89789163704;1582.1614544291544;1588.0709784775804;1590.4194968836523;893.9955300223457;955.9569819358146;983.8032393521324;1008.8700655266002;1013.6654903881702;6304.959681652476;6465.450436712838;6495;6508.674566271668;6536.346365363521;6303.684815759194;6914.861702765917;7220.0613920190035;7223.566586004857;7228.421726261887;6464.353564643498;6485.870282594322;6488.935110648833;6489.480841532666;6504.1869766279215;3778.7165962552917;3822.655960963471;3825.9426108608395;3828.980855095707;3832.5400951885395;7183.712651493986;7476.962615186889;7486.5508069516;7551.660175292125;7563.9621801890635;7370.594617295993;7400.185979542246;7428.9628551856895;7430.814229644302;7454.739084132138;7524.774256772305;7532.39740820733;7550.924490755132;7563.319301262913;7566.1298950621385;6945.131858517685;7190.352868241884;7211.206767255702;7219.675114619749;7229.385502232369;5800.59395842287;7055.6472176392;7105.182903965903;7110.395616372666;7132.465065120033;5591.692456914909;7340.376068034277;7533.472656913963;7555.6977720890545;7573.318401343906;3980.5024371953505;4411.779411029372;4516.029053753458;4574.679772415899;4598;7211.495195336486;7242.710291588278;7242.855142897218;7248.782536523912;7249.746258880914;5890.381509941394;6659.966700166468;6785.9660701696175;6899.551529150589;6967.965160174167;6841.144856892888;6905.723771049102;6907.240203577703;6929.237783843874;6977.302269773185;6758.560693554903;6770.796876093725;6773.729050837911;6781.491388145811;6784.728610855511;6632.966835165793;6928.618925959121;6931.618760967994;6943.652817359213;6950.096487456598;6490.383413575702;6654.101696270942;6661.600303981777;6805.93194068053;6869.656517174221 21:41:01 INFO - PROCESS | 1668 | |5;yui.html;658.0918332700875;695.3811108113778;714.2143641993811;734.9118105827301;805.6938363421906;17358.913205433986;17607.943523388607;17633.470995870113;17635.470935871912;17655.646887062267;15896.920515397436;15956.042637441762;16035.278412471438;16039.83960160398;16051.678966420664;755.1504557372955;932.3007744191873;951.0869565217399;952.347641865321;955.4124213608616;763.0538132715449;928.0255731481951;945.30047764654;946.3801210207325;948.9715308540755;985.8422652375622;995.4873240281261;995.6017592962801;995.8257304971637;996.8953259907714;778.32285911257;791.536950883728;990.4156547636893;991.2218908157098;992.5682328187225;584.9532037436995;712.4015826705593;726.4696771356939;728.1007955175407;728.1589763822793;15354.539363819104;15372.615684607863;15399.23003849803;15412.845871541365;15428.305726242346;12519.248845069325;12551.246925184518;12596.748065038739;12726.10917235794;12755.617331479978;9978.600855965753;10030;10050.849237261447;10141.44222067786;10519.94740026295;3432.4508078707286;3507.3511400391008;3515.261795023023;3589.730770192246;3603.513525674027;83438;83944.16055839424;85472;85523.57238213769;85531.57234213852;9353.438793672265;9439.858402123973;9520.428774273565;9674.806503869882;9716.951415242878;21821.563568728852;21883.905804709702;21897.671534926987;21917.232896848534;22021.889890550443;6319.115323854664;7240.348368646742;7303.780886573411;7370.115586129698;7569.394448444222;4073.857414990461;4130.607592278729;4131.235721391552;4137.1518838638;4137.77242251679;3638.290533346025;3691.187938653492;3695.1685870678884;3695.8336874840697;3696.2237930034994;643.0900276109346;646.9902951455732;653.079158386682;673.7776533743853;673.8382788130813;511.2688854937401;568.8407245971134;596.087985382357;599.7870755881686;608.3338744075319;7996.480228785111;8069.31410830086;8099.473534220257;8163.3061189798345;8177.795555111051;528.6378830501119;576.4345246643662;599.1103211730576;600.3276330509857;605.5518916002127;3498.4052711039185;3578.8905439313894;3708.592054873962;3882.1265215326325;3938.133610605662;78978;94852;96331.55502667466;96717;96792.51603741937;82209;82488.76266856003;82596.58701706454;83086;84520;71124;71610;71741.56516869737;72328.27671723321;73489;7809.648565814438;7825.765227043198;7943.44395892282;8037.03555573335;8176.383557261857;50220.49779502158;51636.96726065382;51832;52055.47944520506;52965.47034529605;69336.30663693299;71864.9220261707;72652.63673681598;72742.27257727567;72754.27245727475;10051.346662466916;10175.7456063599;10205.948970255102;10233.437160956219;10591.993760592732;11125.332480051224;11204.831927521256;11341.546338146381;11372.772544549229;11398.658040258806;8327.417080804285;10259.435731034864;10380.688579342632;10596.735081623021;10759.838602421127;9086.954565227132;10310.948445257725;10471.790564188826;10698.144148467949;10790.190735694698;10298.536565854405;10403.58385664565;10670.30643008202;10718.624848130277;10743.838842417526;7236.89144662841;8140.959295203486;8976.326775491994;9173.816523669355;9216.585253663467;8487;8621.741347759576;8683.175098365646;9031.683891064044;9034.774130646787 21:41:01 INFO - PROCESS | 1668 | __end_tp_report 21:41:01 INFO - PROCESS | 1668 | __start_cc_report 21:41:01 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,1008 21:41:01 INFO - PROCESS | 1668 | __end_cc_report 21:41:01 INFO - PROCESS | 1668 | __startTimestamp1457502061787__endTimestamp 21:41:01 INFO - PROCESS | 1668 | 21:41:01 INFO - PROCESS | 1668 | ------- Summary: start ------- 21:41:01 INFO - PROCESS | 1668 | Number of tests: 6 21:41:01 INFO - PROCESS | 1668 | 21:41:01 INFO - PROCESS | 1668 | [#0] dojo.html Cycles:165 Average:5717.94 Median:5918.47 stddev:658.31 (11.1%) stddev-sans-first:618.60 21:41:01 INFO - PROCESS | 1668 | Values: 2777.5 3466.0 3497.3 3507.9 3554.5 5640.4 5647.4 5663.5 5668.8 5671.7 5571.6 5647.6 5651.5 5663.8 5671.4 5108.9 5144.0 5160.4 5170.2 5215.9 5197.9 5211.2 5220.9 5224.2 5233.5 5125.4 5173.0 5192.7 5197.6 5204.2 5191.5 5221.2 5233.5 5253.2 5282.9 5058.6 5089.8 5098.7 5131.2 5165.4 5561.7 5563.1 5643.9 5654.4 5685.9 6221.5 6255.7 6263.1 6273.1 6290.2 6134.8 6140.9 6247.4 6303.9 6329.2 5789.2 5790.2 5802.3 5809.8 5847.5 6309.6 6314.5 6330.2 6330.3 6350.4 5939.1 6053.5 6087.1 6141.7 6145.6 6157.2 6249.9 6254.4 6262.1 6286.0 6122.0 6182.8 6183.2 6190.0 6192.9 6093.1 6140.2 6259.4 6271.0 6276.6 4186.2 4893.3 4899.3 4900.6 4937.7 4247.3 4392.2 4402.0 4409.1 4478.2 5678.4 5680.7 5744.5 5746.9 5772.4 5774.6 6275.7 6300.6 6308.7 6314.7 5434.7 5594.2 5729.9 5732.5 5756.3 4557.5 5354.3 5358.9 5409.2 5428.2 6278.7 6289.7 6290.6 6292.7 6295.2 6101.2 6254.9 6269.9 6294.8 6295.4 6217.7 6256.7 6287.8 6294.6 6307.2 6166.5 6167.3 6172.3 6174.7 6180.3 6119.2 6129.1 6243.7 6272.1 6272.3 6070.8 6102.9 6109.2 6110.9 6144.3 6044.0 6065.1 6082.2 6089.6 6116.3 5769.6 5861.9 5918.5 5926.4 5952.2 6060.4 6084.5 6100.4 6105.5 6110.8 5875.4 5877.4 5880.9 5899.3 5940.2 21:41:01 INFO - PROCESS | 1668 | 21:41:01 INFO - PROCESS | 1668 | [#1] ext.html Cycles:180 Average:69798.83 Median:39372.41 stddev:152838.32 (388.2%) stddev-sans-first:153178.47 21:41:01 INFO - PROCESS | 1668 | Values: 487.1 575.8 592.6 594.6 635.3 30785.0 39231.8 39513.0 39580.8 39742.2 41831.4 42253.0 42342.4 42385.8 42454.4 9567.3 9804.9 9826.3 9833.1 9841.7 9621.5 9768.9 9769.1 9769.9 9810.2 9726.8 9945.2 9945.8 9950.3 9952.4 9841.0 9896.8 9911.2 9924.2 9928.8 9672.5 9780.5 9814.1 9818.3 9827.0 38576.2 38864.6 38900.6 38934.8 38966.4 3197.2 3332.3 3432.7 3663.8 3829.8 28626.4 29002.3 29788.0 29794.4 29805.1 2685.9 2737.6 2762.9 2825.5 2916.0 379607.1 383558.0 411798.0 413005.0 414341.0 59802.7 64067.7 64603.0 64652.0 64726.0 68451.7 68590.7 68666.0 68793.0 68848.7 13997.5 15570.3 17056.5 17271.8 17281.7 9803.2 11862.2 11865.8 11911.9 13046.2 15656.8 16463.3 17257.7 20669.3 20671.9 6984.7 8183.4 8336.2 8450.2 8547.5 950.2 969.3 996.6 1014.9 1068.0 30073.5 30077.7 30468.0 30707.5 30732.5 1073.6 1107.8 1111.7 1112.4 1173.7 15371.5 15480.0 15694.5 15752.8 15857.7 660847.7 662210.0 666930.0 667532.0 668453.0 56034.9 57123.0 57310.0 57500.1 57580.0 1335.4 1364.3 1366.4 1463.4 1502.3 23322.7 29769.3 30388.8 30594.5 30881.1 48228.0 58691.7 59392.4 59396.0 59400.1 608485.0 612517.0 613111.0 613502.0 614128.0 35281.6 44045.3 44410.8 45050.1 45339.5 42542.8 43797.6 45977.3 46488.0 47983.8 36349.3 36746.3 37174.4 38162.6 38835.8 35315.3 37274.6 37587.4 37852.4 38264.4 29029.7 30279.7 31723.5 33053.2 37768.0 30849.8 31940.2 31945.0 31976.0 32079.7 23989.8 24171.4 24324.3 24620.4 24810.8 21:41:01 INFO - PROCESS | 1668 | 21:41:01 INFO - PROCESS | 1668 | [#2] jquery.html Cycles:180 Average:31586.43 Median:357.92 stddev:87633.50 (24483.8%) stddev-sans-first:87847.97 21:41:01 INFO - PROCESS | 1668 | Values: 356.7 359.1 360.8 368.3 370.5 19785.7 19987.8 20747.7 20768.0 20802.8 15889.8 20591.3 20929.5 21127.5 21129.5 5848.7 6017.8 6071.4 6074.1 6076.1 4264.2 4525.4 5986.5 6593.2 6601.2 6454.1 6512.4 6515.8 6520.0 6521.7 6270.8 6394.2 6466.9 6478.4 6508.1 5544.3 5567.4 5574.2 5580.1 5588.7 24001.9 25213.7 26376.7 26719.6 26767.0 2117.9 2194.3 2337.6 2722.7 2895.8 9527.3 10054.1 12720.3 14568.0 15444.5 1684.9 1687.6 1722.2 1751.0 1834.5 81910.7 93044.5 95093.5 97212.0 98460.5 10481.5 11254.9 11278.8 11307.8 11327.8 12372.9 13853.2 13955.6 13993.9 13994.6 8612.7 8786.0 8820.6 8880.1 8880.6 9035.2 9060.3 9068.7 9149.0 9170.2 4399.8 4467.4 4486.3 4539.3 4548.2 1815.5 1851.7 1858.4 1864.1 1865.8 839.6 930.2 931.4 975.0 1019.6 20334.6 20677.8 20749.9 20884.9 20930.0 934.9 951.4 965.3 993.7 998.7 8031.3 11025.1 11139.2 11159.0 11241.7 476652.0 484884.0 485543.0 540850.0 634185.0 95168.0 96436.6 104400.0 119009.8 121170.0 904.5 1006.6 1022.3 1043.6 1052.0 16127.3 16420.9 18417.4 18792.7 18970.7 37472.0 52805.7 53110.5 54230.5 55191.3 64679.7 66575.0 75370.0 78596.2 79177.6 7822.8 7836.9 8091.0 8094.2 8436.1 10749.7 12770.9 13186.5 13356.4 13417.7 11375.7 11545.7 11569.3 11608.0 11739.4 11221.3 11261.5 11293.0 11459.3 11569.6 11422.5 11792.1 12077.1 12123.0 12204.0 7843.4 8049.0 8077.4 8079.5 8438.9 8517.5 11169.3 11588.9 11717.9 11898.6 21:41:01 INFO - PROCESS | 1668 | 21:41:01 INFO - PROCESS | 1668 | [#3] mootools.html Cycles:180 Average:6108.46 Median:5046.75 stddev:3205.53 (63.5%) stddev-sans-first:3195.14 21:41:01 INFO - PROCESS | 1668 | Values: 1418.5 1580.6 1586.9 1867.2 1982.3 8158.4 8378.4 8380.8 8395.0 8855.0 7750.8 8690.8 8790.0 8958.2 9003.1 2092.9 2457.0 2479.3 2484.4 2485.8 2170.8 2410.8 2465.7 2466.9 2469.4 2413.9 2431.8 2432.5 2433.7 2441.3 2400.8 2455.6 2466.4 2469.6 2470.6 2370.3 2392.3 2395.2 2395.5 2440.7 8978.9 9069.1 9070.4 9084.5 9087.3 5426.8 5584.9 5616.5 5620.2 5621.4 3408.5 3610.8 3685.2 3751.2 3752.7 1009.1 1031.3 1049.5 1055.8 1063.4 11992.3 12043.7 12054.7 12056.9 12115.8 4820.3 4934.2 4990.5 5032.6 5045.6 10148.7 10185.7 10211.3 10227.1 10241.3 4792.2 5605.1 5615.5 5616.7 5628.6 4476.2 5047.9 5091.9 5097.4 5117.9 3918.5 3987.6 4025.3 4050.3 4053.0 1318.2 1326.9 1334.2 1335.2 1349.4 1147.2 1147.7 1150.6 1170.1 1172.0 8047.0 8270.7 8290.5 8396.0 8397.6 1028.7 1163.0 1227.4 1231.5 1248.8 5431.6 6409.1 6486.0 6487.4 6500.3 10097.8 10303.9 10304.1 10308.1 10462.3 10184.6 10208.7 10232.8 10309.2 10321.2 8160.0 8309.6 8330.6 8384.3 8408.4 8212.9 8220.9 8253.1 8322.0 8462.4 9695.7 9724.3 9782.5 9908.7 9960.0 9971.6 10199.4 10313.6 10453.8 10485.0 6109.8 7514.8 7530.6 7597.4 7622.4 8235.6 8241.1 8299.4 8301.3 8309.2 7359.3 7468.8 7494.2 7660.1 7675.9 7341.0 7349.8 7372.4 7434.9 7537.8 7781.8 7814.4 7850.3 7855.8 7876.5 7031.3 7074.6 7098.6 7129.0 7130.6 7170.8 7195.2 7229.9 7237.7 7239.6 21:41:01 INFO - PROCESS | 1668 | 21:41:01 INFO - PROCESS | 1668 | [#4] prototype.html Cycles:180 Average:5624.96 Median:6489.21 stddev:1823.89 (28.1%) stddev-sans-first:1784.90 21:41:01 INFO - PROCESS | 1668 | Values: 312.9 319.1 325.0 326.7 327.6 6448.8 6453.2 6485.7 6522.6 6545.1 6417.2 6486.4 6490.4 6503.3 6506.5 3657.9 4634.0 4635.1 4782.5 4843.2 4022.4 4755.1 4780.2 4796.2 4808.2 4701.1 4717.9 4730.7 4745.7 4779.0 4503.1 4601.7 4694.2 4711.8 4720.5 4053.6 4055.9 4068.5 4069.8 4074.7 5024.8 6134.7 6171.2 6230.5 6255.4 4927.3 5284.2 5593.3 5597.5 5603.6 6849.5 6861.2 6867.6 6884.8 6908.5 4253.1 4432.6 4441.6 4455.5 4465.8 7082.3 7247.9 7249.2 7265.2 7268.4 4507.6 4515.4 4516.1 4516.8 4534.1 4568.1 4568.3 4568.8 4572.5 4576.6 5450.3 5454.4 5455.4 5457.7 5457.9 6638.4 6757.8 6874.3 6885.4 6912.9 1564.5 1570.9 1582.2 1588.1 1590.4 894.0 956.0 983.8 1008.9 1013.7 6305.0 6465.5 6495.0 6508.7 6536.3 6303.7 6914.9 7220.1 7223.6 7228.4 6464.4 6485.9 6488.9 6489.5 6504.2 3778.7 3822.7 3825.9 3829.0 3832.5 7183.7 7477.0 7486.6 7551.7 7564.0 7370.6 7400.2 7429.0 7430.8 7454.7 7524.8 7532.4 7550.9 7563.3 7566.1 6945.1 7190.4 7211.2 7219.7 7229.4 5800.6 7055.6 7105.2 7110.4 7132.5 5591.7 7340.4 7533.5 7555.7 7573.3 3980.5 4411.8 4516.0 4574.7 4598.0 7211.5 7242.7 7242.9 7248.8 7249.7 5890.4 6660.0 6786.0 6899.6 6968.0 6841.1 6905.7 6907.2 6929.2 6977.3 6758.6 6770.8 6773.7 6781.5 6784.7 6633.0 6928.6 6931.6 6943.7 6950.1 6490.4 6654.1 6661.6 6805.9 6869.7 21:41:01 INFO - PROCESS | 1668 | 21:41:01 INFO - PROCESS | 1668 | [#5] yui.html Cycles:180 Average:18732.00 Median:650.03 stddev:26798.42 (4122.6%) stddev-sans-first:26839.23 21:41:01 INFO - PROCESS | 1668 | Values: 658.1 695.4 714.2 734.9 805.7 17358.9 17607.9 17633.5 17635.5 17655.6 15896.9 15956.0 16035.3 16039.8 16051.7 755.2 932.3 951.1 952.3 955.4 763.1 928.0 945.3 946.4 949.0 985.8 995.5 995.6 995.8 996.9 778.3 791.5 990.4 991.2 992.6 585.0 712.4 726.5 728.1 728.2 15354.5 15372.6 15399.2 15412.8 15428.3 12519.2 12551.2 12596.7 12726.1 12755.6 9978.6 10030.0 10050.8 10141.4 10519.9 3432.5 3507.4 3515.3 3589.7 3603.5 83438.0 83944.2 85472.0 85523.6 85531.6 9353.4 9439.9 9520.4 9674.8 9717.0 21821.6 21883.9 21897.7 21917.2 22021.9 6319.1 7240.3 7303.8 7370.1 7569.4 4073.9 4130.6 4131.2 4137.2 4137.8 3638.3 3691.2 3695.2 3695.8 3696.2 643.1 647.0 653.1 673.8 673.8 511.3 568.8 596.1 599.8 608.3 7996.5 8069.3 8099.5 8163.3 8177.8 528.6 576.4 599.1 600.3 605.6 3498.4 3578.9 3708.6 3882.1 3938.1 78978.0 94852.0 96331.6 96717.0 96792.5 82209.0 82488.8 82596.6 83086.0 84520.0 71124.0 71610.0 71741.6 72328.3 73489.0 7809.6 7825.8 7943.4 8037.0 8176.4 50220.5 51637.0 51832.0 52055.5 52965.5 69336.3 71864.9 72652.6 72742.3 72754.3 10051.3 10175.7 10205.9 10233.4 10592.0 11125.3 11204.8 11341.5 11372.8 11398.7 8327.4 10259.4 10380.7 10596.7 10759.8 9087.0 10310.9 10471.8 10698.1 10790.2 10298.5 10403.6 10670.3 10718.6 10743.8 7236.9 8141.0 8976.3 9173.8 9216.6 8487.0 8621.7 8683.2 9031.7 9034.8 21:41:01 INFO - PROCESS | 1668 | -------- Summary: end -------- 21:41:01 INFO - PROCESS | 1668 | 21:41:02 INFO - TEST-INFO | 1668: exit 0 21:41:02 INFO - TEST-OK | dromaeo_css | took 1113008ms 21:41:02 INFO - TEST-START | kraken 21:41:02 INFO - operating with platform_type : mac_ 21:41:02 INFO - Initialising browser for kraken test... 21:41:02 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmpkT0O0u/profile http://localhost:49275/getInfo.html) 21:41:04 INFO - PROCESS | 1679 | __metrics Screen width/height:1600/1200 21:41:04 INFO - PROCESS | 1679 | colorDepth:24 21:41:04 INFO - PROCESS | 1679 | Browser inner width/height: 1024/689 21:41:04 INFO - PROCESS | 1679 | __metrics 21:41:04 INFO - PROCESS | 1679 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:41:04 ERROR - PROCESS | 1679 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 21:41:05 INFO - TEST-INFO | 1679: exit 0 21:41:05 INFO - Browser initialized. 21:41:05 INFO - Running cycle 1/1 for kraken test... 21:41:05 INFO - TEST-INFO | started process 1681 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmpkT0O0u/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:41:16 INFO - PROCESS | 1681 | RSS: Main: 242937856 21:41:16 INFO - PROCESS | 1681 | 21:41:19 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 21:41:20 INFO - PROCESS | 1681 | RSS: Main: 290295808 21:41:20 INFO - PROCESS | 1681 | 21:41:22 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 21:41:23 INFO - PROCESS | 1681 | RSS: Main: 299614208 21:41:23 INFO - PROCESS | 1681 | 21:41:26 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 21:41:27 INFO - PROCESS | 1681 | RSS: Main: 284729344 21:41:27 INFO - PROCESS | 1681 | 21:41:29 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 21:41:29 INFO - PROCESS | 1681 | RSS: Main: 287477760 21:41:29 INFO - PROCESS | 1681 | 21:41:31 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:41:32 INFO - PROCESS | 1681 | RSS: Main: 289923072 21:41:32 INFO - PROCESS | 1681 | 21:41:35 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 21:41:35 INFO - PROCESS | 1681 | RSS: Main: 290783232 21:41:35 INFO - PROCESS | 1681 | 21:41:38 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 21:41:39 INFO - PROCESS | 1681 | RSS: Main: 290168832 21:41:39 INFO - PROCESS | 1681 | 21:41:42 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 21:41:42 INFO - PROCESS | 1681 | RSS: Main: 290795520 21:41:42 INFO - PROCESS | 1681 | 21:41:44 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:41:44 INFO - PROCESS | 1681 | RSS: Main: 325070848 21:41:44 INFO - PROCESS | 1681 | 21:41:46 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:41:47 INFO - PROCESS | 1681 | RSS: Main: 322715648 21:41:47 INFO - PROCESS | 1681 | 21:41:49 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:41:49 INFO - PROCESS | 1681 | RSS: Main: 331976704 21:41:49 INFO - PROCESS | 1681 | 21:41:52 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:41:53 INFO - PROCESS | 1681 | RSS: Main: 331714560 21:41:53 INFO - PROCESS | 1681 | 21:41:55 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:41:56 INFO - PROCESS | 1681 | RSS: Main: 332046336 21:41:56 INFO - PROCESS | 1681 | 21:41:57 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 21:41:58 INFO - PROCESS | 1681 | RSS: Main: 392093696 21:41:58 INFO - PROCESS | 1681 | 21:41:58 INFO - PROCESS | 1681 | __start_tp_report 21:41:58 INFO - PROCESS | 1681 | _x_x_mozilla_page_load 21:41:58 INFO - PROCESS | 1681 | _x_x_mozilla_page_load_details 21:41:58 INFO - PROCESS | 1681 | |i|pagename|runs| 21:41:58 INFO - PROCESS | 1681 | |0;ai-astar;110;107;110;110;111;110;115;109;110;110 21:41:58 INFO - PROCESS | 1681 | |1;audio-beat-detection;182;146;172;196;147;173;137;116;162;119 21:41:58 INFO - PROCESS | 1681 | |2;audio-dft;188;185;185;188;185;185;186;187;188;186 21:41:58 INFO - PROCESS | 1681 | |3;audio-fft;75;75;85;78;56;58;57;86;87;82 21:41:58 INFO - PROCESS | 1681 | |4;audio-oscillator;94;100;131;81;79;85;113;77;79;115 21:41:58 INFO - PROCESS | 1681 | |5;imaging-gaussian-blur;87;85;89;86;89;84;89;86;88;85 21:41:58 INFO - PROCESS | 1681 | |6;imaging-darkroom;93;93;94;94;93;106;150;116;93;94 21:41:58 INFO - PROCESS | 1681 | |7;imaging-desaturate;86;83;89;87;85;87;88;85;106;76 21:41:58 INFO - PROCESS | 1681 | |8;json-parse-financial;55;56;53;54;54;53;75;74;55;52 21:41:58 INFO - PROCESS | 1681 | |9;json-stringify-tinderbox;61;66;80;101;69;66;66;67;67;67 21:41:58 INFO - PROCESS | 1681 | |10;stanford-crypto-aes;83;82;82;83;81;81;83;81;82;83 21:41:58 INFO - PROCESS | 1681 | |11;stanford-crypto-ccm;133;118;132;117;117;135;129;127;129;118 21:41:58 INFO - PROCESS | 1681 | |12;stanford-crypto-pbkdf2;142;128;138;138;142;128;142;137;141;139 21:41:58 INFO - PROCESS | 1681 | |13;stanford-crypto-sha256-iterative;67;68;66;68;67;68;67;67;68;66 21:41:58 INFO - PROCESS | 1681 | __end_tp_report 21:41:58 INFO - PROCESS | 1681 | __start_cc_report 21:41:58 INFO - PROCESS | 1681 | _x_x_mozilla_cycle_collect,1248 21:41:58 INFO - PROCESS | 1681 | __end_cc_report 21:41:58 INFO - PROCESS | 1681 | __startTimestamp1457502118083__endTimestamp 21:41:58 INFO - PROCESS | 1681 | 21:41:58 INFO - PROCESS | 1681 | ------- Summary: start ------- 21:41:58 INFO - PROCESS | 1681 | Number of tests: 14 21:41:58 INFO - PROCESS | 1681 | 21:41:58 INFO - PROCESS | 1681 | [#0] ai-astar Cycles:10 Average:110.20 Median:110.00 stddev:1.99 (1.8%) stddev-sans-first:2.11 21:41:58 INFO - PROCESS | 1681 | Values: 110.0 107.0 110.0 110.0 111.0 110.0 115.0 109.0 110.0 110.0 21:41:58 INFO - PROCESS | 1681 | 21:41:58 INFO - PROCESS | 1681 | [#1] audio-beat-detection Cycles:10 Average:155.00 Median:167.00 stddev:26.58 (15.9%) stddev-sans-first:26.33 21:41:58 INFO - PROCESS | 1681 | Values: 182.0 146.0 172.0 196.0 147.0 173.0 137.0 116.0 162.0 119.0 21:41:58 INFO - PROCESS | 1681 | 21:41:58 INFO - PROCESS | 1681 | [#2] audio-dft Cycles:10 Average:186.30 Median:186.50 stddev:1.34 (0.7%) stddev-sans-first:1.27 21:41:58 INFO - PROCESS | 1681 | Values: 188.0 185.0 185.0 188.0 185.0 185.0 186.0 187.0 188.0 186.0 21:41:58 INFO - PROCESS | 1681 | 21:41:58 INFO - PROCESS | 1681 | [#3] audio-fft Cycles:10 Average:73.90 Median:80.00 stddev:12.40 (15.5%) stddev-sans-first:13.15 21:41:58 INFO - PROCESS | 1681 | Values: 75.0 75.0 85.0 78.0 56.0 58.0 57.0 86.0 87.0 82.0 21:41:58 INFO - PROCESS | 1681 | 21:41:58 INFO - PROCESS | 1681 | [#4] audio-oscillator Cycles:10 Average:95.40 Median:79.00 stddev:18.79 (23.8%) stddev-sans-first:19.92 21:41:58 INFO - PROCESS | 1681 | Values: 94.0 100.0 131.0 81.0 79.0 85.0 113.0 77.0 79.0 115.0 21:41:58 INFO - PROCESS | 1681 | 21:41:58 INFO - PROCESS | 1681 | [#5] imaging-gaussian-blur Cycles:10 Average:86.80 Median:87.50 stddev:1.87 (2.1%) stddev-sans-first:1.99 21:41:58 INFO - PROCESS | 1681 | Values: 87.0 85.0 89.0 86.0 89.0 84.0 89.0 86.0 88.0 85.0 21:41:58 INFO - PROCESS | 1681 | 21:41:58 INFO - PROCESS | 1681 | [#6] imaging-darkroom Cycles:10 Average:102.60 Median:93.00 stddev:18.34 (19.7%) stddev-sans-first:19.12 21:41:58 INFO - PROCESS | 1681 | Values: 93.0 93.0 94.0 94.0 93.0 106.0 150.0 116.0 93.0 94.0 21:41:58 INFO - PROCESS | 1681 | 21:41:58 INFO - PROCESS | 1681 | [#7] imaging-desaturate Cycles:10 Average:87.20 Median:86.50 stddev:7.54 (8.7%) stddev-sans-first:7.98 21:41:58 INFO - PROCESS | 1681 | Values: 86.0 83.0 89.0 87.0 85.0 87.0 88.0 85.0 106.0 76.0 21:41:58 INFO - PROCESS | 1681 | 21:41:58 INFO - PROCESS | 1681 | [#8] json-parse-financial Cycles:10 Average:58.10 Median:55.00 stddev:8.72 (15.9%) stddev-sans-first:9.18 21:41:58 INFO - PROCESS | 1681 | Values: 55.0 56.0 53.0 54.0 54.0 53.0 75.0 74.0 55.0 52.0 21:41:58 INFO - PROCESS | 1681 | 21:41:58 INFO - PROCESS | 1681 | [#9] json-stringify-tinderbox Cycles:10 Average:71.00 Median:67.00 stddev:11.59 (17.3%) stddev-sans-first:11.71 21:41:58 INFO - PROCESS | 1681 | Values: 61.0 66.0 80.0 101.0 69.0 66.0 66.0 67.0 67.0 67.0 21:41:58 INFO - PROCESS | 1681 | 21:41:58 INFO - PROCESS | 1681 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:82.50 stddev:0.88 (1.1%) stddev-sans-first:0.87 21:41:58 INFO - PROCESS | 1681 | Values: 83.0 82.0 82.0 83.0 81.0 81.0 83.0 81.0 82.0 83.0 21:41:58 INFO - PROCESS | 1681 | 21:41:58 INFO - PROCESS | 1681 | [#11] stanford-crypto-ccm Cycles:10 Average:125.50 Median:129.00 stddev:7.25 (5.6%) stddev-sans-first:7.16 21:41:58 INFO - PROCESS | 1681 | Values: 133.0 118.0 132.0 117.0 117.0 135.0 129.0 127.0 129.0 118.0 21:41:58 INFO - PROCESS | 1681 | 21:41:58 INFO - PROCESS | 1681 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.50 Median:140.00 stddev:5.34 (3.8%) stddev-sans-first:5.41 21:41:58 INFO - PROCESS | 1681 | Values: 142.0 128.0 138.0 138.0 142.0 128.0 142.0 137.0 141.0 139.0 21:41:58 INFO - PROCESS | 1681 | 21:41:58 INFO - PROCESS | 1681 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.50 stddev:0.79 (1.2%) stddev-sans-first:0.83 21:41:58 INFO - PROCESS | 1681 | Values: 67.0 68.0 66.0 68.0 67.0 68.0 67.0 67.0 68.0 66.0 21:41:58 INFO - PROCESS | 1681 | -------- Summary: end -------- 21:41:58 INFO - PROCESS | 1681 | 21:41:58 INFO - TEST-INFO | 1681: exit 0 21:41:58 INFO - TEST-OK | kraken | took 56521ms 21:41:58 INFO - SUITE-END | took 1169s 21:41:59 INFO - Completed test suite (00:19:29) 21:41:59 INFO - javascript benchmark 21:41:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2777.527820270554, 3465.9826700866506, 3497.2830569733205, 3507.9298414031737, 3554.4668299755035, 5640.407757185498, 5647.37878833328, 5663.546916246701, 5668.773249070032, 5671.659700417973, 5571.582131340146, 5647.604667673265, 5651.491365777079, 5663.801766938158, 5671.432856714327, 5108.8978220435665, 5143.971205758863, 5160.354955630546, 5170.224466330043, 5215.895682086375, 5197.896042079156, 5211.1922651989, 5220.92168617471, 5224.216367544861, 5233.502817232356, 5125.384953805548, 5172.974135129319, 5192.71440070796, 5197.58419326453, 5204.245384419257, 5191.480851914816, 5221.216817477409, 5233.528982391565, 5253.238280449352, 5282.894342113136, 5058.570021548173, 5089.770960306795, 5098.719570423626, 5131.153359695646, 5165.405978312505, 5561.666300021971, 5563.054280772279, 5643.887122257573, 5654.434556544354, 5685.857853553694, 6221.502279817649, 6255.6872156392, 6263.123162757218, 6273.05904114382, 6290.245170579514, 6134.754609815602, 6140.925338065866, 6247.4377306042215, 6303.936960630427, 6329.208848893888, 5789.218455508494, 5790.160426738099, 5802.332731735904, 5809.7676092956235, 5847.532197424196, 6309.558330916791, 6314.463270622048, 6330.240371155491, 6330.303666596671, 6350.364963503613, 5939.10913362999, 6053.45518903292, 6087.1173679816175, 6141.723622437001, 6145.569810113249, 6157.230346206724, 6249.875022495903, 6254.3745625437095, 6262.12330273762, 6285.96857015712, 6121.989871671213, 6182.783602573888, 6183.227096612924, 6190.0405437157315, 6192.938070619326, 6093.146959425684, 6140.2281855057, 6259.374062593704, 6270.968645156745, 6276.560640755195, 4186.162767446462, 4893.290472881412, 4899.265110233494, 4900.558949694545, 4937.654364194472, 4247.299195632686, 4392.209402307615, 4401.977990110093, 4409.096135292258, 4478.193925093449, 5678.432156784371, 5680.744366503517, 5744.482996530249, 5746.913796293059, 5772.422757724194, 5774.642958904654, 6275.717592708339, 6300.59046161998, 6308.653024083719, 6314.652694101868, 5434.673919564839, 5594.216809646653, 5729.942700573024, 5732.512736417368, 5756.251687280626, 4557.475890272594, 5354.303940487712, 5358.946410535923, 5409.215663728737, 5428.240046393508, 6278.748850046039, 6289.7484100635465, 6290.559660823698, 6292.716827742855, 6295.24457065146, 6101.217066730222, 6254.937450625617, 6269.905951410641, 6294.842628934313, 6295.401936815995, 6217.658028808459, 6256.655883926428, 6287.811365659038, 6294.5593808434805, 6307.211598550181, 6166.506679465721, 6167.259928808572, 6172.290186628596, 6174.722137503913, 6180.289266734203, 6119.228375855631, 6129.141920131275, 6243.687815609293, 6272.09054687077, 6272.278687950761, 6070.7875224366935, 6102.852830488404, 6109.236345456818, 6110.923300256584, 6144.262688477412, 6044.002739548101, 6065.090236464565, 6082.239720034996, 6089.604175728564, 6116.3272040076445, 5769.567282453749, 5861.912071318849, 5918.467337939606, 5926.436988486087, 5952.226210592596, 6060.363661815446, 6084.543659225487, 6100.359462256399, 6105.481034111973, 6110.847228819315, 5875.441833025856, 5877.441643043904, 5880.911786323294, 5899.321578018411, 5940.227770389822], "unit": "score", "name": "dojo.html", "value": 5674.612811641948}, {"lowerIsBetter": false, "replicates": [487.0915742140908, 575.8474004388835, 592.6191972703601, 594.634299905558, 635.3138610300875, 30785.0, 39231.80384098079, 39513.01217469565, 39580.80209598955, 39742.20515589687, 41831.37252941208, 42253.0, 42342.36486452698, 42385.78807105968, 42454.363184552254, 9567.330286879904, 9804.901950980506, 9826.263030272723, 9833.11501964823, 9841.704748857546, 9621.470819104981, 9768.853467197998, 9769.120779129877, 9769.90230097697, 9810.21518278536, 9726.805463890718, 9945.16014537313, 9945.75135621608, 9950.30347875649, 9952.402855828637, 9840.950795246014, 9896.752581185456, 9911.207103431709, 9924.15644670204, 9928.751781205456, 9672.468014259213, 9780.51097445132, 9814.116729494379, 9818.312718109735, 9826.950865245699, 38576.22847543033, 38864.61135388666, 38900.61099388998, 38934.80532597347, 38966.415503767465, 3197.2486465680545, 3332.2502436951736, 3432.7253819694365, 3663.7618554793853, 3829.8468061277517, 28626.427471450454, 29002.27494312638, 29787.957421490144, 29794.40411191764, 29805.10584682463, 2685.946281074387, 2737.603047558093, 2762.875670594808, 2825.5055365311196, 2915.9708402915912, 379607.1019644884, 383558.0, 411798.0, 413005.0, 414341.0, 59802.70098649479, 64067.679661601396, 64603.03095453572, 64652.0, 64726.0, 68451.65774171197, 68590.65704671445, 68666.0, 68793.0, 68848.6557567209, 13997.5100871469, 15570.299336529883, 17056.48830535086, 17271.827281727274, 17281.740773888403, 9803.215742740564, 11862.22895511789, 11865.762684746429, 11911.880881191077, 13046.152000119962, 15656.757850210144, 16463.34146634121, 17257.65484690299, 20669.276575319793, 20671.896640517003, 6984.685689144001, 8183.386246031452, 8336.208060234389, 8450.154984501502, 8547.529885856213, 950.1780959470009, 969.3021024862088, 996.6113215845826, 1014.9340292880939, 1067.9839802402971, 30073.548896766566, 30077.699223007927, 30468.0, 30707.539386909215, 30732.53901191484, 1073.624231518962, 1107.828286615576, 1111.7331840358256, 1112.4326593437243, 1173.700706319883, 15371.538853834403, 15479.993800402937, 15694.450694225647, 15752.842471575366, 15857.682846343008, 660847.6957615277, 662210.0, 666930.0, 667532.0, 668453.0, 56034.87930241454, 57123.0, 57310.0, 57500.13749793756, 57580.0, 1335.4057444437326, 1364.3042048555308, 1366.3714691241942, 1463.4000059975572, 1502.346479281516, 23322.65016024727, 29769.255768605093, 30388.84805575958, 30594.541081884236, 30881.073567792104, 48228.0, 58691.70654146702, 59392.406075938685, 59396.0, 59400.108998365926, 608485.0, 612517.0, 613111.0, 613502.0, 614128.0, 35281.647183527835, 44045.33931991087, 44410.777946110065, 45050.09899802051, 45339.546604533534, 42542.78728606337, 43797.562024379346, 45977.31034034559, 46488.0, 47983.76008119937, 36349.27301454009, 36746.26507469889, 37174.44238336481, 38162.61837381591, 38835.805820970716, 35315.29369412546, 37274.63666290902, 37587.436188456646, 37852.432213516266, 38264.42603361008, 29029.709702903547, 30279.69720302857, 31723.491458829605, 33053.17367065843, 37768.0, 30849.845750771103, 31940.20149496281, 31945.041648750575, 31976.0, 32079.67920320767, 23989.76010239945, 24171.395715107265, 24324.27027189187, 24620.384490387885, 24810.751892481567], "unit": "score", "name": "ext.html", "value": 20146.286176677535}, {"lowerIsBetter": false, "replicates": [356.71641045368926, 359.1326945426794, 360.7853327270274, 368.2689860626656, 370.5386793442165, 19785.703214451794, 19987.800121998775, 20747.688784668204, 20767.96160191992, 20802.791972080275, 15889.841101588981, 20591.27930522432, 20929.47676308093, 21127.47181320464, 21129.47176320589, 5848.736806843703, 6017.7592896284095, 6071.3625069367745, 6074.149619053336, 6076.058210977306, 4264.23243816113, 4525.389072475223, 5986.491148252404, 6593.208814942213, 6601.2078550574, 6454.096426500294, 6512.446442052407, 6515.804525864231, 6520.0, 6521.673916304189, 6270.78052268173, 6394.200724909387, 6466.93533064668, 6478.4169424752, 6508.088867558546, 5544.308985759341, 5567.387587365387, 5574.219609254707, 5580.051391263495, 5588.6646801192055, 24001.87999060011, 25213.739313034457, 26376.73623263762, 26719.599206011924, 26767.0, 2117.8623389479635, 2194.2539536557647, 2337.614293641547, 2722.7005029446746, 2895.811772234798, 9527.285453591008, 10054.145397641209, 12720.300383478905, 14568.0, 15444.5366639001, 1684.8904821186584, 1687.561234079136, 1722.1561434896935, 1750.956226094345, 1834.4680042787575, 81910.72357105708, 93044.53477732636, 95093.52453237689, 97212.027879721, 98460.50769746177, 10481.528331225114, 11254.887451125547, 11278.81572434899, 11307.756146823844, 11327.830082548768, 12372.876271237352, 13853.23807190594, 13955.58133256004, 13993.860061399459, 13994.580162594935, 8612.698555550525, 8786.0, 8820.603072861737, 8880.111988801069, 8880.600372983103, 9035.186833185046, 9060.275177985877, 9068.682596109105, 9149.039350868195, 9170.174684278447, 4399.780010999437, 4467.352233926063, 4486.304622783474, 4539.273716205391, 4548.226801443762, 1815.5279627296998, 1851.7407562941198, 1858.4424672598436, 1864.133178072203, 1865.7854346750025, 839.5802098950525, 930.2232635749225, 931.3852857114272, 974.9512524373753, 1019.5666841592293, 20334.593308133753, 20677.79322206789, 20749.89625051865, 20884.895575522027, 20930.0, 934.9439033658002, 951.3578334624101, 965.2663975378622, 993.6919554937992, 998.6654470752234, 8031.317338026333, 11025.117990560735, 11139.164562657834, 11158.972732094522, 11241.66275011751, 476652.0, 484884.0, 485543.0, 540850.0, 634185.0, 95168.0, 96436.55345169827, 104400.0, 119009.80990190161, 121170.0, 904.4754042655244, 1006.6023920551341, 1022.3150489172124, 1043.639944219243, 1051.9631812886664, 16127.274272657523, 16420.917895410446, 18417.447476575726, 18792.718109228645, 18970.715439268148, 37472.0, 52805.7359713199, 53110.46889531055, 54230.45769542254, 55191.344259672274, 64679.67660161669, 66575.0, 75370.0, 78596.2140378589, 79177.60411197908, 7822.843543129219, 7836.92163078362, 8091.0, 8094.150114238156, 8436.11420800807, 10749.731256718645, 12770.936145319585, 13186.538471153464, 13356.398962046926, 13417.731645367234, 11375.748667646718, 11545.711357215801, 11569.305841649528, 11608.0, 11739.413029348669, 11221.326720396803, 11261.549538018387, 11293.0, 11459.31244125355, 11569.595064172714, 11422.543098275975, 11792.110932821513, 12077.094217933514, 12122.969547588202, 12204.023678105908, 7843.411744119328, 8048.993875765529, 8077.394195435249, 8079.474834135997, 8438.915610844058, 8517.531535765593, 11169.329840209613, 11588.899054589801, 11717.88282117168, 11898.58354957607], "unit": "score", "name": "jquery.html", "value": 9498.32841044882}, {"lowerIsBetter": false, "replicates": [1418.5460652591175, 1580.5890468478196, 1586.9127198004105, 1867.2437662746584, 1982.2566537548419, 8158.428909976304, 8378.413511054236, 8380.83238335233, 8395.0, 8855.0, 7750.8449831003345, 8690.783290339357, 8789.989151247608, 8958.23854972328, 9003.054679258665, 2092.947676308097, 2456.975430245697, 2479.2562231330617, 2484.3664865459373, 2485.7762801347876, 2170.815480684144, 2410.783029527342, 2465.716442609105, 2466.851988880664, 2469.4196863737006, 2413.855168689884, 2431.8054555635595, 2432.4891772727747, 2433.6714543536573, 2441.3286346254745, 2400.8319417640773, 2455.6193789962585, 2466.3957330453973, 2469.6172093325563, 2470.5800013997573, 2370.3007612754277, 2392.270357540949, 2395.245497668229, 2395.4610212702, 2440.7437219091917, 8978.910210897939, 9069.093090690943, 9070.365074444791, 9084.545772711404, 9087.318451116127, 5426.810061647823, 5584.91622625661, 5616.466435688603, 5620.241267428885, 5621.381648018714, 3408.4887266909914, 3610.765300255475, 3685.1708365617787, 3751.1934933989323, 3752.6622603965775, 1009.0817356205818, 1031.2729525684374, 1049.4962418039308, 1055.8152323343384, 1063.4098075568056, 11992.280463172237, 12043.698907527381, 12054.69863253417, 12056.939715301367, 12115.818262726067, 4820.34925285082, 4934.210526315772, 4990.476000020019, 5032.572231360302, 5045.621578381562, 10148.695539133838, 10185.74535636615, 10211.285210035374, 10227.130693890953, 10241.283110182365, 4792.2332426811545, 5605.1031834907035, 5615.4946054854445, 5616.747246373923, 5628.577856660767, 4476.171908196994, 5047.87380315495, 5091.9236211456855, 5097.362829646294, 5117.948820511821, 3918.4710064141545, 3987.5613682494904, 4025.335819589735, 4050.2709512287483, 4052.959470405317, 1318.1827267094463, 1326.8606796286444, 1334.2461509247244, 1335.2389138191138, 1349.3725417680826, 1147.1625713229223, 1147.73602071524, 1150.6260465348628, 1170.1399471388522, 1172.038928078967, 8047.0, 8270.669173233004, 8290.502569845828, 8396.0, 8397.580120994047, 1028.7068185567077, 1162.9825552616717, 1227.404708716272, 1231.4643130238376, 1248.7752204603078, 5431.592630552725, 6409.070684750685, 6486.027095935553, 6487.3836985486305, 6500.317466666026, 10097.83874854401, 10303.896961030443, 10304.12414944723, 10308.12380947628, 10462.267641265038, 10184.592616295413, 10208.744781380525, 10232.795344093076, 10309.226807989431, 10321.174306055498, 8160.0207975042185, 8309.626066827008, 8330.625121869409, 8384.287335576422, 8408.411411201158, 8212.876806847782, 8220.876686849822, 8253.133420990709, 8322.0, 8462.449940753831, 9695.70912872615, 9724.27067969891, 9782.510874456106, 9908.702738917844, 9960.003999599981, 9971.551280192263, 10199.439030853375, 10313.587456501657, 10453.843192352273, 10485.003924627148, 6109.7861574844665, 7514.849703006019, 7530.585817780075, 7597.392208623186, 7622.3521000713345, 8235.588220588827, 8241.134680858424, 8299.377546683902, 8301.252887240178, 8309.210624990616, 7359.337659610661, 7468.775936721907, 7494.213107623839, 7660.080790305199, 7675.923240767521, 7341.0, 7349.8162545936775, 7372.410207183305, 7434.851302973802, 7537.8115547111765, 7781.805454863674, 7814.413918955987, 7850.2542258485355, 7855.764327070197, 7876.527408355288, 7031.296870312928, 7074.610896400747, 7098.609576473137, 7129.0, 7130.607816570138, 7170.784876453715, 7195.208527062124, 7229.855402892018, 7237.674304656198, 7239.638018099179], "unit": "score", "name": "mootools.html", "value": 4973.488273607824}, {"lowerIsBetter": false, "replicates": [312.9374125174965, 319.0858191281978, 324.9593800774903, 326.67169494657867, 327.6199608454195, 6448.7742928997495, 6453.161089058422, 6485.740570377179, 6522.57603255788, 6545.116409284745, 6417.165768450095, 6486.4162225399705, 6490.415862572368, 6503.317151699074, 6506.479481641469, 3657.9451308230396, 4633.953660463403, 4635.072985402916, 4782.473927867932, 4843.200871856148, 4022.356422972325, 4755.120302743986, 4780.235162374021, 4796.232602783555, 4808.158572249842, 4701.106789709961, 4717.858464246078, 4730.6925049871825, 4745.6915300505525, 4779.02030083832, 4503.1218912312115, 4601.700889442175, 4694.178518759203, 4711.7879695413785, 4720.527947205286, 4053.5743746906446, 4055.878323650295, 4068.532118806316, 4069.837206511736, 4074.653654439376, 5024.773885175176, 6134.69326533676, 6171.166892469504, 6230.501559875244, 6255.437010669016, 4927.310176575246, 5284.207368894658, 5593.32880054392, 5597.468240517144, 5603.579731520153, 6849.452043836481, 6861.210960739479, 6867.587944723283, 6884.759033433806, 6908.481863860231, 4253.128108737701, 4432.556744325574, 4441.555844415565, 4455.487618923833, 4465.754383508905, 7082.256363081905, 7247.927520724778, 7249.238829922888, 7265.200827908926, 7268.4185265179185, 4507.57178068083, 4515.390422293014, 4516.07420478801, 4516.751578663139, 4534.115847409724, 4568.086382723469, 4568.291914753152, 4568.840090596813, 4572.45130584332, 4576.6109880660515, 5450.345958484928, 5454.427285135003, 5455.399906010336, 5457.727113644302, 5457.945420545823, 6638.369354911372, 6757.763478278335, 6874.346937040973, 6885.449164066863, 6912.861742765116, 1564.452441645415, 1570.89789163704, 1582.1614544291544, 1588.0709784775804, 1590.4194968836523, 893.9955300223457, 955.9569819358146, 983.8032393521324, 1008.8700655266002, 1013.6654903881702, 6304.959681652476, 6465.450436712838, 6495.0, 6508.674566271668, 6536.346365363521, 6303.684815759194, 6914.861702765917, 7220.0613920190035, 7223.566586004857, 7228.421726261887, 6464.353564643498, 6485.870282594322, 6488.935110648833, 6489.480841532666, 6504.1869766279215, 3778.7165962552917, 3822.655960963471, 3825.9426108608395, 3828.980855095707, 3832.5400951885395, 7183.712651493986, 7476.962615186889, 7486.5508069516, 7551.660175292125, 7563.9621801890635, 7370.594617295993, 7400.185979542246, 7428.9628551856895, 7430.814229644302, 7454.739084132138, 7524.774256772305, 7532.39740820733, 7550.924490755132, 7563.319301262913, 7566.1298950621385, 6945.131858517685, 7190.352868241884, 7211.206767255702, 7219.675114619749, 7229.385502232369, 5800.59395842287, 7055.6472176392, 7105.182903965903, 7110.395616372666, 7132.465065120033, 5591.692456914909, 7340.376068034277, 7533.472656913963, 7555.6977720890545, 7573.318401343906, 3980.5024371953505, 4411.779411029372, 4516.029053753458, 4574.679772415899, 4598.0, 7211.495195336486, 7242.710291588278, 7242.855142897218, 7248.782536523912, 7249.746258880914, 5890.381509941394, 6659.966700166468, 6785.9660701696175, 6899.551529150589, 6967.965160174167, 6841.144856892888, 6905.723771049102, 6907.240203577703, 6929.237783843874, 6977.302269773185, 6758.560693554903, 6770.796876093725, 6773.729050837911, 6781.491388145811, 6784.728610855511, 6632.966835165793, 6928.618925959121, 6931.618760967994, 6943.652817359213, 6950.096487456598, 6490.383413575702, 6654.101696270942, 6661.600303981777, 6805.93194068053, 6869.656517174221], "unit": "score", "name": "prototype.html", "value": 5010.448383109501}, {"lowerIsBetter": false, "replicates": [658.0918332700875, 695.3811108113778, 714.2143641993811, 734.9118105827301, 805.6938363421906, 17358.913205433986, 17607.943523388607, 17633.470995870113, 17635.470935871912, 17655.646887062267, 15896.920515397436, 15956.042637441762, 16035.278412471438, 16039.83960160398, 16051.678966420664, 755.1504557372955, 932.3007744191873, 951.0869565217399, 952.347641865321, 955.4124213608616, 763.0538132715449, 928.0255731481951, 945.30047764654, 946.3801210207325, 948.9715308540755, 985.8422652375622, 995.4873240281261, 995.6017592962801, 995.8257304971637, 996.8953259907714, 778.32285911257, 791.536950883728, 990.4156547636893, 991.2218908157098, 992.5682328187225, 584.9532037436995, 712.4015826705593, 726.4696771356939, 728.1007955175407, 728.1589763822793, 15354.539363819104, 15372.615684607863, 15399.23003849803, 15412.845871541365, 15428.305726242346, 12519.248845069325, 12551.246925184518, 12596.748065038739, 12726.10917235794, 12755.617331479978, 9978.600855965753, 10030.0, 10050.849237261447, 10141.44222067786, 10519.94740026295, 3432.4508078707286, 3507.3511400391008, 3515.261795023023, 3589.730770192246, 3603.513525674027, 83438.0, 83944.16055839424, 85472.0, 85523.57238213769, 85531.57234213852, 9353.438793672265, 9439.858402123973, 9520.428774273565, 9674.806503869882, 9716.951415242878, 21821.563568728852, 21883.905804709702, 21897.671534926987, 21917.232896848534, 22021.889890550443, 6319.115323854664, 7240.348368646742, 7303.780886573411, 7370.115586129698, 7569.394448444222, 4073.857414990461, 4130.607592278729, 4131.235721391552, 4137.1518838638, 4137.77242251679, 3638.290533346025, 3691.187938653492, 3695.1685870678884, 3695.8336874840697, 3696.2237930034994, 643.0900276109346, 646.9902951455732, 653.079158386682, 673.7776533743853, 673.8382788130813, 511.2688854937401, 568.8407245971134, 596.087985382357, 599.7870755881686, 608.3338744075319, 7996.480228785111, 8069.31410830086, 8099.473534220257, 8163.3061189798345, 8177.795555111051, 528.6378830501119, 576.4345246643662, 599.1103211730576, 600.3276330509857, 605.5518916002127, 3498.4052711039185, 3578.8905439313894, 3708.592054873962, 3882.1265215326325, 3938.133610605662, 78978.0, 94852.0, 96331.55502667466, 96717.0, 96792.51603741937, 82209.0, 82488.76266856003, 82596.58701706454, 83086.0, 84520.0, 71124.0, 71610.0, 71741.56516869737, 72328.27671723321, 73489.0, 7809.648565814438, 7825.765227043198, 7943.44395892282, 8037.03555573335, 8176.383557261857, 50220.49779502158, 51636.96726065382, 51832.0, 52055.47944520506, 52965.47034529605, 69336.30663693299, 71864.9220261707, 72652.63673681598, 72742.27257727567, 72754.27245727475, 10051.346662466916, 10175.7456063599, 10205.948970255102, 10233.437160956219, 10591.993760592732, 11125.332480051224, 11204.831927521256, 11341.546338146381, 11372.772544549229, 11398.658040258806, 8327.417080804285, 10259.435731034864, 10380.688579342632, 10596.735081623021, 10759.838602421127, 9086.954565227132, 10310.948445257725, 10471.790564188826, 10698.144148467949, 10790.190735694698, 10298.536565854405, 10403.58385664565, 10670.30643008202, 10718.624848130277, 10743.838842417526, 7236.89144662841, 8140.959295203486, 8976.326775491994, 9173.816523669355, 9216.585253663467, 8487.0, 8621.741347759576, 8683.175098365646, 9031.683891064044, 9034.774130646787], "unit": "score", "name": "yui.html", "value": 6886.944219403511}], "name": "dromaeo_css", "value": 7557.818524687925}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 107.0, 110.0, 110.0, 111.0, 110.0, 115.0, 109.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 110.2}, {"lowerIsBetter": true, "replicates": [182.0, 146.0, 172.0, 196.0, 147.0, 173.0, 137.0, 116.0, 162.0, 119.0], "unit": "score", "name": "audio-beat-detection", "value": 155.0}, {"lowerIsBetter": true, "replicates": [188.0, 185.0, 185.0, 188.0, 185.0, 185.0, 186.0, 187.0, 188.0, 186.0], "unit": "score", "name": "audio-dft", "value": 186.3}, {"lowerIsBetter": true, "replicates": [75.0, 75.0, 85.0, 78.0, 56.0, 58.0, 57.0, 86.0, 87.0, 82.0], "unit": "score", "name": "audio-fft", "value": 73.9}, {"lowerIsBetter": true, "replicates": [94.0, 100.0, 131.0, 81.0, 79.0, 85.0, 113.0, 77.0, 79.0, 115.0], "unit": "score", "name": "audio-oscillator", "value": 95.4}, {"lowerIsBetter": true, "replicates": [87.0, 85.0, 89.0, 86.0, 89.0, 84.0, 89.0, 86.0, 88.0, 85.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 86.8}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 94.0, 94.0, 93.0, 106.0, 150.0, 116.0, 93.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 102.6}, {"lowerIsBetter": true, "replicates": [86.0, 83.0, 89.0, 87.0, 85.0, 87.0, 88.0, 85.0, 106.0, 76.0], "unit": "score", "name": "imaging-desaturate", "value": 87.2}, {"lowerIsBetter": true, "replicates": [55.0, 56.0, 53.0, 54.0, 54.0, 53.0, 75.0, 74.0, 55.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 58.1}, {"lowerIsBetter": true, "replicates": [61.0, 66.0, 80.0, 101.0, 69.0, 66.0, 66.0, 67.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 71.0}, {"lowerIsBetter": true, "replicates": [83.0, 82.0, 82.0, 83.0, 81.0, 81.0, 83.0, 81.0, 82.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.1}, {"lowerIsBetter": true, "replicates": [133.0, 118.0, 132.0, 117.0, 117.0, 135.0, 129.0, 127.0, 129.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.5}, {"lowerIsBetter": true, "replicates": [142.0, 128.0, 138.0, 138.0, 142.0, 128.0, 142.0, 137.0, 141.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.5}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 66.0, 68.0, 67.0, 68.0, 67.0, 67.0, 68.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.2}], "name": "kraken", "value": 1438.8}]} 21:41:59 INFO - Return code: 0 21:41:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 21:41:59 ERROR - # TBPL SUCCESS # 21:41:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:41:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:41:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:41:59 INFO - 2016-03-08 21:41:59.404 screenresolution[1685:10103] starting screenresolution argv=screenresolution get 21:41:59 INFO - 2016-03-08 21:41:59.407 screenresolution[1685:10103] Display 0: 1600x1200x32@60 21:41:59 INFO - 2016-03-08 21:41:59.413 screenresolution[1686:10106] starting screenresolution argv=screenresolution list 21:41:59 INFO - Available Modes on Display 0 21:41:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:41:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:41:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:41:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:41:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:41:59 INFO - Intel Iris: 21:41:59 INFO - Chipset Model: Intel Iris 21:41:59 INFO - Type: GPU 21:41:59 INFO - Bus: Built-In 21:41:59 INFO - VRAM (Dynamic, Max): 1536 MB 21:41:59 INFO - Vendor: Intel (0x8086) 21:41:59 INFO - Device ID: 0x0a2e 21:41:59 INFO - Revision ID: 0x0009 21:41:59 INFO - Displays: 21:41:59 INFO - Display: 21:41:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:41:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:41:59 INFO - Display Serial Number: 1600x1200 60 21:41:59 INFO - Main Display: Yes 21:41:59 INFO - Mirror: Off 21:41:59 INFO - Online: Yes 21:41:59 INFO - Rotation: Supported 21:41:59 INFO - Return code: 0 21:41:59 INFO - Running post-action listener: _resource_record_post_action 21:41:59 INFO - Running post-run listener: _resource_record_post_run 21:42:00 INFO - Total resource usage - Wall time: 1205s; CPU: 53.0%; Read bytes: 39523840; Write bytes: 707041792; Read time: 434; Write time: 2081 21:42:00 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 397036032; Write bytes: 394104320; Read time: 30032; Write time: 769 21:42:00 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 37725696; Write bytes: 299355136; Read time: 416; Write time: 1278 21:42:00 INFO - Running post-run listener: _upload_blobber_files 21:42:00 INFO - Blob upload gear active. 21:42:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:42:00 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 21:42:00 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'] 21:42:00 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 21:42:01 INFO - (blobuploader) - INFO - Open directory for files ... 21:42:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:42:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:42:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:42:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:42:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:42:01 INFO - (blobuploader) - INFO - Done attempting. 21:42:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:42:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:42:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:42:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:42:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:42:03 INFO - (blobuploader) - INFO - Done attempting. 21:42:03 INFO - (blobuploader) - INFO - Iteration through files over. 21:42:03 INFO - Return code: 0 21:42:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:42:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:42:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8ecf2e3a67618e76857f8e9fa2830f6952ceb6356f489e2bcfed7015ac371b825334f0635a9642b9ca4083a079a95f91af580feab27ae0e68d7049ca1afe9544", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cf74cb8c9e1a96dc755afb65f1b160414f05a41b563fb635674e3a18e2cc5e70e4c741c7935f587cb1acb855dcb12ab8a6c7df6e2bf25143f4be5b78b9e4adc8"} 21:42:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:42:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:42:03 INFO - Contents: 21:42:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8ecf2e3a67618e76857f8e9fa2830f6952ceb6356f489e2bcfed7015ac371b825334f0635a9642b9ca4083a079a95f91af580feab27ae0e68d7049ca1afe9544", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cf74cb8c9e1a96dc755afb65f1b160414f05a41b563fb635674e3a18e2cc5e70e4c741c7935f587cb1acb855dcb12ab8a6c7df6e2bf25143f4be5b78b9e4adc8"} 21:42:03 INFO - Running post-run listener: copy_logs_to_upload_dir 21:42:03 INFO - Copying logs to upload dir... 21:42:03 INFO - mkdir: /builds/slave/test/build/upload/logs 21:42:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.788018 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-03-08 21:42:03.104708) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-08 21:42:03.108533) ========= 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.2fYdLJmjEG/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.erlyQd39C3/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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/8ecf2e3a67618e76857f8e9fa2830f6952ceb6356f489e2bcfed7015ac371b825334f0635a9642b9ca4083a079a95f91af580feab27ae0e68d7049ca1afe9544", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cf74cb8c9e1a96dc755afb65f1b160414f05a41b563fb635674e3a18e2cc5e70e4c741c7935f587cb1acb855dcb12ab8a6c7df6e2bf25143f4be5b78b9e4adc8"} build_url:https://queue.taskcluster.net/v1/task/MYQiA5a_TXS2JsozWhcFCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011252 build_url: 'https://queue.taskcluster.net/v1/task/MYQiA5a_TXS2JsozWhcFCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8ecf2e3a67618e76857f8e9fa2830f6952ceb6356f489e2bcfed7015ac371b825334f0635a9642b9ca4083a079a95f91af580feab27ae0e68d7049ca1afe9544", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cf74cb8c9e1a96dc755afb65f1b160414f05a41b563fb635674e3a18e2cc5e70e4c741c7935f587cb1acb855dcb12ab8a6c7df6e2bf25143f4be5b78b9e4adc8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-08 21:42:03.142183) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 21:42:03.142508) ========= 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.2fYdLJmjEG/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.erlyQd39C3/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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.005001 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 21:42:03.191146) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-08 21:42:03.191455) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-08 21:42:03.191956) ========= ========= Total master_lag: 0.27 =========