builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0118 starttime: 1464868189.13 results: success (0) buildid: 20160602025051 builduid: 97a509b54c39477e958e73416d639535 revision: bf9266fa9187c6ec6bb7935f51573fe8d7336ea5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 04:49:49.126891) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 04:49:49.127804) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 04:49:49.128578) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 04:49:49.151191) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 04:49:49.151898) ========= 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.VXA8m0gRY8/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.WckHtTDF0V/Listeners TMPDIR=/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/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-06-02 04:49:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.37M=0.001s 2016-06-02 04:49:49 (8.37 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.332470 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 04:49:49.506046) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 04:49:49.506426) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VXA8m0gRY8/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.WckHtTDF0V/Listeners TMPDIR=/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/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.020668 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 04:49:49.555396) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 04:49:49.555779) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev bf9266fa9187c6ec6bb7935f51573fe8d7336ea5 --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 bf9266fa9187c6ec6bb7935f51573fe8d7336ea5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VXA8m0gRY8/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.WckHtTDF0V/Listeners TMPDIR=/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/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-06-02 04:49:49,627 truncating revision to first 12 chars 2016-06-02 04:49:49,627 Setting DEBUG logging. 2016-06-02 04:49:49,627 attempt 1/10 2016-06-02 04:49:49,627 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/bf9266fa9187?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-02 04:49:49,948 unpacking tar archive at: fx-team-bf9266fa9187/testing/mozharness/ program finished with exit code 0 elapsedTime=0.569663 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 04:49:50.145379) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 04:49:50.145744) ========= script_repo_revision: bf9266fa9187c6ec6bb7935f51573fe8d7336ea5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 04:49:50.146193) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 04:49:50.146516) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 04:49:50.162893) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 24 mins, 40 secs) (at 2016-06-02 04:49:50.163239) ========= /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.VXA8m0gRY8/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.WckHtTDF0V/Listeners TMPDIR=/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:49:50 INFO - MultiFileLogger online at 20160602 04:49:50 in /builds/slave/test 04:49:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 04:49:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:49:50 INFO - {'append_to_log': False, 04:49:50 INFO - 'base_work_dir': '/builds/slave/test', 04:49:50 INFO - 'blob_upload_branch': 'Fx-Team', 04:49:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:49:50 INFO - 'branch': 'Fx-Team', 04:49:50 INFO - 'buildbot_json_path': 'buildprops.json', 04:49:50 INFO - 'config_files': ('talos/mac_config.py',), 04:49:50 INFO - 'default_actions': ('clobber', 04:49:50 INFO - 'read-buildbot-config', 04:49:50 INFO - 'download-and-extract', 04:49:50 INFO - 'populate-webroot', 04:49:50 INFO - 'create-virtualenv', 04:49:50 INFO - 'install', 04:49:50 INFO - 'run-tests'), 04:49:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:49:50 INFO - 'download_minidump_stackwalk': True, 04:49:50 INFO - 'download_symbols': 'ondemand', 04:49:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:49:50 INFO - 'tooltool.py': '/tools/tooltool.py', 04:49:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:49:50 INFO - '/tools/misc-python/virtualenv.py')}, 04:49:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:49:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:49:50 INFO - 'installer_path': 'installer.exe', 04:49:50 INFO - 'log_level': 'info', 04:49:50 INFO - 'log_name': 'talos', 04:49:50 INFO - 'log_to_console': True, 04:49:50 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:49:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:49:50 INFO - 'opt_config_files': (), 04:49:50 INFO - 'pip_index': False, 04:49:50 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:49:50 INFO - 'cmd': ('bash', 04:49:50 INFO - '-c', 04:49:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:49:50 INFO - 'enabled': True, 04:49:50 INFO - 'halt_on_failure': False, 04:49:50 INFO - 'name': 'check_screen_resolution'},), 04:49:50 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:49:50 INFO - 'cmd': ('bash', 04:49:50 INFO - '-c', 04:49:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:49:50 INFO - 'enabled': True, 04:49:50 INFO - 'halt_on_failure': False, 04:49:50 INFO - 'name': 'check_screen_resolution'},), 04:49:50 INFO - 'run_cmd_checks_enabled': True, 04:49:50 INFO - 'sps_profile': False, 04:49:50 INFO - 'sps_profile_interval': 0, 04:49:50 INFO - 'suite': 'dromaeojs', 04:49:50 INFO - 'system_bits': '32', 04:49:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:49:50 INFO - 'title': 't-yosemite-r7-0118', 04:49:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:49:50 INFO - 'use_talos_json': True, 04:49:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:49:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:49:50 INFO - 'work_dir': 'build'} 04:49:50 INFO - ##### 04:49:50 INFO - ##### Running clobber step. 04:49:50 INFO - ##### 04:49:50 INFO - Running pre-action listener: _resource_record_pre_action 04:49:50 INFO - Running main action method: clobber 04:49:50 INFO - rmtree: /builds/slave/test/build 04:49:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:49:52 INFO - Running post-action listener: _resource_record_post_action 04:49:52 INFO - ##### 04:49:52 INFO - ##### Finished clobber step (success) 04:49:52 INFO - ##### 04:49:52 INFO - ##### 04:49:52 INFO - ##### Running read-buildbot-config step. 04:49:52 INFO - ##### 04:49:52 INFO - Running pre-action listener: _resource_record_pre_action 04:49:52 INFO - Running main action method: read_buildbot_config 04:49:52 INFO - Using buildbot properties: 04:49:52 INFO - { 04:49:52 INFO - "project": "", 04:49:52 INFO - "product": "firefox", 04:49:52 INFO - "script_repo_revision": "production", 04:49:52 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 04:49:52 INFO - "repository": "", 04:49:52 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 04:49:52 INFO - "buildid": "20160602025051", 04:49:52 INFO - "pgo_build": "False", 04:49:52 INFO - "basedir": "/builds/slave/test", 04:49:52 INFO - "buildnumber": 31, 04:49:52 INFO - "slavename": "t-yosemite-r7-0118", 04:49:52 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 04:49:52 INFO - "platform": "yosemite_r7", 04:49:52 INFO - "scheduler": "tests-fx-team-macosx64-talos", 04:49:52 INFO - "branch": "fx-team", 04:49:52 INFO - "repo_path": "integration/fx-team", 04:49:52 INFO - "revision": "bf9266fa9187c6ec6bb7935f51573fe8d7336ea5", 04:49:52 INFO - "stage_platform": "macosx64", 04:49:52 INFO - "builduid": "97a509b54c39477e958e73416d639535", 04:49:52 INFO - "slavebuilddir": "test" 04:49:52 INFO - } 04:49:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/WmJ4ZOLdSTqvVE78bxgnXw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 04:49:52 INFO - Running post-action listener: _resource_record_post_action 04:49:52 INFO - ##### 04:49:52 INFO - ##### Finished read-buildbot-config step (success) 04:49:52 INFO - ##### 04:49:52 INFO - ##### 04:49:52 INFO - ##### Running download-and-extract step. 04:49:52 INFO - ##### 04:49:52 INFO - Running pre-action listener: _resource_record_pre_action 04:49:52 INFO - Running main action method: download_and_extract 04:49:52 INFO - mkdir: /builds/slave/test/build/tests 04:49:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:52 INFO - https://queue.taskcluster.net/v1/task/WmJ4ZOLdSTqvVE78bxgnXw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 04:49:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmJ4ZOLdSTqvVE78bxgnXw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 04:49:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmJ4ZOLdSTqvVE78bxgnXw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 04:49:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmJ4ZOLdSTqvVE78bxgnXw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 04:49:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmJ4ZOLdSTqvVE78bxgnXw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #1 04:50:23 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmJ4ZOLdSTqvVE78bxgnXw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json: timed out 04:50:23 INFO - retry: attempt #1 caught exception: timed out 04:50:23 INFO - retry: Failed, sleeping 30 seconds before retrying 04:50:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmJ4ZOLdSTqvVE78bxgnXw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #2 04:51:23 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmJ4ZOLdSTqvVE78bxgnXw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json: timed out 04:51:23 INFO - retry: attempt #2 caught exception: timed out 04:51:23 INFO - retry: Failed, sleeping 60 seconds before retrying 04:52:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmJ4ZOLdSTqvVE78bxgnXw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #3 04:52:37 INFO - Downloaded 1199 bytes. 04:52:37 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 04:52:37 INFO - Using the following test package requirements: 04:52:37 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 04:52:37 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 04:52:37 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 04:52:37 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 04:52:37 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 04:52:37 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 04:52:37 INFO - u'jsshell-mac.zip'], 04:52:37 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 04:52:37 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 04:52:37 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 04:52:37 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 04:52:37 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 04:52:37 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 04:52:37 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 04:52:37 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 04:52:37 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 04:52:37 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 04:52:37 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 04:52:37 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:52:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:37 INFO - https://queue.taskcluster.net/v1/task/WmJ4ZOLdSTqvVE78bxgnXw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:52:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmJ4ZOLdSTqvVE78bxgnXw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 04:52:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmJ4ZOLdSTqvVE78bxgnXw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 04:52:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmJ4ZOLdSTqvVE78bxgnXw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 04:52:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmJ4ZOLdSTqvVE78bxgnXw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:52:48 INFO - Downloaded 18697473 bytes. 04:52:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:52:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:52:51 INFO - Return code: 0 04:52:51 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip', u'firefox-49.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:52:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:51 INFO - https://queue.taskcluster.net/v1/task/WmJ4ZOLdSTqvVE78bxgnXw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:52:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmJ4ZOLdSTqvVE78bxgnXw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 04:52:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmJ4ZOLdSTqvVE78bxgnXw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 04:52:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmJ4ZOLdSTqvVE78bxgnXw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 04:52:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmJ4ZOLdSTqvVE78bxgnXw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:53:02 INFO - Downloaded 18697473 bytes. 04:53:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:53:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:53:06 INFO - Return code: 0 04:53:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:06 INFO - https://queue.taskcluster.net/v1/task/WmJ4ZOLdSTqvVE78bxgnXw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:53:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmJ4ZOLdSTqvVE78bxgnXw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 04:53:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmJ4ZOLdSTqvVE78bxgnXw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 04:53:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmJ4ZOLdSTqvVE78bxgnXw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip 04:53:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmJ4ZOLdSTqvVE78bxgnXw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:53:15 INFO - Downloaded 10834055 bytes. 04:53:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:53:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 04:53:15 INFO - Return code: 0 04:53:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:15 INFO - https://queue.taskcluster.net/v1/task/WmJ4ZOLdSTqvVE78bxgnXw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 04:53:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmJ4ZOLdSTqvVE78bxgnXw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 04:53:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmJ4ZOLdSTqvVE78bxgnXw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 04:53:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmJ4ZOLdSTqvVE78bxgnXw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 04:53:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmJ4ZOLdSTqvVE78bxgnXw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg'}, attempt #1 04:53:28 INFO - Downloaded 111048747 bytes. 04:53:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WmJ4ZOLdSTqvVE78bxgnXw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 04:53:28 INFO - mkdir: /builds/slave/test/properties 04:53:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:53:28 INFO - Writing to file /builds/slave/test/properties/build_url 04:53:28 INFO - Contents: 04:53:28 INFO - build_url:https://queue.taskcluster.net/v1/task/WmJ4ZOLdSTqvVE78bxgnXw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 04:53:38 INFO - Running post-action listener: _resource_record_post_action 04:53:38 INFO - Running post-action listener: set_extra_try_arguments 04:53:38 INFO - ##### 04:53:38 INFO - ##### Finished download-and-extract step (success) 04:53:38 INFO - ##### 04:53:38 INFO - ##### 04:53:38 INFO - ##### Running populate-webroot step. 04:53:38 INFO - ##### 04:53:38 INFO - Running pre-action listener: _resource_record_pre_action 04:53:38 INFO - Running main action method: populate_webroot 04:53:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:53:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:53:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:53:38 INFO - '--tppagecycles', 04:53:38 INFO - '7'], 04:53:38 INFO - 'tests': ['tsvgm']}}, 04:53:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:53:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:53:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:53:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:53:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:53:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:53:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:38 INFO - 'talos_options': ['--disable-e10s'], 04:53:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:53:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:53:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:38 INFO - 'talos_options': ['--disable-e10s'], 04:53:38 INFO - 'tests': ['damp', 'tps']}, 04:53:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:38 INFO - 'tests': ['damp', 'tps']}, 04:53:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:53:38 INFO - 'tests': ['dromaeo_dom']}, 04:53:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:53:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:53:38 INFO - 'tests': ['a11yr', 04:53:38 INFO - 'ts_paint', 04:53:38 INFO - 'tpaint', 04:53:38 INFO - 'sessionrestore', 04:53:38 INFO - 'sessionrestore_no_auto_restore', 04:53:38 INFO - 'tabpaint']}, 04:53:38 INFO - 'other-e10s': {'tests': ['a11yr', 04:53:38 INFO - 'ts_paint', 04:53:38 INFO - 'tpaint', 04:53:38 INFO - 'sessionrestore', 04:53:38 INFO - 'sessionrestore_no_auto_restore', 04:53:38 INFO - 'tabpaint']}, 04:53:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:53:38 INFO - 'ts_paint', 04:53:38 INFO - 'tpaint', 04:53:38 INFO - 'sessionrestore', 04:53:38 INFO - 'sessionrestore_no_auto_restore', 04:53:38 INFO - 'tabpaint']}, 04:53:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:53:38 INFO - 'ts_paint', 04:53:38 INFO - 'tpaint', 04:53:38 INFO - 'sessionrestore', 04:53:38 INFO - 'sessionrestore_no_auto_restore', 04:53:38 INFO - 'tabpaint']}, 04:53:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:53:38 INFO - 'tests': ['a11yr', 04:53:38 INFO - 'ts_paint', 04:53:38 INFO - 'tpaint', 04:53:38 INFO - 'sessionrestore', 04:53:38 INFO - 'sessionrestore_no_auto_restore', 04:53:38 INFO - 'tabpaint']}, 04:53:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:53:38 INFO - 'tests': ['a11yr', 04:53:38 INFO - 'ts_paint', 04:53:38 INFO - 'tpaint', 04:53:38 INFO - 'sessionrestore', 04:53:38 INFO - 'sessionrestore_no_auto_restore', 04:53:38 INFO - 'tabpaint']}, 04:53:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:53:38 INFO - 'tests': ['tsvgx', 04:53:38 INFO - 'tsvgr_opacity', 04:53:38 INFO - 'tart', 04:53:38 INFO - 'tscrollx', 04:53:38 INFO - 'cart']}, 04:53:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:53:38 INFO - 'tsvgr_opacity', 04:53:38 INFO - 'tart', 04:53:38 INFO - 'tscrollx', 04:53:38 INFO - 'cart']}, 04:53:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:38 INFO - 'talos_options': ['--disable-e10s'], 04:53:38 INFO - 'tests': ['tp5o']}, 04:53:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:38 INFO - 'tests': ['tp5o']}, 04:53:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:38 INFO - 'talos_options': ['--disable-e10s', 04:53:38 INFO - '--xperf_path', 04:53:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:53:38 INFO - 'tests': ['tp5n']}, 04:53:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:38 INFO - 'talos_options': ['--xperf_path', 04:53:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:53:38 INFO - 'tests': ['tp5n']}}, 04:53:38 INFO - 'talos.zip': {'path': '', 04:53:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:53:38 INFO - Running post-action listener: _resource_record_post_action 04:53:38 INFO - ##### 04:53:38 INFO - ##### Finished populate-webroot step (success) 04:53:38 INFO - ##### 04:53:38 INFO - ##### 04:53:38 INFO - ##### Running create-virtualenv step. 04:53:38 INFO - ##### 04:53:38 INFO - Running pre-action listener: _resource_record_pre_action 04:53:38 INFO - Running main action method: create_virtualenv 04:53:38 INFO - Creating virtualenv /builds/slave/test/build/venv 04:53:38 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:53:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:53:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:53:38 INFO - Using real prefix '/tools/python27' 04:53:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:53:38 INFO - Installing distribute.............................................................................................................................................................................................done. 04:53:41 INFO - Installing pip.................done. 04:53:41 INFO - Return code: 0 04:53:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:53:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10397da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103983570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae295b6a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103821d30>, '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 0x103645db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103818b20>, '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.VXA8m0gRY8/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.WckHtTDF0V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:53:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:53:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:53:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VXA8m0gRY8/Render', 04:53:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:42 INFO - 'HOME': '/Users/cltbld', 04:53:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:42 INFO - 'LOGNAME': 'cltbld', 04:53:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:42 INFO - 'MOZ_NO_REMOTE': '1', 04:53:42 INFO - 'NO_EM_RESTART': '1', 04:53:42 INFO - 'PAGER': '/bin/cat', 04:53:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:42 INFO - 'PWD': '/builds/slave/test', 04:53:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:42 INFO - 'SHELL': '/bin/bash', 04:53:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WckHtTDF0V/Listeners', 04:53:42 INFO - 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', 04:53:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:42 INFO - 'USER': 'cltbld', 04:53:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:42 INFO - 'XPC_FLAGS': '0x0', 04:53:42 INFO - 'XPC_SERVICE_NAME': '0', 04:53:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:42 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:53:42 INFO - Cleaning up... 04:53:42 INFO - Return code: 0 04:53:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:53:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10397da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103983570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae295b6a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103821d30>, '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 0x103645db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103818b20>, '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.VXA8m0gRY8/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.WckHtTDF0V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:53:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:53:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:53:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VXA8m0gRY8/Render', 04:53:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:42 INFO - 'HOME': '/Users/cltbld', 04:53:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:42 INFO - 'LOGNAME': 'cltbld', 04:53:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:42 INFO - 'MOZ_NO_REMOTE': '1', 04:53:42 INFO - 'NO_EM_RESTART': '1', 04:53:42 INFO - 'PAGER': '/bin/cat', 04:53:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:42 INFO - 'PWD': '/builds/slave/test', 04:53:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:42 INFO - 'SHELL': '/bin/bash', 04:53:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WckHtTDF0V/Listeners', 04:53:42 INFO - 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', 04:53:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:42 INFO - 'USER': 'cltbld', 04:53:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:42 INFO - 'XPC_FLAGS': '0x0', 04:53:42 INFO - 'XPC_SERVICE_NAME': '0', 04:53:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:42 INFO - Downloading/unpacking psutil>=3.1.1 04:53: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 04:53: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 04:53: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 04:53: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 04:53: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 04:53: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 04:53:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:53:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:53:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:53:45 INFO - Installing collected packages: psutil 04:53:45 INFO - Running setup.py install for psutil 04:53:45 INFO - building 'psutil._psutil_osx' extension 04:53:45 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:53:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:53:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:53:46 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:53:46 INFO - building 'psutil._psutil_posix' extension 04:53:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:53:46 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:53:46 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:53:46 INFO - ^ 04:53:46 INFO - 1 warning generated. 04:53:46 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:53:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:53:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:53:46 INFO - Successfully installed psutil 04:53:46 INFO - Cleaning up... 04:53:46 INFO - Return code: 0 04:53:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:53:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10397da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103983570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae295b6a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103821d30>, '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 0x103645db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103818b20>, '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.VXA8m0gRY8/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.WckHtTDF0V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:53:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:53:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:53:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VXA8m0gRY8/Render', 04:53:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:46 INFO - 'HOME': '/Users/cltbld', 04:53:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:46 INFO - 'LOGNAME': 'cltbld', 04:53:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:46 INFO - 'MOZ_NO_REMOTE': '1', 04:53:46 INFO - 'NO_EM_RESTART': '1', 04:53:46 INFO - 'PAGER': '/bin/cat', 04:53:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:46 INFO - 'PWD': '/builds/slave/test', 04:53:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:46 INFO - 'SHELL': '/bin/bash', 04:53:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WckHtTDF0V/Listeners', 04:53:46 INFO - 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', 04:53:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:46 INFO - 'USER': 'cltbld', 04:53:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:46 INFO - 'XPC_FLAGS': '0x0', 04:53:46 INFO - 'XPC_SERVICE_NAME': '0', 04:53:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:53:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:53:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:53:49 INFO - Installing collected packages: mozsystemmonitor 04:53:49 INFO - Running setup.py install for mozsystemmonitor 04:53:49 INFO - Successfully installed mozsystemmonitor 04:53:49 INFO - Cleaning up... 04:53:49 INFO - Return code: 0 04:53:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:53: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')]} 04:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53: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')]} 04:53:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53: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', '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 0x10397da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103983570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae295b6a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103821d30>, '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 0x103645db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103818b20>, '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.VXA8m0gRY8/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.WckHtTDF0V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:53: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:53: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 blobuploader==1.2.4 04:53:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VXA8m0gRY8/Render', 04:53:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:49 INFO - 'HOME': '/Users/cltbld', 04:53:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:49 INFO - 'LOGNAME': 'cltbld', 04:53:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:49 INFO - 'MOZ_NO_REMOTE': '1', 04:53:49 INFO - 'NO_EM_RESTART': '1', 04:53:49 INFO - 'PAGER': '/bin/cat', 04:53:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:49 INFO - 'PWD': '/builds/slave/test', 04:53:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:49 INFO - 'SHELL': '/bin/bash', 04:53:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WckHtTDF0V/Listeners', 04:53:49 INFO - 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', 04:53:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:49 INFO - 'USER': 'cltbld', 04:53:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:49 INFO - 'XPC_FLAGS': '0x0', 04:53:49 INFO - 'XPC_SERVICE_NAME': '0', 04:53:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:49 INFO - Downloading/unpacking blobuploader==1.2.4 04:53: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 04:53: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 04:53: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 04:53: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 04:53: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 04:53: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 04:53:52 INFO - Downloading blobuploader-1.2.4.tar.gz 04:53:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:53:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:53: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 04:53: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 04:53: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 04:53: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 04:53: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 04:53: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 04:53:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:53:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:53 INFO - Downloading docopt-0.6.1.tar.gz 04:53:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:53:53 INFO - Installing collected packages: blobuploader, requests, docopt 04:53:53 INFO - Running setup.py install for blobuploader 04:53:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:53:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:53:53 INFO - Running setup.py install for requests 04:53:54 INFO - Running setup.py install for docopt 04:53:54 INFO - Successfully installed blobuploader requests docopt 04:53:54 INFO - Cleaning up... 04:53:54 INFO - Return code: 0 04:53:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:53:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:54 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 0x10397da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103983570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae295b6a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103821d30>, '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 0x103645db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103818b20>, '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.VXA8m0gRY8/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.WckHtTDF0V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:53:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:53:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:53:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VXA8m0gRY8/Render', 04:53:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:54 INFO - 'HOME': '/Users/cltbld', 04:53:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:54 INFO - 'LOGNAME': 'cltbld', 04:53:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:54 INFO - 'MOZ_NO_REMOTE': '1', 04:53:54 INFO - 'NO_EM_RESTART': '1', 04:53:54 INFO - 'PAGER': '/bin/cat', 04:53:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:54 INFO - 'PWD': '/builds/slave/test', 04:53:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:54 INFO - 'SHELL': '/bin/bash', 04:53:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WckHtTDF0V/Listeners', 04:53:54 INFO - 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', 04:53:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:54 INFO - 'USER': 'cltbld', 04:53:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:54 INFO - 'XPC_FLAGS': '0x0', 04:53:54 INFO - 'XPC_SERVICE_NAME': '0', 04:53:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:53:54 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-zTOjrV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:53:54 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-gZYAJO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:53:55 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-qpygVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:53:55 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-Oz2FYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:53:55 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-3flyR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:53:55 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-l6_fpB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:53:55 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-B3rF5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:53:55 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-5vPXM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:53:55 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-IzPIkG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:53:55 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-4CjbTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:53:55 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-WeeiGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:53:55 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-E8EPXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:53:56 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-cPi0d7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:53:56 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-9go0d3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:56 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-hAnAth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:53:56 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-UeZx5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:53:56 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-Wt7Viu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:53:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:53:56 INFO - Running setup.py install for manifestparser 04:53:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:53:56 INFO - Running setup.py install for mozcrash 04:53:56 INFO - Running setup.py install for mozdebug 04:53:57 INFO - Running setup.py install for mozdevice 04:53:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:53:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:53:57 INFO - Running setup.py install for mozfile 04:53:57 INFO - Running setup.py install for mozhttpd 04:53:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:53:57 INFO - Running setup.py install for mozinfo 04:53:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:53:57 INFO - Running setup.py install for mozInstall 04:53:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:53:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:53:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:53:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:53:57 INFO - Running setup.py install for mozleak 04:53:57 INFO - Running setup.py install for mozlog 04:53:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:53:58 INFO - Running setup.py install for moznetwork 04:53:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:53:58 INFO - Running setup.py install for mozprocess 04:53:58 INFO - Running setup.py install for mozprofile 04:53:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:53:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:53:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:53:58 INFO - Running setup.py install for mozrunner 04:53:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:53:58 INFO - Running setup.py install for mozscreenshot 04:53:58 INFO - Running setup.py install for moztest 04:53:58 INFO - Running setup.py install for mozversion 04:53:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:53:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:53:59 INFO - Cleaning up... 04:53:59 INFO - Return code: 0 04:53:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:53:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:59 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 0x10397da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103983570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae295b6a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103821d30>, '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 0x103645db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103818b20>, '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.VXA8m0gRY8/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.WckHtTDF0V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:53:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:53:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:53:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VXA8m0gRY8/Render', 04:53:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:59 INFO - 'HOME': '/Users/cltbld', 04:53:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:59 INFO - 'LOGNAME': 'cltbld', 04:53:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:59 INFO - 'MOZ_NO_REMOTE': '1', 04:53:59 INFO - 'NO_EM_RESTART': '1', 04:53:59 INFO - 'PAGER': '/bin/cat', 04:53:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:59 INFO - 'PWD': '/builds/slave/test', 04:53:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:59 INFO - 'SHELL': '/bin/bash', 04:53:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WckHtTDF0V/Listeners', 04:53:59 INFO - 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', 04:53:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:59 INFO - 'USER': 'cltbld', 04:53:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:59 INFO - 'XPC_FLAGS': '0x0', 04:53:59 INFO - 'XPC_SERVICE_NAME': '0', 04:53:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:53:59 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-puZp0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:53:59 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:53:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:53:59 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-ylYBri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:53:59 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)) 04:53:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:53:59 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-kaJ6IV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:53:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:53:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:53:59 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-QPWbRc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:53:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:53:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:53:59 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-rEa1po-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:53:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:53:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:53:59 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-S5BrAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:54:00 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-jXsp_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:54:00 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-BRjz9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:54:00 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-mgwtQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:54:00 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-8F1Rxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:54:00 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-dpi7Cy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:54:00 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-w90cu4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:54:00 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-Rj1bU5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:54:00 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-JGBzgj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:54:00 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-tfCpNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:54:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:54:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:54:01 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-hkZyvI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:54:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:54:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:54:01 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-rOXsH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:54:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:54:01 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)) 04:54:01 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)) 04:54:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:54:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:54:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:54:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:03 INFO - Downloading blessings-1.6.tar.gz 04:54:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:54:03 INFO - Installing collected packages: blessings 04:54:03 INFO - Running setup.py install for blessings 04:54:03 INFO - Successfully installed blessings 04:54:03 INFO - Cleaning up... 04:54:03 INFO - Return code: 0 04:54:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:54:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:54:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:54:04 INFO - Reading from file tmpfile_stdout 04:54:04 INFO - Current package versions: 04:54:04 INFO - blessings == 1.6 04:54:04 INFO - blobuploader == 1.2.4 04:54:04 INFO - docopt == 0.6.1 04:54:04 INFO - manifestparser == 1.1 04:54:04 INFO - mozInstall == 1.12 04:54:04 INFO - mozcrash == 0.17 04:54:04 INFO - mozdebug == 0.1 04:54:04 INFO - mozdevice == 0.48 04:54:04 INFO - mozfile == 1.2 04:54:04 INFO - mozhttpd == 0.7 04:54:04 INFO - mozinfo == 0.9 04:54:04 INFO - mozleak == 0.1 04:54:04 INFO - mozlog == 3.2 04:54:04 INFO - moznetwork == 0.27 04:54:04 INFO - mozprocess == 0.22 04:54:04 INFO - mozprofile == 0.28 04:54:04 INFO - mozrunner == 6.11 04:54:04 INFO - mozscreenshot == 0.1 04:54:04 INFO - mozsystemmonitor == 0.3 04:54:04 INFO - moztest == 0.7 04:54:04 INFO - mozversion == 1.4 04:54:04 INFO - psutil == 3.1.1 04:54:04 INFO - requests == 1.2.3 04:54:04 INFO - wsgiref == 0.1.2 04:54:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:54:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:04 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 0x10397da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103983570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae295b6a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103821d30>, '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 0x103645db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103818b20>, '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.VXA8m0gRY8/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.WckHtTDF0V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:54:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:54:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:54:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VXA8m0gRY8/Render', 04:54:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:54:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:54:04 INFO - 'HOME': '/Users/cltbld', 04:54:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:54:04 INFO - 'LOGNAME': 'cltbld', 04:54:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:04 INFO - 'MOZ_NO_REMOTE': '1', 04:54:04 INFO - 'NO_EM_RESTART': '1', 04:54:04 INFO - 'PAGER': '/bin/cat', 04:54:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:54:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:04 INFO - 'PWD': '/builds/slave/test', 04:54:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:54:04 INFO - 'SHELL': '/bin/bash', 04:54:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WckHtTDF0V/Listeners', 04:54:04 INFO - 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', 04:54:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:54:04 INFO - 'USER': 'cltbld', 04:54:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:54:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:54:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:04 INFO - 'XPC_FLAGS': '0x0', 04:54:04 INFO - 'XPC_SERVICE_NAME': '0', 04:54:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:54:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:54:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:54:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:54:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:54:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:54:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:54:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:54:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:54:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:54:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:54:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:54:04 INFO - Cleaning up... 04:54:04 INFO - Return code: 0 04:54:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:54:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10397da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103983570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae295b6a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103821d30>, '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 0x103645db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103818b20>, '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.VXA8m0gRY8/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.WckHtTDF0V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:54:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:54:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:54:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VXA8m0gRY8/Render', 04:54:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:54:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:54:04 INFO - 'HOME': '/Users/cltbld', 04:54:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:54:04 INFO - 'LOGNAME': 'cltbld', 04:54:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:04 INFO - 'MOZ_NO_REMOTE': '1', 04:54:04 INFO - 'NO_EM_RESTART': '1', 04:54:04 INFO - 'PAGER': '/bin/cat', 04:54:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:54:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:04 INFO - 'PWD': '/builds/slave/test', 04:54:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:54:04 INFO - 'SHELL': '/bin/bash', 04:54:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WckHtTDF0V/Listeners', 04:54:04 INFO - 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', 04:54:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:54:04 INFO - 'USER': 'cltbld', 04:54:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:54:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:54:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:04 INFO - 'XPC_FLAGS': '0x0', 04:54:04 INFO - 'XPC_SERVICE_NAME': '0', 04:54:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:54:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:04 INFO - Downloading/unpacking jsonschema 04:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:54:07 INFO - Downloading/unpacking functools32 (from jsonschema) 04:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:07 INFO - Downloading functools32-3.2.3-2.tar.gz 04:54:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:54:07 INFO - warning: no files found matching '*.txt' 04:54:07 INFO - no previously-included directories found matching 'build' 04:54:07 INFO - no previously-included directories found matching 'dist' 04:54:07 INFO - no previously-included directories found matching '.git*' 04:54:07 INFO - Installing collected packages: jsonschema, functools32 04:54:07 INFO - Running setup.py install for functools32 04:54:07 INFO - warning: no files found matching '*.txt' 04:54:07 INFO - no previously-included directories found matching 'build' 04:54:07 INFO - no previously-included directories found matching 'dist' 04:54:07 INFO - no previously-included directories found matching '.git*' 04:54:07 INFO - Successfully installed jsonschema functools32 04:54:07 INFO - Cleaning up... 04:54:07 INFO - Return code: 0 04:54:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:54:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:07 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 0x10397da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103983570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae295b6a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103821d30>, '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 0x103645db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103818b20>, '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.VXA8m0gRY8/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.WckHtTDF0V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:54:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:54:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:54:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VXA8m0gRY8/Render', 04:54:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:54:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:54:07 INFO - 'HOME': '/Users/cltbld', 04:54:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:54:07 INFO - 'LOGNAME': 'cltbld', 04:54:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:07 INFO - 'MOZ_NO_REMOTE': '1', 04:54:07 INFO - 'NO_EM_RESTART': '1', 04:54:07 INFO - 'PAGER': '/bin/cat', 04:54:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:54:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:07 INFO - 'PWD': '/builds/slave/test', 04:54:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:54:07 INFO - 'SHELL': '/bin/bash', 04:54:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WckHtTDF0V/Listeners', 04:54:07 INFO - 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', 04:54:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:54:07 INFO - 'USER': 'cltbld', 04:54:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:54:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:54:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:07 INFO - 'XPC_FLAGS': '0x0', 04:54:07 INFO - 'XPC_SERVICE_NAME': '0', 04:54:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:54:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:08 INFO - Downloading/unpacking flake8 04:54:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:54:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:54:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:54:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:54:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:54:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:54:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:54:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:54:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:54:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:54:11 INFO - no previously-included directories found matching 'docs/_build' 04:54:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:54:12 INFO - Running setup.py install for pep8 04:54:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:54:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:54:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:54:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:54:12 INFO - no previously-included directories found matching 'docs/_build' 04:54:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:54:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:54:12 INFO - Cleaning up... 04:54:12 INFO - Return code: 0 04:54:12 INFO - Running post-action listener: _resource_record_post_action 04:54:12 INFO - Running post-action listener: _start_resource_monitoring 04:54:12 INFO - Starting resource monitoring. 04:54:12 INFO - ##### 04:54:12 INFO - ##### Finished create-virtualenv step (success) 04:54:12 INFO - ##### 04:54:12 INFO - ##### 04:54:12 INFO - ##### Running install step. 04:54:12 INFO - ##### 04:54:12 INFO - Running pre-action listener: _resource_record_pre_action 04:54:12 INFO - Running main action method: install 04:54:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:54:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:54:12 INFO - Reading from file tmpfile_stdout 04:54:12 INFO - Detecting whether we're running mozinstall >=1.0... 04:54:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:54:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:54:12 INFO - Reading from file tmpfile_stdout 04:54:12 INFO - Output received: 04:54:12 INFO - Usage: mozinstall [options] installer 04:54:12 INFO - Options: 04:54:12 INFO - -h, --help show this help message and exit 04:54:12 INFO - -d DEST, --destination=DEST 04:54:12 INFO - Directory to install application into. [default: 04:54:12 INFO - "/builds/slave/test"] 04:54:12 INFO - --app=APP Application being installed. [default: firefox] 04:54:12 INFO - mkdir: /builds/slave/test/build/application 04:54:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:54:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:54:46 INFO - Reading from file tmpfile_stdout 04:54:46 INFO - Output received: 04:54:46 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:54:46 INFO - Running post-action listener: _resource_record_post_action 04:54:46 INFO - ##### 04:54:46 INFO - ##### Finished install step (success) 04:54:46 INFO - ##### 04:54:46 INFO - ##### 04:54:46 INFO - ##### Running run-tests step. 04:54:46 INFO - ##### 04:54:46 INFO - Running pre-action listener: _resource_record_pre_action 04:54:46 INFO - Running main action method: run_tests 04:54:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:54:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:54:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:54:46 INFO - 2016-06-02 04:54:46.965 screenresolution[1942:19003] starting screenresolution argv=screenresolution get 04:54:46 INFO - 2016-06-02 04:54:46.967 screenresolution[1942:19003] Display 0: 1600x1200x32@60 04:54:46 INFO - 2016-06-02 04:54:46.973 screenresolution[1943:19005] starting screenresolution argv=screenresolution list 04:54:46 INFO - Available Modes on Display 0 04:54:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:54:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:54:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:54:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:54:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:54:47 INFO - Intel Iris: 04:54:47 INFO - Chipset Model: Intel Iris 04:54:47 INFO - Type: GPU 04:54:47 INFO - Bus: Built-In 04:54:47 INFO - VRAM (Dynamic, Max): 1536 MB 04:54:47 INFO - Vendor: Intel (0x8086) 04:54:47 INFO - Device ID: 0x0a2e 04:54:47 INFO - Revision ID: 0x0009 04:54:47 INFO - Displays: 04:54:47 INFO - Display: 04:54:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:54:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:54:47 INFO - Display Serial Number: 1600x1200 60 04:54:47 INFO - Main Display: Yes 04:54:47 INFO - Mirror: Off 04:54:47 INFO - Online: Yes 04:54:47 INFO - Rotation: Supported 04:54:47 INFO - Return code: 0 04:54:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:54:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:54:47 INFO - Python 2.7.3 04:54:47 INFO - Return code: 0 04:54:47 INFO - grabbing minidump binary from tooltool 04:54:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:47 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103821d30>, '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 0x103645db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103818b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:54:47 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:54:47 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:54:47 INFO - Calling ['/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'] with output_timeout 600 04:54:47 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:54:47 INFO - Return code: 0 04:54:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:54:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:54:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:54:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:54:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:54:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:54:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:54:48 INFO - Return code: 0 04:54:48 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/WmJ4ZOLdSTqvVE78bxgnXw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0118', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:54:48 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/WmJ4ZOLdSTqvVE78bxgnXw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0118 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:54:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VXA8m0gRY8/Render', 04:54:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:54:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:54:48 INFO - 'HOME': '/Users/cltbld', 04:54:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:54:48 INFO - 'LOGNAME': 'cltbld', 04:54:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:54:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:54:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:48 INFO - 'MOZ_NO_REMOTE': '1', 04:54:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:54:48 INFO - 'NO_EM_RESTART': '1', 04:54:48 INFO - 'PAGER': '/bin/cat', 04:54:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:54:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:48 INFO - 'PWD': '/builds/slave/test', 04:54:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:54:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:54:48 INFO - 'SHELL': '/bin/bash', 04:54:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WckHtTDF0V/Listeners', 04:54:48 INFO - 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', 04:54:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:54:48 INFO - 'USER': 'cltbld', 04:54:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:54:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:54:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:48 INFO - 'XPC_FLAGS': '0x0', 04:54:48 INFO - 'XPC_SERVICE_NAME': '0', 04:54:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:54:48 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/WmJ4ZOLdSTqvVE78bxgnXw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0118', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:54:48 INFO - mozversion application_buildid: 20160602025051 04:54:48 INFO - mozversion application_changeset: bf9266fa9187c6ec6bb7935f51573fe8d7336ea5 04:54:48 INFO - mozversion application_display_name: Nightly 04:54:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:54:48 INFO - mozversion application_name: Firefox 04:54:48 INFO - mozversion application_remotingname: firefox 04:54:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:54:48 INFO - mozversion application_vendor: Mozilla 04:54:48 INFO - mozversion application_version: 49.0a1 04:54:48 INFO - mozversion platform_buildid: 20160602025051 04:54:48 INFO - mozversion platform_changeset: bf9266fa9187c6ec6bb7935f51573fe8d7336ea5 04:54:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:54:48 INFO - mozversion platform_version: 49.0a1 04:54:48 INFO - using testdate: 1464868488 04:54:48 INFO - actual date: 1464868488 04:54:48 INFO - starting webserver on 'localhost:57190' 04:54:48 INFO - SUITE-START | Running 2 tests 04:54:48 INFO - TEST-START | dromaeo_css 04:54:48 INFO - operating with platform_type : mac_ 04:54:48 INFO - Initialising browser for dromaeo_css test... 04:54:48 INFO - TEST-INFO | started process 1961 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/tmp8vzoua/profile http://localhost:57190/getInfo.html) 04:54:50 INFO - PROCESS | 1961 | __metrics Screen width/height:1600/1200 04:54:50 INFO - PROCESS | 1961 | colorDepth:24 04:54:50 INFO - PROCESS | 1961 | Browser inner width/height: 1024/689 04:54:50 INFO - PROCESS | 1961 | __metrics 04:54:51 INFO - PROCESS | 1961 | 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" 04:54:51 ERROR - PROCESS | 1961 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:54:51 INFO - TEST-INFO | 1961: exit 0 04:54:51 INFO - Browser initialized. 04:54:51 INFO - Running cycle 1/1 for dromaeo_css test... 04:54:51 INFO - TEST-INFO | started process 1963 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/tmp8vzoua/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:55:03 INFO - PROCESS | 1963 | RSS: Main: 241565696 04:55:03 INFO - PROCESS | 1963 | 04:55:55 INFO - PROCESS | 1963 | 1464868555285 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:58:06 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:57190/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57190/tests/dromaeo/cssquery-ext.html) 04:58:07 INFO - PROCESS | 1963 | RSS: Main: 350560256 04:58:07 INFO - PROCESS | 1963 | 05:01:10 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:57190/tests/dromaeo/cssquery-ext.html (next: http://localhost:57190/tests/dromaeo/cssquery-jquery.html) 05:01:10 INFO - PROCESS | 1963 | RSS: Main: 379924480 05:01:10 INFO - PROCESS | 1963 | 05:04:13 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:57190/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57190/tests/dromaeo/cssquery-mootools.html) 05:04:14 INFO - PROCESS | 1963 | RSS: Main: 372760576 05:04:14 INFO - PROCESS | 1963 | 05:07:16 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:57190/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57190/tests/dromaeo/cssquery-prototype.html) 05:07:16 INFO - PROCESS | 1963 | RSS: Main: 372006912 05:07:16 INFO - PROCESS | 1963 | 05:10:20 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:57190/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57190/tests/dromaeo/cssquery-yui.html) 05:10:20 INFO - PROCESS | 1963 | RSS: Main: 340570112 05:10:20 INFO - PROCESS | 1963 | 05:13:24 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:57190/tests/dromaeo/cssquery-yui.html (next: http://localhost:57190/tests/dromaeo/cssquery-dojo.html) 05:13:24 INFO - PROCESS | 1963 | RSS: Main: 381276160 05:13:24 INFO - PROCESS | 1963 | 05:13:24 INFO - PROCESS | 1963 | __start_tp_report 05:13:24 INFO - PROCESS | 1963 | _x_x_mozilla_page_load 05:13:24 INFO - PROCESS | 1963 | _x_x_mozilla_page_load_details 05:13:24 INFO - PROCESS | 1963 | |i|pagename|runs| 05:13:24 INFO - PROCESS | 1963 | |0;dojo.html;3384.661533846614;3392.4063288924435;3406.523086767852;3429.5198672185916;3432.6738959798827;5519.751611177497;5563;5602.1036634138545;5646.294213223342;5682.204491371206;5600.831975040755;5673.8581535461635;5676.063449530822;5679.5740319476;5686.687232202227;5068.341115654969;5127.974405118973;5149.098907691157;5150.845474635767;5203.5056669616515;5205.3233079699585;5215.921761173586;5222.060029194743;5226.111561034633;5230.189320655304;5065.873353166164;5080.568151707109;5107.233914912756;5113.079645663779;5203.375594928595;5115.667481613702;5197.948020519822;5207.739613019372;5210.835434476622;5266.183741520071;5006.374203224597;5014.323066386028;5083.034223497561;5139.0749665060275;5148.150555158394;5413.810516631938;5486.341639003345;5516.503514683657;5534.225208470817;5583.3300003999375;6118.9694051529905;6197.566170368076;6206.689665516707;6215.533834962396;6225.937740622627;6122.093225952662;6143.754249830002;6164.815055548341;6275.309715931244;6308;5726.7995620153515;5768.278965129359;5782.132680098019;5812.070068788974;5826.126081087786;5559.336854081105;6309.652969086653;6317.715702793385;6322.810315690536;6335.461485773669;6007.939920600826;6051.667158306335;6120.785772497941;6121.204243448412;6129.835331287041;6268.717907694165;6274.341194174546;6284.937150628435;6291.276503202099;6313;6187;6214.8135555933395;6215.254169499689;6244.406781355764;6252.6873656317;6085.208922840091;6107.267127944586;6129.693515324216;6158.775188339102;6159.4456498915315;4889.193283108319;4918.975405123023;4926.408830940239;4934.284528743312;4942.777575009133;4368.60682538573;4392.824287028547;4431.468223813163;4452.354408610733;4474.597286244254;5635.098384258499;5635.830925072254;5659.773609055674;5666.603337766399;5680.460356266148;5137.460566640449;6287.46556542699;6304.275008374096;6310.368963103653;6318.810435686937;4985.302057711923;5503.091989821714;5558.33300003994;5606.495415412633;5625.634333768292;5244.31823862903;5297.920531192035;5300;5300.1519756838725;5302.443243459458;6314.684265786692;6324.873502529924;6326.715297811702;6346.524010699124;6347.0479428086155;6130.386961303834;6166.506679465721;6252.374762523711;6260.843478913063;6263.906041409291;6261.843453913689;6290.056491526308;6305.4009869062365;6347.96826015867;6348.3651634838;5118.283440318284;6195.349488303663;6202.689865506797;6219.906701399573;6257.968710156602;6076.878462430638;6128.717018009172;6217.844553886189;6264.154339164154;6265.780697675559;5988.371221021905;6122.093225952662;6131.835460087213;6134.797803295058;6146.279041868284;6090.177825993612;6113.17472141273;6114.6636934969;6121.908171377522;6141.662208578571;4550.863474095782;5765.048766953406;5869.148973398918;5874.412558744091;5938.970305148447;6114.0236562776045;6125.601746185103;6126.142295209414;6134.4789689280005;6135.3188087147355;5928.258967629046;5932.733027013881;5941.465268125889;5945.821625351246;5967.015442452121 05:13:24 INFO - PROCESS | 1963 | |1;ext.html;496.60519886690076;496.8136948644258;514.5086442447463;566.2248849855704;598.766540925693;31292.217694557618;41767.79116104419;43185.35221971665;43208.56791432081;45701.85745356368;44402.55597444025;44577.77711111448;44664;44727.881802954864;44904.326435103416;8428.115047919971;9407.388519746211;9616.80766384672;9620;9625.181859541948;8602.87095693565;9269.814603707922;11580;11585.246958947642;11860.703482412922;11596.478158482889;11628.244164129304;11655.358955257458;11662.533498660086;11679.5912143075;8494.617742201615;11328.207025508218;11531.65405037846;11614.883851161549;11698.771628978962;11461.656150315504;11567.826482602768;11578.305301681927;11582.942085289604;11616.303021818634;41389.37915931264;41863.37204941928;41939.37090943638;41944.79027604873;41946.79026604878;3509.859605615772;3577;3644.4168932970597;3704.9814750926344;3850.8844734658005;32051.358972820413;32301;32695.50956735651;32908;33086;2846.889713011927;2903.3062384680766;3076.0310502191737;3322.6677332266822;3349.447341188701;394108;407068;407719.9614001911;407783;408510.9148908532;63422.73154536976;63624.68187659032;63795.896328293624;63817.04274435887;64022.67988660027;67055.65888682198;67250.99123513151;67291.32708672949;67454.3254567448;67460.66269668718;16147.677046459004;16384.83615163833;16396.508104756875;16397.262123204484;16400.75398869018;11266.267692599955;11357.886421135683;12246.326452045045;12503;12584.18202816814;17745.911270443823;17832.197551110232;17848.19683114237;17871.285148594172;17945.820541794677;6329;7389.889151662729;7503.2496750324535;7509.51188172767;7571.697132114764;789.455275859655;909.3589019741066;909.4497828813605;1009.1523120578603;1038.657243109772;21886.671699924515;27527.724722752515;30940.69059309423;30976.53535196974;31763.36473270568;1107.64001699448;1109.4286442482128;1122.6575894352138;1173.3487914207697;1176.3412489006014;13319;15984.36062557508;16014.519564413085;16091;16397.180140992903;687410;693617;694911;696072;697620;59641.403585963584;61370;61442.692786536674;61454.692726536974;61478.38521614816;1305.8367704036996;1335.8263425754783;1419.2052450627475;1439.172475826404;1449.978250326225;31486.842565787025;32028.51957220597;32142.678573214904;32819.671803281664;32957;52618.21072683989;53376.466235337146;53393;53502.662433437916;53529;560612;564596;565410;565747.1712641411;784156;41807.581924181584;42850.57149428466;42971.92570185645;45295.7735211335;45790.31314530218;49909.25136122888;50165.74585635242;50541;51657.74171129271;51687.74156129195;38249.4262586067;40204.79897600493;40221.994450138984;40742.0175162496;41900;36196.81901590475;39167;39335.60664393319;39635.60364396319;40436;39104.608953910094;39552.80223598979;39912;39968.00079998023;40011.399829002;28573.571396428655;34683.47974780431;35439.64560354467;35612;35729.46405803967;20313.695294570298;25661.845216965656;26052.088176913716;26251.484812489456;26416.603750944134 05:13:24 INFO - PROCESS | 1963 | |2;jquery.html;380.16553664705964;382.9597892221317;386.04261431649525;397.1084914367246;406.4411434277868;20350.89824550877;21630.89184554075;21842.89078554605;22041.448963775914;22048.11807527699;19020.524486887836;20724.27465038724;21656.89171554144;21719.782802171972;21744.238951636657;5531.917021244684;5650.011248031578;5842.737076831553;5855.355910849803;5856.648601083927;4108.4864391951005;4322.935155972647;5809;6163.660998645073;6536.967315163418;6427.710753016102;6515.0553169790355;6526.086347911296;6528.673566321689;6533;6320.431161195492;6495.155629768147;6505.837354066186;6506.804795856132;6516.120323756303;3586.7668601541077;5239.161734122522;5605.663660180361;5622.971885140548;5641.633293835887;25656.230313090637;25948.61077083845;26219.868900655376;26300.473990520273;26517.73482265172;1976.3675623800389;2212.325240801555;2292.7821856923565;2387.8925448354694;2441.6215486599604;9942.552585133613;10221.488925553767;10412.947935260276;10538.420386878719;10572;1900.942971710851;1924.162989099746;1952.1215453046186;2003.6994450832347;2012.8993550322425;127189.36405318006;129879.70120298771;130687;132303;134540.999999999;11365.602203922823;11464.770704585862;11538.192326537062;11560.421978901022;11582.71043223926;14501.564953051426;14651.34068966899;14667.92666036663;14668.339924703414;14682.55952321432;8361.665533378597;8454.957725211334;8485.448445851;8501.65993360271;8626.611802468778;7330.523515971445;7980.042394912648;8428.789280268042;8477.95761021191;8518.957405212934;4490.371348011281;4576.26779715244;4599;4632;4642.86071417858;1796.0630764885173;1804.5939663575853;1818;1918.4052943587533;1947.4741819708884;901.9729408117636;914.5518695838991;971.5919313888184;1005.894381089975;1008.9041541053588;17820.19809108593;20755.58488830215;20896.895515522327;20924.790752092587;21095.26166584193;937.634322614181;963.8939716631165;967.5210770668564;995.6415690351467;1021.0147207944221;10904.182186336056;10973.189423745152;11038.448077596087;11084.778304433867;11087.002169804757;608553;615463;617774.9111254415;618363;620598;103359;129145.77135571686;129764;135945;138731;1009.0918173643779;1017.760826205841;1050.6847945616285;1068.3643232276784;1074.6023971130733;15194.088354698753;17813.376531821323;18279.725804112684;18366.449006529827;18377.448676539727;50064.74838129076;50072.49927500824;53311.733441332544;53598.196027058846;53977.73011134919;80515.59742201252;81845;81906;83637.16362836538;92561;6978.581285122909;7355.77932662021;7575.659095340613;7844.254795794391;8458.74623761288;9328.860067098864;12755.426005829575;13185.626587214394;13621;13635.454581816617;11230.83153752678;11524.82712759326;11554.306741595532;11697;11737.765244695229;9124.726258212264;10892.945535272273;11298.548058077586;11813.704657383634;11849.881501185222;11766.411679415824;11777.524540674489;12022.879771202175;12076.456559455022;12213.633590992284;6769.255381907888;7142.285771422816;7471.8879216812875;8024.959875200587;8425.578721064045;10691.732706682395;11129.777404452028;11730.648080557597;11819;11837.940810295893 05:13:24 INFO - PROCESS | 1963 | |3;mootools.html;1401.761700510913;1405.5502239283421;1544.2047345617007;1770.7255375416808;1971.6549603819337;7884.329831964283;8368.121347258542;8635.13648635136;8861.556922153899;8906.599203035863;8674.739757807276;8783.165599268059;8881.333899957497;8889.511076890769;8904.376693631448;2366.337425520857;2395.317334559651;2400.1359510576267;2407.2417188585628;2411.2284069097896;2349.6827928229727;2380.071772008918;2389.82076344274;2390.306811024801;2403.182917807954;2360.6459031145296;2374.299581623425;2388.605880029793;2393.808495320379;2395;2328.1502251678016;2347.507023525062;2354.6468029795583;2356.5051339218785;2376.2871138658506;2320.5706944215376;2351.870647114408;2356.988215058931;2360.079568968104;2367.562001029815;8796.07641197678;8898.976617688919;8900.821983560292;8902.777430564223;8911.420757650732;5166.276721258989;5372.919406208871;5379.408265090837;5404.3784964728775;5408.486193811582;3522.189896323834;3640.9635903640888;3737.1501106952232;3739.6260373962386;3748.025513366517;1072.7425417899726;1082.2099867097063;1091.1434523898702;1096.353151640528;1112.7106952192407;11603.941980290128;11737.765244695058;11741.58904438349;11746;11746.29522228669;3810.9047273817823;4508.729476231437;4539.682222244412;4665.626749860003;4666.813327466931;9215.95392023049;9243;9248.630054797868;9260.39807412516;9273.026332235153;4652.767361631905;5293.676580854786;5301.045811753845;5309.230161626542;5311.681299122065;4404.889877753082;4563.155816174019;4624.815007399667;4775.403074615673;4900.215965445583;3725.6088110747983;3768.4535742317757;3810.40938654509;3842.7502212356667;3915.647591716759;1084.1326938449208;1163.4124766992616;1167.3871217610651;1176.8999635030948;1179.015522039107;651.3681728723132;805.5931754463958;927.2118699105706;958.9280803939732;1002.6590959073804;5989.8203053908455;6040.546958978094;6053.364396738367;6231.034189700604;6234.127222188898;480.1549273279054;489.6156517134033;491.9163742163841;501.20558914120795;645.5642441352069;3840.3663395539984;4075.7146999709735;4125.97937010313;4126.174765047002;4131.35963925592;8949.731508054769;10437.425941573287;10717.303375280582;10835.729106772395;10899.67300980956;10786;10848.511816968256;10861.83707244392;10864.293820901616;10865.967733065347;7915.12933577306;8245.95877020623;8284.005919289724;8289.171082891784;8384.868042814263;6080.543959203166;6100.75596976116;6120.143179954899;6184.5052395809125;6293.213348331458;9861.457619830979;9890.901090988998;10201;10207.285490015925;10227.488625568543;10121.190304775748;10338.379697218192;10338.689839304832;10450.477476126316;10510.684679459628;7253.3834624057545;7332;7409.62951852416;7411.888821667787;7429.851402972018;8188.0993090758775;8420.5789710513;8441.36689748259;8451.915480845359;8478.02502712196;6070.817875463743;7520.699172033057;7525.023475116394;7771.222877712184;7798;7434.405247580073;7544.547327160388;7597.088349398107;7659.693612255447;7659.770206893802;7047.295270473117;7064.894026589503;7133.500654954103;7156;7169.175544812205;4365.257906156025;4935.62982776286;5040.773165207501;5158.329417175743;5167.372277732502;4315.805788739577;5198.948010519846;5214.32213812202;5219.451957544555;5220.425753167073 05:13:24 INFO - PROCESS | 1963 | |4;prototype.html;300.0802540214242;303.2056013245297;316.18897527841085;319.98880039198633;322.9854656540455;4702.85891423257;5298.284731561238;5372.012355428487;5383.3849845046425;5413.756380962856;4929;5119.2577076324005;5129.743512824362;5154.252633368159;5331.626786124973;3323.7507186961075;3940.2119576084756;3955.4660120883746;3960.544537378195;3980.4029395590605;3394.2871996880685;4006.8196931138023;4025.657819085381;4033.6773058155277;4041.1513582147636;3579.821008949555;3608.747387682863;3830.367989281779;3900.921981560367;4023.8189281482405;3747.400415933465;3947.6052394760436;3971.285168669638;3991.62289010291;4018.57804930481;3107.052349033544;3201.599800024997;3415.8633654653786;3419.1623052352334;3431.330890476358;4063.878083657495;4576.977115114403;4987.650864439491;5070.771815268285;5093.312402825645;3849.7305188636806;4593.26507758757;4603.378543896598;4616.0537089896825;4631.976840115812;4813.975930120362;5023.2214006829;5142.897142057175;5449.700266485342;5521.337439507285;3387.9830600847085;3410.488426735985;3481.9651803481893;3740.195857890539;3748.9625103748886;5042.823501177441;5747.729646789537;5776.42235776419;5778.451047150514;5815.214945982323;3567.5362202913457;3792.5259342582176;3794.5636251831393;3810.980945095312;3853.9574025766387;3341.498775183742;3889.202713443737;3907.7920974649232;3911.3155197840265;3923.293807114747;4167.74993500391;4498.707584007029;4512.210363186495;4528.705634133771;4566.406367172246;5054.317667114966;5134.2298655201275;5217.426083130853;5625.296837895263;5677.77288908439;1132.8470656461272;1249.28790589365;1302.2512055567897;1339.4240476594962;1346.7104572516955;738.9482736208521;810.8256724804196;849.5837039850429;952.2762700347786;957.1911734584265;4486.295207821007;4769.76151192439;4771.308160316804;5069.822556210589;5156.871078222999;4723.456802467692;5248.580113590903;5736.512396446349;5749.8562535936935;5750.856228594319;4450.064222063413;4486.416765820422;4915.1644220481885;5265.447128051576;5273.419923808378;2539.159109645529;3023.4406634772636;3033.9848300758354;3058.1590062732926;3071.8957514102913;4953.925691114636;5554.805581804699;5942.286925568959;5959.672218027963;5998.520118390518;5062.772175252123;5084.1188760158975;5639.718014099279;5702.657840529581;5927.347991720907;5551.945130425206;5883.676397798076;6027.578069535178;6054;6062.18160548338;5303.231031500488;5373.596980226421;5737.885242295214;5770.538356931519;5827.475527202572;4598.448186217675;5072.6557462271785;5218.373795144607;5621.409751975983;5665.518430933417;4993.325901003318;5578.888422231614;6010.278766548042;6034.366391529002;6043.879122417615;3640.0899775056237;3748.362778327636;3805.562360328487;3830.9808450957566;3839.6961822906032;5325.973370133124;5738.368779434342;5759.9136012959;5801.36185019639;5818.854528636818;4439.62263207631;5366.570674345965;5587.385387607279;5640.294963129609;5646.265985421869;5504.752286147213;5584.916226256528;5592.965301419251;5605.299337582802;5608.186812912023;4251.936220956626;4674.92987605193;5143.794248230179;5372.328458942632;5514.255575497256;5258.947410525846;5578.079616863172;5634.295713035871;5639.351474580311;5681.659100453986;4723.7401942893475;5444.945550544444;5461.235427040297;5497.945020549743;5506.2743941749095 05:13:24 INFO - PROCESS | 1963 | |5;yui.html;739.737393225405;838.5597561280323;842.6376658037045;871.9275291391584;896.9596368163434;15316.923415382935;15346.539603811889;15579.922100389482;15589.844101558981;15659.373625054985;14094.436222551085;14112.012159148864;14124.788128178085;14172;14178.71642567148;699.5802518488916;732.1872721279402;884.4428010353469;903.9638414463413;904.2223687628634;862.9266512346458;910.6630546697731;911.3529394130176;912.9132732390445;914.9771255718593;958.6165533786507;968.9079537443931;968.9854652180223;969.3505351414534;970.2480577552418;945.2249155692335;962.0812124421161;962.7208109648194;962.7496850818768;963.7590602349447;546.8222827581052;679.2528218959155;712.5012491256141;714.9356557909813;717.5156769180834;14640.194789286585;14649.340779664833;14689.192094434802;14693.485727999576;14698.33857476416;13243.47026118954;13552.186868787905;13627.318634068357;13646.86353136466;13850.547358400818;11732.296062236208;12030.63908082759;12306;12339.62981110568;12675.112742108056;4424.823007079713;4445.799939002753;4446.133004064209;4548.113117942003;4612.285095810154;78479.6076019622;79974;80146.59926700387;80316.59841700754;81096;10763.623273185402;10867.130629549618;11111.555417820502;11154.776904461865;11241.60654377093;21112.577748444946;21115;21139.47151321229;21143.577128457346;21149.836758978097;7786.221377862282;7901.486403383762;7903.723369682033;7938.404619653549;8028.43800933929;3639.9818000909827;4374.671899607542;4396.956030439655;4432.734035957853;4574.565416285448;3377.5778027746533;3446.362422951762;3479.7912125272564;3485.1635607454537;3486.89539313821;575.4475703324855;667.3893387550434;668.6756922892394;692.4598812925926;693.414065114977;557.4509108528097;568.2782865760461;633.1990032608753;639.4404895716249;656.6158797103652;7505.274340520327;8679.439565328243;8829.426087304304;8924.419912705653;9047.230985366186;564.1058921609214;614.4869034356274;645.3353046362255;655.783591414832;659.788867562385;3122.828244446577;3506.859725610998;4115.176964607091;4252.574742525784;4328.567143285709;87346.68979965306;90298.09701902897;95644;95790.0420995795;95884.52057739667;74310.25689743142;78419;83190;84188;84753.57623211968;66033.66983165054;66063.66968165128;66192.6761464768;67390;67395;7789.532628042336;8046.7929810528885;8127.75616731499;8277.213664701843;8438.789030274293;45915;45971.540284598064;46717;47639.523604764894;47795.566133016066;59291;63072.05391919216;63184;63471.6826415865;63564.68217658882;11136.55453781872;11155.442227888736;11356.886431135914;11494.96545310926;11789.76420471603;11380.317180969168;11827.526898923947;11852.881471185177;12401;12416.006719462603;11100.389478578756;11447.370394628375;11664.475098620413;11741.76516469683;11745.588904388305;11271.211015228855;11383.373914434786;11407.657770266906;11703.824442633197;11759.588414405454;11090.889091108986;11101.777964440827;11514.36670983104;11560.94219528897;11663.475143618387;9367.859482107637;9377.390469619726;9453.952730236304;9649;9703.417794932328;8107.594620269081;8706;8838.646454141763;9628.518574071408;9790.167835734042 05:13:24 INFO - PROCESS | 1963 | __end_tp_report 05:13:24 INFO - PROCESS | 1963 | __start_cc_report 05:13:24 INFO - PROCESS | 1963 | _x_x_mozilla_cycle_collect,1058 05:13:24 INFO - PROCESS | 1963 | __end_cc_report 05:13:24 INFO - PROCESS | 1963 | __startTimestamp1464869604315__endTimestamp 05:13:24 INFO - PROCESS | 1963 | 05:13:24 INFO - PROCESS | 1963 | ------- Summary: start ------- 05:13:24 INFO - PROCESS | 1963 | Number of tests: 6 05:13:24 INFO - PROCESS | 1963 | 05:13:24 INFO - PROCESS | 1963 | [#0] dojo.html Cycles:165 Average:5689.74 Median:5928.26 stddev:651.81 (11.0%) stddev-sans-first:628.22 05:13:24 INFO - PROCESS | 1963 | Values: 3384.7 3392.4 3406.5 3429.5 3432.7 5519.8 5563.0 5602.1 5646.3 5682.2 5600.8 5673.9 5676.1 5679.6 5686.7 5068.3 5128.0 5149.1 5150.8 5203.5 5205.3 5215.9 5222.1 5226.1 5230.2 5065.9 5080.6 5107.2 5113.1 5203.4 5115.7 5197.9 5207.7 5210.8 5266.2 5006.4 5014.3 5083.0 5139.1 5148.2 5413.8 5486.3 5516.5 5534.2 5583.3 6119.0 6197.6 6206.7 6215.5 6225.9 6122.1 6143.8 6164.8 6275.3 6308.0 5726.8 5768.3 5782.1 5812.1 5826.1 5559.3 6309.7 6317.7 6322.8 6335.5 6007.9 6051.7 6120.8 6121.2 6129.8 6268.7 6274.3 6284.9 6291.3 6313.0 6187.0 6214.8 6215.3 6244.4 6252.7 6085.2 6107.3 6129.7 6158.8 6159.4 4889.2 4919.0 4926.4 4934.3 4942.8 4368.6 4392.8 4431.5 4452.4 4474.6 5635.1 5635.8 5659.8 5666.6 5680.5 5137.5 6287.5 6304.3 6310.4 6318.8 4985.3 5503.1 5558.3 5606.5 5625.6 5244.3 5297.9 5300.0 5300.2 5302.4 6314.7 6324.9 6326.7 6346.5 6347.0 6130.4 6166.5 6252.4 6260.8 6263.9 6261.8 6290.1 6305.4 6348.0 6348.4 5118.3 6195.3 6202.7 6219.9 6258.0 6076.9 6128.7 6217.8 6264.2 6265.8 5988.4 6122.1 6131.8 6134.8 6146.3 6090.2 6113.2 6114.7 6121.9 6141.7 4550.9 5765.0 5869.1 5874.4 5939.0 6114.0 6125.6 6126.1 6134.5 6135.3 5928.3 5932.7 5941.5 5945.8 5967.0 05:13:24 INFO - PROCESS | 1963 | 05:13:24 INFO - PROCESS | 1963 | [#1] ext.html Cycles:180 Average:71658.70 Median:216830.40 stddev:156294.37 (72.1%) stddev-sans-first:156641.49 05:13:24 INFO - PROCESS | 1963 | Values: 496.6 496.8 514.5 566.2 598.8 31292.2 41767.8 43185.4 43208.6 45701.9 44402.6 44577.8 44664.0 44727.9 44904.3 8428.1 9407.4 9616.8 9620.0 9625.2 8602.9 9269.8 11580.0 11585.2 11860.7 11596.5 11628.2 11655.4 11662.5 11679.6 8494.6 11328.2 11531.7 11614.9 11698.8 11461.7 11567.8 11578.3 11582.9 11616.3 41389.4 41863.4 41939.4 41944.8 41946.8 3509.9 3577.0 3644.4 3705.0 3850.9 32051.4 32301.0 32695.5 32908.0 33086.0 2846.9 2903.3 3076.0 3322.7 3349.4 394108.0 407068.0 407720.0 407783.0 408510.9 63422.7 63624.7 63795.9 63817.0 64022.7 67055.7 67251.0 67291.3 67454.3 67460.7 16147.7 16384.8 16396.5 16397.3 16400.8 11266.3 11357.9 12246.3 12503.0 12584.2 17745.9 17832.2 17848.2 17871.3 17945.8 6329.0 7389.9 7503.2 7509.5 7571.7 789.5 909.4 909.4 1009.2 1038.7 21886.7 27527.7 30940.7 30976.5 31763.4 1107.6 1109.4 1122.7 1173.3 1176.3 13319.0 15984.4 16014.5 16091.0 16397.2 687410.0 693617.0 694911.0 696072.0 697620.0 59641.4 61370.0 61442.7 61454.7 61478.4 1305.8 1335.8 1419.2 1439.2 1450.0 31486.8 32028.5 32142.7 32819.7 32957.0 52618.2 53376.5 53393.0 53502.7 53529.0 560612.0 564596.0 565410.0 565747.2 784156.0 41807.6 42850.6 42971.9 45295.8 45790.3 49909.3 50165.7 50541.0 51657.7 51687.7 38249.4 40204.8 40222.0 40742.0 41900.0 36196.8 39167.0 39335.6 39635.6 40436.0 39104.6 39552.8 39912.0 39968.0 40011.4 28573.6 34683.5 35439.6 35612.0 35729.5 20313.7 25661.8 26052.1 26251.5 26416.6 05:13:24 INFO - PROCESS | 1963 | 05:13:24 INFO - PROCESS | 1963 | [#2] jquery.html Cycles:180 Average:36067.57 Median:12130.22 stddev:103056.92 (849.6%) stddev-sans-first:103311.18 05:13:24 INFO - PROCESS | 1963 | Values: 380.2 383.0 386.0 397.1 406.4 20350.9 21630.9 21842.9 22041.4 22048.1 19020.5 20724.3 21656.9 21719.8 21744.2 5531.9 5650.0 5842.7 5855.4 5856.6 4108.5 4322.9 5809.0 6163.7 6537.0 6427.7 6515.1 6526.1 6528.7 6533.0 6320.4 6495.2 6505.8 6506.8 6516.1 3586.8 5239.2 5605.7 5623.0 5641.6 25656.2 25948.6 26219.9 26300.5 26517.7 1976.4 2212.3 2292.8 2387.9 2441.6 9942.6 10221.5 10412.9 10538.4 10572.0 1900.9 1924.2 1952.1 2003.7 2012.9 127189.4 129879.7 130687.0 132303.0 134541.0 11365.6 11464.8 11538.2 11560.4 11582.7 14501.6 14651.3 14667.9 14668.3 14682.6 8361.7 8455.0 8485.4 8501.7 8626.6 7330.5 7980.0 8428.8 8478.0 8519.0 4490.4 4576.3 4599.0 4632.0 4642.9 1796.1 1804.6 1818.0 1918.4 1947.5 902.0 914.6 971.6 1005.9 1008.9 17820.2 20755.6 20896.9 20924.8 21095.3 937.6 963.9 967.5 995.6 1021.0 10904.2 10973.2 11038.4 11084.8 11087.0 608553.0 615463.0 617774.9 618363.0 620598.0 103359.0 129145.8 129764.0 135945.0 138731.0 1009.1 1017.8 1050.7 1068.4 1074.6 15194.1 17813.4 18279.7 18366.4 18377.4 50064.7 50072.5 53311.7 53598.2 53977.7 80515.6 81845.0 81906.0 83637.2 92561.0 6978.6 7355.8 7575.7 7844.3 8458.7 9328.9 12755.4 13185.6 13621.0 13635.5 11230.8 11524.8 11554.3 11697.0 11737.8 9124.7 10892.9 11298.5 11813.7 11849.9 11766.4 11777.5 12022.9 12076.5 12213.6 6769.3 7142.3 7471.9 8025.0 8425.6 10691.7 11129.8 11730.6 11819.0 11837.9 05:13:24 INFO - PROCESS | 1963 | 05:13:24 INFO - PROCESS | 1963 | [#3] mootools.html Cycles:180 Average:5704.96 Median:484.89 stddev:3219.24 (663.9%) stddev-sans-first:3212.03 05:13:24 INFO - PROCESS | 1963 | Values: 1401.8 1405.6 1544.2 1770.7 1971.7 7884.3 8368.1 8635.1 8861.6 8906.6 8674.7 8783.2 8881.3 8889.5 8904.4 2366.3 2395.3 2400.1 2407.2 2411.2 2349.7 2380.1 2389.8 2390.3 2403.2 2360.6 2374.3 2388.6 2393.8 2395.0 2328.2 2347.5 2354.6 2356.5 2376.3 2320.6 2351.9 2357.0 2360.1 2367.6 8796.1 8899.0 8900.8 8902.8 8911.4 5166.3 5372.9 5379.4 5404.4 5408.5 3522.2 3641.0 3737.2 3739.6 3748.0 1072.7 1082.2 1091.1 1096.4 1112.7 11603.9 11737.8 11741.6 11746.0 11746.3 3810.9 4508.7 4539.7 4665.6 4666.8 9216.0 9243.0 9248.6 9260.4 9273.0 4652.8 5293.7 5301.0 5309.2 5311.7 4404.9 4563.2 4624.8 4775.4 4900.2 3725.6 3768.5 3810.4 3842.8 3915.6 1084.1 1163.4 1167.4 1176.9 1179.0 651.4 805.6 927.2 958.9 1002.7 5989.8 6040.5 6053.4 6231.0 6234.1 480.2 489.6 491.9 501.2 645.6 3840.4 4075.7 4126.0 4126.2 4131.4 8949.7 10437.4 10717.3 10835.7 10899.7 10786.0 10848.5 10861.8 10864.3 10866.0 7915.1 8246.0 8284.0 8289.2 8384.9 6080.5 6100.8 6120.1 6184.5 6293.2 9861.5 9890.9 10201.0 10207.3 10227.5 10121.2 10338.4 10338.7 10450.5 10510.7 7253.4 7332.0 7409.6 7411.9 7429.9 8188.1 8420.6 8441.4 8451.9 8478.0 6070.8 7520.7 7525.0 7771.2 7798.0 7434.4 7544.5 7597.1 7659.7 7659.8 7047.3 7064.9 7133.5 7156.0 7169.2 4365.3 4935.6 5040.8 5158.3 5167.4 4315.8 5198.9 5214.3 5219.5 5220.4 05:13:24 INFO - PROCESS | 1963 | 05:13:24 INFO - PROCESS | 1963 | [#4] prototype.html Cycles:180 Average:4459.90 Median:5033.02 stddev:1389.92 (27.6%) stddev-sans-first:1358.30 05:13:24 INFO - PROCESS | 1963 | Values: 300.1 303.2 316.2 320.0 323.0 4702.9 5298.3 5372.0 5383.4 5413.8 4929.0 5119.3 5129.7 5154.3 5331.6 3323.8 3940.2 3955.5 3960.5 3980.4 3394.3 4006.8 4025.7 4033.7 4041.2 3579.8 3608.7 3830.4 3900.9 4023.8 3747.4 3947.6 3971.3 3991.6 4018.6 3107.1 3201.6 3415.9 3419.2 3431.3 4063.9 4577.0 4987.7 5070.8 5093.3 3849.7 4593.3 4603.4 4616.1 4632.0 4814.0 5023.2 5142.9 5449.7 5521.3 3388.0 3410.5 3482.0 3740.2 3749.0 5042.8 5747.7 5776.4 5778.5 5815.2 3567.5 3792.5 3794.6 3811.0 3854.0 3341.5 3889.2 3907.8 3911.3 3923.3 4167.7 4498.7 4512.2 4528.7 4566.4 5054.3 5134.2 5217.4 5625.3 5677.8 1132.8 1249.3 1302.3 1339.4 1346.7 738.9 810.8 849.6 952.3 957.2 4486.3 4769.8 4771.3 5069.8 5156.9 4723.5 5248.6 5736.5 5749.9 5750.9 4450.1 4486.4 4915.2 5265.4 5273.4 2539.2 3023.4 3034.0 3058.2 3071.9 4953.9 5554.8 5942.3 5959.7 5998.5 5062.8 5084.1 5639.7 5702.7 5927.3 5551.9 5883.7 6027.6 6054.0 6062.2 5303.2 5373.6 5737.9 5770.5 5827.5 4598.4 5072.7 5218.4 5621.4 5665.5 4993.3 5578.9 6010.3 6034.4 6043.9 3640.1 3748.4 3805.6 3831.0 3839.7 5326.0 5738.4 5759.9 5801.4 5818.9 4439.6 5366.6 5587.4 5640.3 5646.3 5504.8 5584.9 5593.0 5605.3 5608.2 4251.9 4674.9 5143.8 5372.3 5514.3 5258.9 5578.1 5634.3 5639.4 5681.7 4723.7 5444.9 5461.2 5497.9 5506.3 05:13:24 INFO - PROCESS | 1963 | 05:13:24 INFO - PROCESS | 1963 | [#5] yui.html Cycles:180 Average:18230.65 Median:29952.74 stddev:25281.84 (84.4%) stddev-sans-first:25318.65 05:13:24 INFO - PROCESS | 1963 | Values: 739.7 838.6 842.6 871.9 897.0 15316.9 15346.5 15579.9 15589.8 15659.4 14094.4 14112.0 14124.8 14172.0 14178.7 699.6 732.2 884.4 904.0 904.2 862.9 910.7 911.4 912.9 915.0 958.6 968.9 969.0 969.4 970.2 945.2 962.1 962.7 962.7 963.8 546.8 679.3 712.5 714.9 717.5 14640.2 14649.3 14689.2 14693.5 14698.3 13243.5 13552.2 13627.3 13646.9 13850.5 11732.3 12030.6 12306.0 12339.6 12675.1 4424.8 4445.8 4446.1 4548.1 4612.3 78479.6 79974.0 80146.6 80316.6 81096.0 10763.6 10867.1 11111.6 11154.8 11241.6 21112.6 21115.0 21139.5 21143.6 21149.8 7786.2 7901.5 7903.7 7938.4 8028.4 3640.0 4374.7 4397.0 4432.7 4574.6 3377.6 3446.4 3479.8 3485.2 3486.9 575.4 667.4 668.7 692.5 693.4 557.5 568.3 633.2 639.4 656.6 7505.3 8679.4 8829.4 8924.4 9047.2 564.1 614.5 645.3 655.8 659.8 3122.8 3506.9 4115.2 4252.6 4328.6 87346.7 90298.1 95644.0 95790.0 95884.5 74310.3 78419.0 83190.0 84188.0 84753.6 66033.7 66063.7 66192.7 67390.0 67395.0 7789.5 8046.8 8127.8 8277.2 8438.8 45915.0 45971.5 46717.0 47639.5 47795.6 59291.0 63072.1 63184.0 63471.7 63564.7 11136.6 11155.4 11356.9 11495.0 11789.8 11380.3 11827.5 11852.9 12401.0 12416.0 11100.4 11447.4 11664.5 11741.8 11745.6 11271.2 11383.4 11407.7 11703.8 11759.6 11090.9 11101.8 11514.4 11560.9 11663.5 9367.9 9377.4 9454.0 9649.0 9703.4 8107.6 8706.0 8838.6 9628.5 9790.2 05:13:24 INFO - PROCESS | 1963 | -------- Summary: end -------- 05:13:24 INFO - PROCESS | 1963 | 05:13:24 INFO - TEST-INFO | 1963: exit 0 05:13:24 INFO - TEST-OK | dromaeo_css | took 1116272ms 05:13:24 INFO - TEST-START | kraken 05:13:24 INFO - operating with platform_type : mac_ 05:13:24 INFO - Initialising browser for kraken test... 05:13:24 INFO - TEST-INFO | started process 1966 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/tmp2wD5HG/profile http://localhost:57190/getInfo.html) 05:13:27 INFO - PROCESS | 1966 | __metrics Screen width/height:1600/1200 05:13:27 INFO - PROCESS | 1966 | colorDepth:24 05:13:27 INFO - PROCESS | 1966 | Browser inner width/height: 1024/689 05:13:27 INFO - PROCESS | 1966 | __metrics 05:13:27 INFO - PROCESS | 1966 | 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" 05:13:27 ERROR - PROCESS | 1966 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:13:27 INFO - TEST-INFO | 1966: exit 0 05:13:27 INFO - Browser initialized. 05:13:27 INFO - Running cycle 1/1 for kraken test... 05:13:27 INFO - TEST-INFO | started process 1967 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/tmp2wD5HG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:13:39 INFO - PROCESS | 1967 | RSS: Main: 241803264 05:13:39 INFO - PROCESS | 1967 | 05:13:42 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:57190/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57190/tests/kraken/driver.html?testName=audio-beat-detection) 05:13:43 INFO - PROCESS | 1967 | RSS: Main: 292306944 05:13:43 INFO - PROCESS | 1967 | 05:13:46 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:57190/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57190/tests/kraken/driver.html?testName=audio-dft) 05:13:46 INFO - PROCESS | 1967 | RSS: Main: 302129152 05:13:46 INFO - PROCESS | 1967 | 05:13:50 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:57190/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57190/tests/kraken/driver.html?testName=audio-fft) 05:13:50 INFO - PROCESS | 1967 | RSS: Main: 388169728 05:13:50 INFO - PROCESS | 1967 | 05:13:52 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:57190/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57190/tests/kraken/driver.html?testName=audio-oscillator) 05:13:53 INFO - PROCESS | 1967 | RSS: Main: 288571392 05:13:53 INFO - PROCESS | 1967 | 05:13:55 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:57190/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57190/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:13:56 INFO - PROCESS | 1967 | RSS: Main: 292577280 05:13:56 INFO - PROCESS | 1967 | 05:13:59 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:57190/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57190/tests/kraken/driver.html?testName=imaging-darkroom) 05:13:59 INFO - PROCESS | 1967 | RSS: Main: 331165696 05:13:59 INFO - PROCESS | 1967 | 05:14:02 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:57190/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57190/tests/kraken/driver.html?testName=imaging-desaturate) 05:14:03 INFO - PROCESS | 1967 | RSS: Main: 332165120 05:14:03 INFO - PROCESS | 1967 | 05:14:05 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:57190/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57190/tests/kraken/driver.html?testName=json-parse-financial) 05:14:06 INFO - PROCESS | 1967 | RSS: Main: 330088448 05:14:06 INFO - PROCESS | 1967 | 05:14:08 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:57190/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57190/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:14:08 INFO - PROCESS | 1967 | RSS: Main: 311783424 05:14:08 INFO - PROCESS | 1967 | 05:14:10 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:57190/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57190/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:14:11 INFO - PROCESS | 1967 | RSS: Main: 318775296 05:14:11 INFO - PROCESS | 1967 | 05:14:13 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:57190/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57190/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:14:14 INFO - PROCESS | 1967 | RSS: Main: 321908736 05:14:14 INFO - PROCESS | 1967 | 05:14:16 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:57190/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57190/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:14:17 INFO - PROCESS | 1967 | RSS: Main: 324775936 05:14:17 INFO - PROCESS | 1967 | 05:14:20 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:57190/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57190/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:14:20 INFO - PROCESS | 1967 | RSS: Main: 325529600 05:14:20 INFO - PROCESS | 1967 | 05:14:22 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:57190/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57190/tests/kraken/driver.html?testName=ai-astar) 05:14:22 INFO - PROCESS | 1967 | RSS: Main: 369643520 05:14:22 INFO - PROCESS | 1967 | 05:14:22 INFO - PROCESS | 1967 | __start_tp_report 05:14:22 INFO - PROCESS | 1967 | _x_x_mozilla_page_load 05:14:22 INFO - PROCESS | 1967 | _x_x_mozilla_page_load_details 05:14:22 INFO - PROCESS | 1967 | |i|pagename|runs| 05:14:22 INFO - PROCESS | 1967 | |0;ai-astar;113;106;112;113;112;113;112;161;167;126 05:14:22 INFO - PROCESS | 1967 | |1;audio-beat-detection;162;119;118;171;134;112;138;139;149;117 05:14:22 INFO - PROCESS | 1967 | |2;audio-dft;184;183;185;185;183;181;183;184;182;178 05:14:22 INFO - PROCESS | 1967 | |3;audio-fft;79;73;56;107;57;57;60;65;98;72 05:14:22 INFO - PROCESS | 1967 | |4;audio-oscillator;85;90;92;71;70;68;96;70;68;103 05:14:22 INFO - PROCESS | 1967 | |5;imaging-gaussian-blur;88;88;108;114;132;88;86;83;88;86 05:14:22 INFO - PROCESS | 1967 | |6;imaging-darkroom;92;100;122;93;92;93;93;93;91;92 05:14:22 INFO - PROCESS | 1967 | |7;imaging-desaturate;86;84;85;84;85;85;85;85;87;87 05:14:22 INFO - PROCESS | 1967 | |8;json-parse-financial;56;56;55;54;55;54;54;55;53;54 05:14:22 INFO - PROCESS | 1967 | |9;json-stringify-tinderbox;64;73;77;73;70;69;68;69;69;69 05:14:22 INFO - PROCESS | 1967 | |10;stanford-crypto-aes;86;85;85;86;86;86;84;87;124;87 05:14:22 INFO - PROCESS | 1967 | |11;stanford-crypto-ccm;140;149;145;137;142;135;135;137;150;142 05:14:22 INFO - PROCESS | 1967 | |12;stanford-crypto-pbkdf2;164;165;164;163;163;162;161;166;160;167 05:14:22 INFO - PROCESS | 1967 | |13;stanford-crypto-sha256-iterative;66;68;68;67;66;67;67;66;66;69 05:14:22 INFO - PROCESS | 1967 | __end_tp_report 05:14:22 INFO - PROCESS | 1967 | __start_cc_report 05:14:22 INFO - PROCESS | 1967 | _x_x_mozilla_cycle_collect,1927 05:14:22 INFO - PROCESS | 1967 | __end_cc_report 05:14:22 INFO - PROCESS | 1967 | __startTimestamp1464869662942__endTimestamp 05:14:22 INFO - PROCESS | 1967 | 05:14:22 INFO - PROCESS | 1967 | ------- Summary: start ------- 05:14:22 INFO - PROCESS | 1967 | Number of tests: 14 05:14:22 INFO - PROCESS | 1967 | 05:14:22 INFO - PROCESS | 1967 | [#0] ai-astar Cycles:10 Average:123.50 Median:113.00 stddev:21.96 (19.4%) stddev-sans-first:22.96 05:14:22 INFO - PROCESS | 1967 | Values: 113.0 106.0 112.0 113.0 112.0 113.0 112.0 161.0 167.0 126.0 05:14:22 INFO - PROCESS | 1967 | 05:14:22 INFO - PROCESS | 1967 | [#1] audio-beat-detection Cycles:10 Average:135.90 Median:138.50 stddev:20.10 (14.5%) stddev-sans-first:18.97 05:14:22 INFO - PROCESS | 1967 | Values: 162.0 119.0 118.0 171.0 134.0 112.0 138.0 139.0 149.0 117.0 05:14:22 INFO - PROCESS | 1967 | 05:14:22 INFO - PROCESS | 1967 | [#2] audio-dft Cycles:10 Average:182.80 Median:183.50 stddev:2.10 (1.1%) stddev-sans-first:2.18 05:14:22 INFO - PROCESS | 1967 | Values: 184.0 183.0 185.0 185.0 183.0 181.0 183.0 184.0 182.0 178.0 05:14:22 INFO - PROCESS | 1967 | 05:14:22 INFO - PROCESS | 1967 | [#3] audio-fft Cycles:10 Average:72.40 Median:68.50 stddev:17.79 (26.0%) stddev-sans-first:18.71 05:14:22 INFO - PROCESS | 1967 | Values: 79.0 73.0 56.0 107.0 57.0 57.0 60.0 65.0 98.0 72.0 05:14:22 INFO - PROCESS | 1967 | 05:14:22 INFO - PROCESS | 1967 | [#4] audio-oscillator Cycles:10 Average:81.30 Median:78.00 stddev:13.36 (17.1%) stddev-sans-first:14.10 05:14:22 INFO - PROCESS | 1967 | Values: 85.0 90.0 92.0 71.0 70.0 68.0 96.0 70.0 68.0 103.0 05:14:22 INFO - PROCESS | 1967 | 05:14:22 INFO - PROCESS | 1967 | [#5] imaging-gaussian-blur Cycles:10 Average:96.10 Median:87.00 stddev:16.29 (18.7%) stddev-sans-first:17.01 05:14:22 INFO - PROCESS | 1967 | Values: 88.0 88.0 108.0 114.0 132.0 88.0 86.0 83.0 88.0 86.0 05:14:22 INFO - PROCESS | 1967 | 05:14:22 INFO - PROCESS | 1967 | [#6] imaging-darkroom Cycles:10 Average:96.10 Median:92.50 stddev:9.43 (10.2%) stddev-sans-first:9.89 05:14:22 INFO - PROCESS | 1967 | Values: 92.0 100.0 122.0 93.0 92.0 93.0 93.0 93.0 91.0 92.0 05:14:22 INFO - PROCESS | 1967 | 05:14:22 INFO - PROCESS | 1967 | [#7] imaging-desaturate Cycles:10 Average:85.30 Median:85.00 stddev:1.06 (1.2%) stddev-sans-first:1.09 05:14:22 INFO - PROCESS | 1967 | Values: 86.0 84.0 85.0 84.0 85.0 85.0 85.0 85.0 87.0 87.0 05:14:22 INFO - PROCESS | 1967 | 05:14:22 INFO - PROCESS | 1967 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:55.00 stddev:0.97 (1.8%) stddev-sans-first:0.88 05:14:22 INFO - PROCESS | 1967 | Values: 56.0 56.0 55.0 54.0 55.0 54.0 54.0 55.0 53.0 54.0 05:14:22 INFO - PROCESS | 1967 | 05:14:22 INFO - PROCESS | 1967 | [#9] json-stringify-tinderbox Cycles:10 Average:70.10 Median:69.50 stddev:3.51 (5.1%) stddev-sans-first:2.95 05:14:22 INFO - PROCESS | 1967 | Values: 64.0 73.0 77.0 73.0 70.0 69.0 68.0 69.0 69.0 69.0 05:14:22 INFO - PROCESS | 1967 | 05:14:22 INFO - PROCESS | 1967 | [#10] stanford-crypto-aes Cycles:10 Average:89.60 Median:86.00 stddev:12.12 (14.1%) stddev-sans-first:12.79 05:14:22 INFO - PROCESS | 1967 | Values: 86.0 85.0 85.0 86.0 86.0 86.0 84.0 87.0 124.0 87.0 05:14:22 INFO - PROCESS | 1967 | 05:14:22 INFO - PROCESS | 1967 | [#11] stanford-crypto-ccm Cycles:10 Average:141.20 Median:142.00 stddev:5.45 (3.8%) stddev-sans-first:5.77 05:14:22 INFO - PROCESS | 1967 | Values: 140.0 149.0 145.0 137.0 142.0 135.0 135.0 137.0 150.0 142.0 05:14:22 INFO - PROCESS | 1967 | 05:14:22 INFO - PROCESS | 1967 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.50 Median:164.00 stddev:2.17 (1.3%) stddev-sans-first:2.30 05:14:22 INFO - PROCESS | 1967 | Values: 164.0 165.0 164.0 163.0 163.0 162.0 161.0 166.0 160.0 167.0 05:14:22 INFO - PROCESS | 1967 | 05:14:22 INFO - PROCESS | 1967 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:1.05 (1.6%) stddev-sans-first:1.05 05:14:22 INFO - PROCESS | 1967 | Values: 66.0 68.0 68.0 67.0 66.0 67.0 67.0 66.0 66.0 69.0 05:14:22 INFO - PROCESS | 1967 | -------- Summary: end -------- 05:14:22 INFO - PROCESS | 1967 | 05:14:23 INFO - TEST-INFO | 1967: exit 0 05:14:23 INFO - TEST-OK | kraken | took 58920ms 05:14:23 INFO - SUITE-END | took 1175s 05:14:24 INFO - Completed test suite (00:19:35) 05:14:24 INFO - javascript benchmark 05:14:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3384.661533846614, 3392.4063288924435, 3406.523086767852, 3429.5198672185916, 3432.6738959798827, 5519.751611177497, 5563.0, 5602.1036634138545, 5646.294213223342, 5682.204491371206, 5600.831975040755, 5673.8581535461635, 5676.063449530822, 5679.5740319476, 5686.687232202227, 5068.341115654969, 5127.974405118973, 5149.098907691157, 5150.845474635767, 5203.5056669616515, 5205.3233079699585, 5215.921761173586, 5222.060029194743, 5226.111561034633, 5230.189320655304, 5065.873353166164, 5080.568151707109, 5107.233914912756, 5113.079645663779, 5203.375594928595, 5115.667481613702, 5197.948020519822, 5207.739613019372, 5210.835434476622, 5266.183741520071, 5006.374203224597, 5014.323066386028, 5083.034223497561, 5139.0749665060275, 5148.150555158394, 5413.810516631938, 5486.341639003345, 5516.503514683657, 5534.225208470817, 5583.3300003999375, 6118.9694051529905, 6197.566170368076, 6206.689665516707, 6215.533834962396, 6225.937740622627, 6122.093225952662, 6143.754249830002, 6164.815055548341, 6275.309715931244, 6308.0, 5726.7995620153515, 5768.278965129359, 5782.132680098019, 5812.070068788974, 5826.126081087786, 5559.336854081105, 6309.652969086653, 6317.715702793385, 6322.810315690536, 6335.461485773669, 6007.939920600826, 6051.667158306335, 6120.785772497941, 6121.204243448412, 6129.835331287041, 6268.717907694165, 6274.341194174546, 6284.937150628435, 6291.276503202099, 6313.0, 6187.0, 6214.8135555933395, 6215.254169499689, 6244.406781355764, 6252.6873656317, 6085.208922840091, 6107.267127944586, 6129.693515324216, 6158.775188339102, 6159.4456498915315, 4889.193283108319, 4918.975405123023, 4926.408830940239, 4934.284528743312, 4942.777575009133, 4368.60682538573, 4392.824287028547, 4431.468223813163, 4452.354408610733, 4474.597286244254, 5635.098384258499, 5635.830925072254, 5659.773609055674, 5666.603337766399, 5680.460356266148, 5137.460566640449, 6287.46556542699, 6304.275008374096, 6310.368963103653, 6318.810435686937, 4985.302057711923, 5503.091989821714, 5558.33300003994, 5606.495415412633, 5625.634333768292, 5244.31823862903, 5297.920531192035, 5300.0, 5300.1519756838725, 5302.443243459458, 6314.684265786692, 6324.873502529924, 6326.715297811702, 6346.524010699124, 6347.0479428086155, 6130.386961303834, 6166.506679465721, 6252.374762523711, 6260.843478913063, 6263.906041409291, 6261.843453913689, 6290.056491526308, 6305.4009869062365, 6347.96826015867, 6348.3651634838, 5118.283440318284, 6195.349488303663, 6202.689865506797, 6219.906701399573, 6257.968710156602, 6076.878462430638, 6128.717018009172, 6217.844553886189, 6264.154339164154, 6265.780697675559, 5988.371221021905, 6122.093225952662, 6131.835460087213, 6134.797803295058, 6146.279041868284, 6090.177825993612, 6113.17472141273, 6114.6636934969, 6121.908171377522, 6141.662208578571, 4550.863474095782, 5765.048766953406, 5869.148973398918, 5874.412558744091, 5938.970305148447, 6114.0236562776045, 6125.601746185103, 6126.142295209414, 6134.4789689280005, 6135.3188087147355, 5928.258967629046, 5932.733027013881, 5941.465268125889, 5945.821625351246, 5967.015442452121], "value": 5649.161038450371, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [496.60519886690076, 496.8136948644258, 514.5086442447463, 566.2248849855704, 598.766540925693, 31292.217694557618, 41767.79116104419, 43185.35221971665, 43208.56791432081, 45701.85745356368, 44402.55597444025, 44577.77711111448, 44664.0, 44727.881802954864, 44904.326435103416, 8428.115047919971, 9407.388519746211, 9616.80766384672, 9620.0, 9625.181859541948, 8602.87095693565, 9269.814603707922, 11580.0, 11585.246958947642, 11860.703482412922, 11596.478158482889, 11628.244164129304, 11655.358955257458, 11662.533498660086, 11679.5912143075, 8494.617742201615, 11328.207025508218, 11531.65405037846, 11614.883851161549, 11698.771628978962, 11461.656150315504, 11567.826482602768, 11578.305301681927, 11582.942085289604, 11616.303021818634, 41389.37915931264, 41863.37204941928, 41939.37090943638, 41944.79027604873, 41946.79026604878, 3509.859605615772, 3577.0, 3644.4168932970597, 3704.9814750926344, 3850.8844734658005, 32051.358972820413, 32301.0, 32695.50956735651, 32908.0, 33086.0, 2846.889713011927, 2903.3062384680766, 3076.0310502191737, 3322.6677332266822, 3349.447341188701, 394108.0, 407068.0, 407719.9614001911, 407783.0, 408510.9148908532, 63422.73154536976, 63624.68187659032, 63795.896328293624, 63817.04274435887, 64022.67988660027, 67055.65888682198, 67250.99123513151, 67291.32708672949, 67454.3254567448, 67460.66269668718, 16147.677046459004, 16384.83615163833, 16396.508104756875, 16397.262123204484, 16400.75398869018, 11266.267692599955, 11357.886421135683, 12246.326452045045, 12503.0, 12584.18202816814, 17745.911270443823, 17832.197551110232, 17848.19683114237, 17871.285148594172, 17945.820541794677, 6329.0, 7389.889151662729, 7503.2496750324535, 7509.51188172767, 7571.697132114764, 789.455275859655, 909.3589019741066, 909.4497828813605, 1009.1523120578603, 1038.657243109772, 21886.671699924515, 27527.724722752515, 30940.69059309423, 30976.53535196974, 31763.36473270568, 1107.64001699448, 1109.4286442482128, 1122.6575894352138, 1173.3487914207697, 1176.3412489006014, 13319.0, 15984.36062557508, 16014.519564413085, 16091.0, 16397.180140992903, 687410.0, 693617.0, 694911.0, 696072.0, 697620.0, 59641.403585963584, 61370.0, 61442.692786536674, 61454.692726536974, 61478.38521614816, 1305.8367704036996, 1335.8263425754783, 1419.2052450627475, 1439.172475826404, 1449.978250326225, 31486.842565787025, 32028.51957220597, 32142.678573214904, 32819.671803281664, 32957.0, 52618.21072683989, 53376.466235337146, 53393.0, 53502.662433437916, 53529.0, 560612.0, 564596.0, 565410.0, 565747.1712641411, 784156.0, 41807.581924181584, 42850.57149428466, 42971.92570185645, 45295.7735211335, 45790.31314530218, 49909.25136122888, 50165.74585635242, 50541.0, 51657.74171129271, 51687.74156129195, 38249.4262586067, 40204.79897600493, 40221.994450138984, 40742.0175162496, 41900.0, 36196.81901590475, 39167.0, 39335.60664393319, 39635.60364396319, 40436.0, 39104.608953910094, 39552.80223598979, 39912.0, 39968.00079998023, 40011.399829002, 28573.571396428655, 34683.47974780431, 35439.64560354467, 35612.0, 35729.46405803967, 20313.695294570298, 25661.845216965656, 26052.088176913716, 26251.484812489456, 26416.603750944134], "value": 20896.791746718594, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.16553664705964, 382.9597892221317, 386.04261431649525, 397.1084914367246, 406.4411434277868, 20350.89824550877, 21630.89184554075, 21842.89078554605, 22041.448963775914, 22048.11807527699, 19020.524486887836, 20724.27465038724, 21656.89171554144, 21719.782802171972, 21744.238951636657, 5531.917021244684, 5650.011248031578, 5842.737076831553, 5855.355910849803, 5856.648601083927, 4108.4864391951005, 4322.935155972647, 5809.0, 6163.660998645073, 6536.967315163418, 6427.710753016102, 6515.0553169790355, 6526.086347911296, 6528.673566321689, 6533.0, 6320.431161195492, 6495.155629768147, 6505.837354066186, 6506.804795856132, 6516.120323756303, 3586.7668601541077, 5239.161734122522, 5605.663660180361, 5622.971885140548, 5641.633293835887, 25656.230313090637, 25948.61077083845, 26219.868900655376, 26300.473990520273, 26517.73482265172, 1976.3675623800389, 2212.325240801555, 2292.7821856923565, 2387.8925448354694, 2441.6215486599604, 9942.552585133613, 10221.488925553767, 10412.947935260276, 10538.420386878719, 10572.0, 1900.942971710851, 1924.162989099746, 1952.1215453046186, 2003.6994450832347, 2012.8993550322425, 127189.36405318006, 129879.70120298771, 130687.0, 132303.0, 134540.999999999, 11365.602203922823, 11464.770704585862, 11538.192326537062, 11560.421978901022, 11582.71043223926, 14501.564953051426, 14651.34068966899, 14667.92666036663, 14668.339924703414, 14682.55952321432, 8361.665533378597, 8454.957725211334, 8485.448445851, 8501.65993360271, 8626.611802468778, 7330.523515971445, 7980.042394912648, 8428.789280268042, 8477.95761021191, 8518.957405212934, 4490.371348011281, 4576.26779715244, 4599.0, 4632.0, 4642.86071417858, 1796.0630764885173, 1804.5939663575853, 1818.0, 1918.4052943587533, 1947.4741819708884, 901.9729408117636, 914.5518695838991, 971.5919313888184, 1005.894381089975, 1008.9041541053588, 17820.19809108593, 20755.58488830215, 20896.895515522327, 20924.790752092587, 21095.26166584193, 937.634322614181, 963.8939716631165, 967.5210770668564, 995.6415690351467, 1021.0147207944221, 10904.182186336056, 10973.189423745152, 11038.448077596087, 11084.778304433867, 11087.002169804757, 608553.0, 615463.0, 617774.9111254415, 618363.0, 620598.0, 103359.0, 129145.77135571686, 129764.0, 135945.0, 138731.0, 1009.0918173643779, 1017.760826205841, 1050.6847945616285, 1068.3643232276784, 1074.6023971130733, 15194.088354698753, 17813.376531821323, 18279.725804112684, 18366.449006529827, 18377.448676539727, 50064.74838129076, 50072.49927500824, 53311.733441332544, 53598.196027058846, 53977.73011134919, 80515.59742201252, 81845.0, 81906.0, 83637.16362836538, 92561.0, 6978.581285122909, 7355.77932662021, 7575.659095340613, 7844.254795794391, 8458.74623761288, 9328.860067098864, 12755.426005829575, 13185.626587214394, 13621.0, 13635.454581816617, 11230.83153752678, 11524.82712759326, 11554.306741595532, 11697.0, 11737.765244695229, 9124.726258212264, 10892.945535272273, 11298.548058077586, 11813.704657383634, 11849.881501185222, 11766.411679415824, 11777.524540674489, 12022.879771202175, 12076.456559455022, 12213.633590992284, 6769.255381907888, 7142.285771422816, 7471.8879216812875, 8024.959875200587, 8425.578721064045, 10691.732706682395, 11129.777404452028, 11730.648080557597, 11819.0, 11837.940810295893], "value": 9679.530124456152, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1401.761700510913, 1405.5502239283421, 1544.2047345617007, 1770.7255375416808, 1971.6549603819337, 7884.329831964283, 8368.121347258542, 8635.13648635136, 8861.556922153899, 8906.599203035863, 8674.739757807276, 8783.165599268059, 8881.333899957497, 8889.511076890769, 8904.376693631448, 2366.337425520857, 2395.317334559651, 2400.1359510576267, 2407.2417188585628, 2411.2284069097896, 2349.6827928229727, 2380.071772008918, 2389.82076344274, 2390.306811024801, 2403.182917807954, 2360.6459031145296, 2374.299581623425, 2388.605880029793, 2393.808495320379, 2395.0, 2328.1502251678016, 2347.507023525062, 2354.6468029795583, 2356.5051339218785, 2376.2871138658506, 2320.5706944215376, 2351.870647114408, 2356.988215058931, 2360.079568968104, 2367.562001029815, 8796.07641197678, 8898.976617688919, 8900.821983560292, 8902.777430564223, 8911.420757650732, 5166.276721258989, 5372.919406208871, 5379.408265090837, 5404.3784964728775, 5408.486193811582, 3522.189896323834, 3640.9635903640888, 3737.1501106952232, 3739.6260373962386, 3748.025513366517, 1072.7425417899726, 1082.2099867097063, 1091.1434523898702, 1096.353151640528, 1112.7106952192407, 11603.941980290128, 11737.765244695058, 11741.58904438349, 11746.0, 11746.29522228669, 3810.9047273817823, 4508.729476231437, 4539.682222244412, 4665.626749860003, 4666.813327466931, 9215.95392023049, 9243.0, 9248.630054797868, 9260.39807412516, 9273.026332235153, 4652.767361631905, 5293.676580854786, 5301.045811753845, 5309.230161626542, 5311.681299122065, 4404.889877753082, 4563.155816174019, 4624.815007399667, 4775.403074615673, 4900.215965445583, 3725.6088110747983, 3768.4535742317757, 3810.40938654509, 3842.7502212356667, 3915.647591716759, 1084.1326938449208, 1163.4124766992616, 1167.3871217610651, 1176.8999635030948, 1179.015522039107, 651.3681728723132, 805.5931754463958, 927.2118699105706, 958.9280803939732, 1002.6590959073804, 5989.8203053908455, 6040.546958978094, 6053.364396738367, 6231.034189700604, 6234.127222188898, 480.1549273279054, 489.6156517134033, 491.9163742163841, 501.20558914120795, 645.5642441352069, 3840.3663395539984, 4075.7146999709735, 4125.97937010313, 4126.174765047002, 4131.35963925592, 8949.731508054769, 10437.425941573287, 10717.303375280582, 10835.729106772395, 10899.67300980956, 10786.0, 10848.511816968256, 10861.83707244392, 10864.293820901616, 10865.967733065347, 7915.12933577306, 8245.95877020623, 8284.005919289724, 8289.171082891784, 8384.868042814263, 6080.543959203166, 6100.75596976116, 6120.143179954899, 6184.5052395809125, 6293.213348331458, 9861.457619830979, 9890.901090988998, 10201.0, 10207.285490015925, 10227.488625568543, 10121.190304775748, 10338.379697218192, 10338.689839304832, 10450.477476126316, 10510.684679459628, 7253.3834624057545, 7332.0, 7409.62951852416, 7411.888821667787, 7429.851402972018, 8188.0993090758775, 8420.5789710513, 8441.36689748259, 8451.915480845359, 8478.02502712196, 6070.817875463743, 7520.699172033057, 7525.023475116394, 7771.222877712184, 7798.0, 7434.405247580073, 7544.547327160388, 7597.088349398107, 7659.693612255447, 7659.770206893802, 7047.295270473117, 7064.894026589503, 7133.500654954103, 7156.0, 7169.175544812205, 4365.257906156025, 4935.62982776286, 5040.773165207501, 5158.329417175743, 5167.372277732502, 4315.805788739577, 5198.948010519846, 5214.32213812202, 5219.451957544555, 5220.425753167073], "value": 4512.646932426243, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.0802540214242, 303.2056013245297, 316.18897527841085, 319.98880039198633, 322.9854656540455, 4702.85891423257, 5298.284731561238, 5372.012355428487, 5383.3849845046425, 5413.756380962856, 4929.0, 5119.2577076324005, 5129.743512824362, 5154.252633368159, 5331.626786124973, 3323.7507186961075, 3940.2119576084756, 3955.4660120883746, 3960.544537378195, 3980.4029395590605, 3394.2871996880685, 4006.8196931138023, 4025.657819085381, 4033.6773058155277, 4041.1513582147636, 3579.821008949555, 3608.747387682863, 3830.367989281779, 3900.921981560367, 4023.8189281482405, 3747.400415933465, 3947.6052394760436, 3971.285168669638, 3991.62289010291, 4018.57804930481, 3107.052349033544, 3201.599800024997, 3415.8633654653786, 3419.1623052352334, 3431.330890476358, 4063.878083657495, 4576.977115114403, 4987.650864439491, 5070.771815268285, 5093.312402825645, 3849.7305188636806, 4593.26507758757, 4603.378543896598, 4616.0537089896825, 4631.976840115812, 4813.975930120362, 5023.2214006829, 5142.897142057175, 5449.700266485342, 5521.337439507285, 3387.9830600847085, 3410.488426735985, 3481.9651803481893, 3740.195857890539, 3748.9625103748886, 5042.823501177441, 5747.729646789537, 5776.42235776419, 5778.451047150514, 5815.214945982323, 3567.5362202913457, 3792.5259342582176, 3794.5636251831393, 3810.980945095312, 3853.9574025766387, 3341.498775183742, 3889.202713443737, 3907.7920974649232, 3911.3155197840265, 3923.293807114747, 4167.74993500391, 4498.707584007029, 4512.210363186495, 4528.705634133771, 4566.406367172246, 5054.317667114966, 5134.2298655201275, 5217.426083130853, 5625.296837895263, 5677.77288908439, 1132.8470656461272, 1249.28790589365, 1302.2512055567897, 1339.4240476594962, 1346.7104572516955, 738.9482736208521, 810.8256724804196, 849.5837039850429, 952.2762700347786, 957.1911734584265, 4486.295207821007, 4769.76151192439, 4771.308160316804, 5069.822556210589, 5156.871078222999, 4723.456802467692, 5248.580113590903, 5736.512396446349, 5749.8562535936935, 5750.856228594319, 4450.064222063413, 4486.416765820422, 4915.1644220481885, 5265.447128051576, 5273.419923808378, 2539.159109645529, 3023.4406634772636, 3033.9848300758354, 3058.1590062732926, 3071.8957514102913, 4953.925691114636, 5554.805581804699, 5942.286925568959, 5959.672218027963, 5998.520118390518, 5062.772175252123, 5084.1188760158975, 5639.718014099279, 5702.657840529581, 5927.347991720907, 5551.945130425206, 5883.676397798076, 6027.578069535178, 6054.0, 6062.18160548338, 5303.231031500488, 5373.596980226421, 5737.885242295214, 5770.538356931519, 5827.475527202572, 4598.448186217675, 5072.6557462271785, 5218.373795144607, 5621.409751975983, 5665.518430933417, 4993.325901003318, 5578.888422231614, 6010.278766548042, 6034.366391529002, 6043.879122417615, 3640.0899775056237, 3748.362778327636, 3805.562360328487, 3830.9808450957566, 3839.6961822906032, 5325.973370133124, 5738.368779434342, 5759.9136012959, 5801.36185019639, 5818.854528636818, 4439.62263207631, 5366.570674345965, 5587.385387607279, 5640.294963129609, 5646.265985421869, 5504.752286147213, 5584.916226256528, 5592.965301419251, 5605.299337582802, 5608.186812912023, 4251.936220956626, 4674.92987605193, 5143.794248230179, 5372.328458942632, 5514.255575497256, 5258.947410525846, 5578.079616863172, 5634.295713035871, 5639.351474580311, 5681.659100453986, 4723.7401942893475, 5444.945550544444, 5461.235427040297, 5497.945020549743, 5506.2743941749095], "value": 4020.5882150973052, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [739.737393225405, 838.5597561280323, 842.6376658037045, 871.9275291391584, 896.9596368163434, 15316.923415382935, 15346.539603811889, 15579.922100389482, 15589.844101558981, 15659.373625054985, 14094.436222551085, 14112.012159148864, 14124.788128178085, 14172.0, 14178.71642567148, 699.5802518488916, 732.1872721279402, 884.4428010353469, 903.9638414463413, 904.2223687628634, 862.9266512346458, 910.6630546697731, 911.3529394130176, 912.9132732390445, 914.9771255718593, 958.6165533786507, 968.9079537443931, 968.9854652180223, 969.3505351414534, 970.2480577552418, 945.2249155692335, 962.0812124421161, 962.7208109648194, 962.7496850818768, 963.7590602349447, 546.8222827581052, 679.2528218959155, 712.5012491256141, 714.9356557909813, 717.5156769180834, 14640.194789286585, 14649.340779664833, 14689.192094434802, 14693.485727999576, 14698.33857476416, 13243.47026118954, 13552.186868787905, 13627.318634068357, 13646.86353136466, 13850.547358400818, 11732.296062236208, 12030.63908082759, 12306.0, 12339.62981110568, 12675.112742108056, 4424.823007079713, 4445.799939002753, 4446.133004064209, 4548.113117942003, 4612.285095810154, 78479.6076019622, 79974.0, 80146.59926700387, 80316.59841700754, 81096.0, 10763.623273185402, 10867.130629549618, 11111.555417820502, 11154.776904461865, 11241.60654377093, 21112.577748444946, 21115.0, 21139.47151321229, 21143.577128457346, 21149.836758978097, 7786.221377862282, 7901.486403383762, 7903.723369682033, 7938.404619653549, 8028.43800933929, 3639.9818000909827, 4374.671899607542, 4396.956030439655, 4432.734035957853, 4574.565416285448, 3377.5778027746533, 3446.362422951762, 3479.7912125272564, 3485.1635607454537, 3486.89539313821, 575.4475703324855, 667.3893387550434, 668.6756922892394, 692.4598812925926, 693.414065114977, 557.4509108528097, 568.2782865760461, 633.1990032608753, 639.4404895716249, 656.6158797103652, 7505.274340520327, 8679.439565328243, 8829.426087304304, 8924.419912705653, 9047.230985366186, 564.1058921609214, 614.4869034356274, 645.3353046362255, 655.783591414832, 659.788867562385, 3122.828244446577, 3506.859725610998, 4115.176964607091, 4252.574742525784, 4328.567143285709, 87346.68979965306, 90298.09701902897, 95644.0, 95790.0420995795, 95884.52057739667, 74310.25689743142, 78419.0, 83190.0, 84188.0, 84753.57623211968, 66033.66983165054, 66063.66968165128, 66192.6761464768, 67390.0, 67395.0, 7789.532628042336, 8046.7929810528885, 8127.75616731499, 8277.213664701843, 8438.789030274293, 45915.0, 45971.540284598064, 46717.0, 47639.523604764894, 47795.566133016066, 59291.0, 63072.05391919216, 63184.0, 63471.6826415865, 63564.68217658882, 11136.55453781872, 11155.442227888736, 11356.886431135914, 11494.96545310926, 11789.76420471603, 11380.317180969168, 11827.526898923947, 11852.881471185177, 12401.0, 12416.006719462603, 11100.389478578756, 11447.370394628375, 11664.475098620413, 11741.76516469683, 11745.588904388305, 11271.211015228855, 11383.373914434786, 11407.657770266906, 11703.824442633197, 11759.588414405454, 11090.889091108986, 11101.777964440827, 11514.36670983104, 11560.94219528897, 11663.475143618387, 9367.859482107637, 9377.390469619726, 9453.952730236304, 9649.0, 9703.417794932328, 8107.594620269081, 8706.0, 8838.646454141763, 9628.518574071408, 9790.167835734042], "value": 7062.941122459127, "unit": "score"}], "name": "dromaeo_css", "value": 7260.150468106139, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 106.0, 112.0, 113.0, 112.0, 113.0, 112.0, 161.0, 167.0, 126.0], "value": 123.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 119.0, 118.0, 171.0, 134.0, 112.0, 138.0, 139.0, 149.0, 117.0], "value": 135.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 183.0, 185.0, 185.0, 183.0, 181.0, 183.0, 184.0, 182.0, 178.0], "value": 182.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 73.0, 56.0, 107.0, 57.0, 57.0, 60.0, 65.0, 98.0, 72.0], "value": 72.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 90.0, 92.0, 71.0, 70.0, 68.0, 96.0, 70.0, 68.0, 103.0], "value": 81.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 108.0, 114.0, 132.0, 88.0, 86.0, 83.0, 88.0, 86.0], "value": 96.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 100.0, 122.0, 93.0, 92.0, 93.0, 93.0, 93.0, 91.0, 92.0], "value": 96.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 85.0, 84.0, 85.0, 85.0, 85.0, 85.0, 87.0, 87.0], "value": 85.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 55.0, 54.0, 55.0, 54.0, 54.0, 55.0, 53.0, 54.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 73.0, 77.0, 73.0, 70.0, 69.0, 68.0, 69.0, 69.0, 69.0], "value": 70.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 85.0, 86.0, 86.0, 86.0, 84.0, 87.0, 124.0, 87.0], "value": 89.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 149.0, 145.0, 137.0, 142.0, 135.0, 135.0, 137.0, 150.0, 142.0], "value": 141.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 164.0, 163.0, 163.0, 162.0, 161.0, 166.0, 160.0, 167.0], "value": 163.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 68.0, 67.0, 66.0, 67.0, 67.0, 66.0, 66.0, 69.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1459.4, "alertThreshold": 2.0}]} 05:14:24 INFO - Return code: 0 05:14:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:14:24 ERROR - # TBPL SUCCESS # 05:14:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:14:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:14:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:14:24 INFO - 2016-06-02 05:14:24.247 screenresolution[1971:21051] starting screenresolution argv=screenresolution get 05:14:24 INFO - 2016-06-02 05:14:24.250 screenresolution[1971:21051] Display 0: 1600x1200x32@60 05:14:24 INFO - 2016-06-02 05:14:24.256 screenresolution[1972:21054] starting screenresolution argv=screenresolution list 05:14:24 INFO - Available Modes on Display 0 05:14:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:14:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:14:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:14:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:14:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:14:24 INFO - Intel Iris: 05:14:24 INFO - Chipset Model: Intel Iris 05:14:24 INFO - Type: GPU 05:14:24 INFO - Bus: Built-In 05:14:24 INFO - VRAM (Dynamic, Max): 1536 MB 05:14:24 INFO - Vendor: Intel (0x8086) 05:14:24 INFO - Device ID: 0x0a2e 05:14:24 INFO - Revision ID: 0x0009 05:14:24 INFO - Displays: 05:14:24 INFO - Display: 05:14:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:14:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:14:24 INFO - Display Serial Number: 1600x1200 60 05:14:24 INFO - Main Display: Yes 05:14:24 INFO - Mirror: Off 05:14:24 INFO - Online: Yes 05:14:24 INFO - Rotation: Supported 05:14:24 INFO - Return code: 0 05:14:24 INFO - Running post-action listener: _resource_record_post_action 05:14:24 INFO - ##### 05:14:24 INFO - ##### Finished run-tests step (success) 05:14:24 INFO - ##### 05:14:24 INFO - Running post-run listener: _resource_record_post_run 05:14:24 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 163840; Write bytes: 698486272; Read time: 5; Write time: 2154 05:14:24 INFO - TinderboxPrint: CPU usage
53.5% 05:14:24 INFO - TinderboxPrint: I/O read bytes / time
163,840 / 5 05:14:24 INFO - TinderboxPrint: I/O write bytes / time
698,486,272 / 2,154 05:14:24 INFO - TinderboxPrint: CPU idle
2,252.4 (46.5%) 05:14:24 INFO - TinderboxPrint: CPU system
963.0 (19.9%) 05:14:24 INFO - TinderboxPrint: CPU user
1,630.2 (33.6%) 05:14:24 INFO - TinderboxPrint: Swap in / out
399,732,736 / 0 05:14:24 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 386886144; Write bytes: 381687296; Read time: 28986; Write time: 728 05:14:24 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 163840; Write bytes: 295000064; Read time: 5; Write time: 1382 05:14:24 INFO - Running post-run listener: _upload_blobber_files 05:14:24 INFO - Blob upload gear active. 05:14:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:14:24 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 05:14:24 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'] 05:14:24 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 05:14:25 INFO - (blobuploader) - INFO - Open directory for files ... 05:14:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:14:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:14:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:14:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:14:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:14:26 INFO - (blobuploader) - INFO - Done attempting. 05:14:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:14:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:14:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:14:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:14:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:14:27 INFO - (blobuploader) - INFO - Done attempting. 05:14:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:14:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:14:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:14:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:14:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:14:29 INFO - (blobuploader) - INFO - Done attempting. 05:14:29 INFO - (blobuploader) - INFO - Iteration through files over. 05:14:29 INFO - Return code: 0 05:14:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:14:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:14:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5f168f89de16ac4d240c5130cbc6d99389ef2c50463e3320681405d47c588401e451b39fdbba5ff8b94c4df4f72ea3b6aa63ea476a84cd9a1f3cf90e5f798150", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5ed4641422b9b60339cd0e5ce1886a98cb3d08a93b37245709815d71713d9fd761f238cfa4d32ff41c7572ac01155a0836c8fc508f960e39bf538b622a0f5432", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/41c12bd01976317e48d79e9abc2b57b14a8a8d42ffcd7d2aca0e4a3373d7cf3f4b93b0026e27664ba8679bacf482b58eaa05d768503137932d2905d4e50fed9b"} 05:14:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:14:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:14:29 INFO - Contents: 05:14:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5f168f89de16ac4d240c5130cbc6d99389ef2c50463e3320681405d47c588401e451b39fdbba5ff8b94c4df4f72ea3b6aa63ea476a84cd9a1f3cf90e5f798150", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5ed4641422b9b60339cd0e5ce1886a98cb3d08a93b37245709815d71713d9fd761f238cfa4d32ff41c7572ac01155a0836c8fc508f960e39bf538b622a0f5432", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/41c12bd01976317e48d79e9abc2b57b14a8a8d42ffcd7d2aca0e4a3373d7cf3f4b93b0026e27664ba8679bacf482b58eaa05d768503137932d2905d4e50fed9b"} 05:14:29 INFO - Running post-run listener: copy_logs_to_upload_dir 05:14:29 INFO - Copying logs to upload dir... 05:14:29 INFO - mkdir: /builds/slave/test/build/upload/logs 05:14:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1479.769905 ========= master_lag: 0.43 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 24 mins, 40 secs) (at 2016-06-02 05:14:30.363754) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 05:14:30.368189) ========= 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.VXA8m0gRY8/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.WckHtTDF0V/Listeners TMPDIR=/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/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/5f168f89de16ac4d240c5130cbc6d99389ef2c50463e3320681405d47c588401e451b39fdbba5ff8b94c4df4f72ea3b6aa63ea476a84cd9a1f3cf90e5f798150", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5ed4641422b9b60339cd0e5ce1886a98cb3d08a93b37245709815d71713d9fd761f238cfa4d32ff41c7572ac01155a0836c8fc508f960e39bf538b622a0f5432", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/41c12bd01976317e48d79e9abc2b57b14a8a8d42ffcd7d2aca0e4a3373d7cf3f4b93b0026e27664ba8679bacf482b58eaa05d768503137932d2905d4e50fed9b"} build_url:https://queue.taskcluster.net/v1/task/WmJ4ZOLdSTqvVE78bxgnXw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011094 build_url: 'https://queue.taskcluster.net/v1/task/WmJ4ZOLdSTqvVE78bxgnXw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5f168f89de16ac4d240c5130cbc6d99389ef2c50463e3320681405d47c588401e451b39fdbba5ff8b94c4df4f72ea3b6aa63ea476a84cd9a1f3cf90e5f798150", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5ed4641422b9b60339cd0e5ce1886a98cb3d08a93b37245709815d71713d9fd761f238cfa4d32ff41c7572ac01155a0836c8fc508f960e39bf538b622a0f5432", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/41c12bd01976317e48d79e9abc2b57b14a8a8d42ffcd7d2aca0e4a3373d7cf3f4b93b0026e27664ba8679bacf482b58eaa05d768503137932d2905d4e50fed9b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 05:14:30.403249) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 05:14:30.403747) ========= 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.VXA8m0gRY8/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.WckHtTDF0V/Listeners TMPDIR=/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/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.005283 ========= master_lag: 0.10 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 05:14:30.511143) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 05:14:30.511521) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 05:14:30.512195) ========= ========= Total master_lag: 0.63 =========