builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0209 starttime: 1468404200.2 results: success (0) buildid: 20160713010309 builduid: cb4e951959164b369f43d78d0625ccc1 revision: 7054f1c4d2b11ed3511731565a264e4521cba9b4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 03:03:20.201148) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 03:03:20.201642) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 03:03:20.201979) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 03:03:20.227490) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 03:03:20.227905) ========= 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.pOPZrHlnlN/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.K6829h2fJM/Listeners TMPDIR=/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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-07-13 03:03:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.2M=0.001s 2016-07-13 03:03:20 (19.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.088341 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 03:03:20.339661) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 03:03:20.340043) ========= 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.pOPZrHlnlN/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.K6829h2fJM/Listeners TMPDIR=/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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.025561 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 03:03:20.389107) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-13 03:03:20.389532) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7054f1c4d2b11ed3511731565a264e4521cba9b4 --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 7054f1c4d2b11ed3511731565a264e4521cba9b4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.pOPZrHlnlN/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.K6829h2fJM/Listeners TMPDIR=/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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-07-13 03:03:20,471 truncating revision to first 12 chars 2016-07-13 03:03:20,471 Setting DEBUG logging. 2016-07-13 03:03:20,472 attempt 1/10 2016-07-13 03:03:20,472 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7054f1c4d2b1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-13 03:03:21,475 unpacking tar archive at: fx-team-7054f1c4d2b1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.256898 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-13 03:03:21.668630) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 03:03:21.669020) ========= script_repo_revision: 7054f1c4d2b11ed3511731565a264e4521cba9b4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 03:03:21.669477) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 03:03:21.669815) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 03:03:21.688917) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-07-13 03:03:21.689247) ========= /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.pOPZrHlnlN/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.K6829h2fJM/Listeners TMPDIR=/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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 03:03:21 INFO - MultiFileLogger online at 20160713 03:03:21 in /builds/slave/test 03:03:21 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 03:03:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:03:21 INFO - {'append_to_log': False, 03:03:21 INFO - 'base_work_dir': '/builds/slave/test', 03:03:21 INFO - 'blob_upload_branch': 'Fx-Team', 03:03:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:03:21 INFO - 'branch': 'Fx-Team', 03:03:21 INFO - 'buildbot_json_path': 'buildprops.json', 03:03:21 INFO - 'config_files': ('talos/mac_config.py',), 03:03:21 INFO - 'default_actions': ('clobber', 03:03:21 INFO - 'read-buildbot-config', 03:03:21 INFO - 'download-and-extract', 03:03:21 INFO - 'populate-webroot', 03:03:21 INFO - 'create-virtualenv', 03:03:21 INFO - 'install', 03:03:21 INFO - 'run-tests'), 03:03:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:03:21 INFO - 'download_minidump_stackwalk': True, 03:03:21 INFO - 'download_symbols': 'ondemand', 03:03:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:03:21 INFO - 'tooltool.py': '/tools/tooltool.py', 03:03:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:03:21 INFO - '/tools/misc-python/virtualenv.py')}, 03:03:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:03:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:03:21 INFO - 'installer_path': 'installer.exe', 03:03:21 INFO - 'log_level': 'info', 03:03:21 INFO - 'log_name': 'talos', 03:03:21 INFO - 'log_to_console': True, 03:03:21 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:03:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:03:21 INFO - 'opt_config_files': (), 03:03:21 INFO - 'pip_index': False, 03:03:21 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:03:21 INFO - 'cmd': ('bash', 03:03:21 INFO - '-c', 03:03:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:03:21 INFO - 'enabled': True, 03:03:21 INFO - 'halt_on_failure': False, 03:03:21 INFO - 'name': 'check_screen_resolution'},), 03:03:21 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:03:21 INFO - 'cmd': ('bash', 03:03:21 INFO - '-c', 03:03:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:03:21 INFO - 'enabled': True, 03:03:21 INFO - 'halt_on_failure': False, 03:03:21 INFO - 'name': 'check_screen_resolution'},), 03:03:21 INFO - 'run_cmd_checks_enabled': True, 03:03:21 INFO - 'sps_profile': False, 03:03:21 INFO - 'sps_profile_interval': 0, 03:03:21 INFO - 'suite': 'dromaeojs', 03:03:21 INFO - 'system_bits': '32', 03:03:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:03:21 INFO - 'title': 't-yosemite-r7-0209', 03:03:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:03:21 INFO - 'use_talos_json': True, 03:03:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:03:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:03:21 INFO - 'work_dir': 'build'} 03:03:21 INFO - ##### 03:03:21 INFO - ##### Running clobber step. 03:03:21 INFO - ##### 03:03:21 INFO - Running pre-action listener: _resource_record_pre_action 03:03:21 INFO - Running main action method: clobber 03:03:21 INFO - rmtree: /builds/slave/test/build 03:03:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:03:23 INFO - Running post-action listener: _resource_record_post_action 03:03:23 INFO - ##### 03:03:23 INFO - ##### Finished clobber step (success) 03:03:23 INFO - ##### 03:03:23 INFO - ##### 03:03:23 INFO - ##### Running read-buildbot-config step. 03:03:23 INFO - ##### 03:03:23 INFO - Running pre-action listener: _resource_record_pre_action 03:03:23 INFO - Running main action method: read_buildbot_config 03:03:23 INFO - Using buildbot properties: 03:03:23 INFO - { 03:03:23 INFO - "project": "", 03:03:23 INFO - "product": "firefox", 03:03:23 INFO - "script_repo_revision": "production", 03:03:23 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 03:03:23 INFO - "repository": "", 03:03:23 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 03:03:23 INFO - "buildid": "20160713010309", 03:03:23 INFO - "pgo_build": "False", 03:03:23 INFO - "basedir": "/builds/slave/test", 03:03:23 INFO - "buildnumber": 103, 03:03:23 INFO - "slavename": "t-yosemite-r7-0209", 03:03:23 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 03:03:23 INFO - "platform": "yosemite_r7", 03:03:23 INFO - "scheduler": "tests-fx-team-macosx64-talos", 03:03:23 INFO - "branch": "fx-team", 03:03:23 INFO - "repo_path": "integration/fx-team", 03:03:23 INFO - "revision": "7054f1c4d2b11ed3511731565a264e4521cba9b4", 03:03:23 INFO - "stage_platform": "macosx64", 03:03:23 INFO - "builduid": "cb4e951959164b369f43d78d0625ccc1", 03:03:23 INFO - "slavebuilddir": "test" 03:03:23 INFO - } 03:03:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/eVSHIxfpSFaORQLGScN6yg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 03:03:23 INFO - Running post-action listener: _resource_record_post_action 03:03:23 INFO - ##### 03:03:23 INFO - ##### Finished read-buildbot-config step (success) 03:03:23 INFO - ##### 03:03:23 INFO - ##### 03:03:23 INFO - ##### Running download-and-extract step. 03:03:23 INFO - ##### 03:03:23 INFO - Running pre-action listener: _resource_record_pre_action 03:03:23 INFO - Running main action method: download_and_extract 03:03:23 INFO - mkdir: /builds/slave/test/build/tests 03:03:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:03:23 INFO - https://queue.taskcluster.net/v1/task/eVSHIxfpSFaORQLGScN6yg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 03:03:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVSHIxfpSFaORQLGScN6yg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 03:03:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVSHIxfpSFaORQLGScN6yg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 03:03:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVSHIxfpSFaORQLGScN6yg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 03:03:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVSHIxfpSFaORQLGScN6yg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #1 03:03:26 INFO - Downloaded 1199 bytes. 03:03:26 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 03:03:26 INFO - Using the following test package requirements: 03:03:26 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 03:03:26 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 03:03:26 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 03:03:26 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 03:03:26 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 03:03:26 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 03:03:26 INFO - u'jsshell-mac.zip'], 03:03:26 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 03:03:26 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 03:03:26 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 03:03:26 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 03:03:26 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 03:03:26 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 03:03:26 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 03:03:26 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 03:03:26 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 03:03:26 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 03:03:26 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 03:03:26 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:03:26 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')]} 03:03:26 INFO - https://queue.taskcluster.net/v1/task/eVSHIxfpSFaORQLGScN6yg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:03:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVSHIxfpSFaORQLGScN6yg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 03:03:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVSHIxfpSFaORQLGScN6yg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 03:03:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVSHIxfpSFaORQLGScN6yg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 03:03:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVSHIxfpSFaORQLGScN6yg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:03:27 INFO - Downloaded 18822773 bytes. 03:03:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:03:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 03:03:30 INFO - Return code: 0 03:03:30 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip', u'firefox-50.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 03:03:30 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')]} 03:03:30 INFO - https://queue.taskcluster.net/v1/task/eVSHIxfpSFaORQLGScN6yg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:03:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVSHIxfpSFaORQLGScN6yg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 03:03:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVSHIxfpSFaORQLGScN6yg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 03:03:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVSHIxfpSFaORQLGScN6yg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 03:03:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVSHIxfpSFaORQLGScN6yg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:03:31 INFO - Downloaded 18822773 bytes. 03:03:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:03:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 03:03:35 INFO - Return code: 0 03:03:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:03:35 INFO - https://queue.taskcluster.net/v1/task/eVSHIxfpSFaORQLGScN6yg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 03:03:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVSHIxfpSFaORQLGScN6yg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 03:03:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVSHIxfpSFaORQLGScN6yg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 03:03:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVSHIxfpSFaORQLGScN6yg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip 03:03:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVSHIxfpSFaORQLGScN6yg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip'}, attempt #1 03:03:36 INFO - Downloaded 14403317 bytes. 03:03:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:03:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 03:03:36 INFO - Return code: 0 03:03:36 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')]} 03:03:36 INFO - https://queue.taskcluster.net/v1/task/eVSHIxfpSFaORQLGScN6yg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 03:03:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVSHIxfpSFaORQLGScN6yg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 03:03:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVSHIxfpSFaORQLGScN6yg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 03:03:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVSHIxfpSFaORQLGScN6yg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 03:03:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVSHIxfpSFaORQLGScN6yg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg'}, attempt #1 03:03:39 INFO - Downloaded 112767644 bytes. 03:03:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eVSHIxfpSFaORQLGScN6yg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 03:03:39 INFO - mkdir: /builds/slave/test/properties 03:03:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:03:39 INFO - Writing to file /builds/slave/test/properties/build_url 03:03:39 INFO - Contents: 03:03:39 INFO - build_url:https://queue.taskcluster.net/v1/task/eVSHIxfpSFaORQLGScN6yg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 03:03:40 INFO - Running post-action listener: _resource_record_post_action 03:03:40 INFO - Running post-action listener: set_extra_try_arguments 03:03:40 INFO - ##### 03:03:40 INFO - ##### Finished download-and-extract step (success) 03:03:40 INFO - ##### 03:03:40 INFO - ##### 03:03:40 INFO - ##### Running populate-webroot step. 03:03:40 INFO - ##### 03:03:40 INFO - Running pre-action listener: _resource_record_pre_action 03:03:40 INFO - Running main action method: populate_webroot 03:03:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:03:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:03:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:03:40 INFO - '--tppagecycles', 03:03:40 INFO - '7'], 03:03:40 INFO - 'tests': ['tsvgm']}}, 03:03:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:03:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:03:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:03:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:03:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:03:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:03:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:03:40 INFO - 'talos_options': ['--disable-e10s'], 03:03:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:03:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:03:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:03:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:03:40 INFO - 'talos_options': ['--disable-e10s'], 03:03:40 INFO - 'tests': ['damp', 'tps']}, 03:03:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:03:40 INFO - 'tests': ['damp', 'tps']}, 03:03:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:03:40 INFO - 'tests': ['dromaeo_dom']}, 03:03:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:03:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:03:40 INFO - 'tests': ['basic_compositor_video']}, 03:03:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:03:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:03:40 INFO - 'tests': ['a11yr', 03:03:40 INFO - 'ts_paint', 03:03:40 INFO - 'tpaint', 03:03:40 INFO - 'sessionrestore', 03:03:40 INFO - 'sessionrestore_no_auto_restore', 03:03:40 INFO - 'tabpaint']}, 03:03:40 INFO - 'other-e10s': {'tests': ['a11yr', 03:03:40 INFO - 'ts_paint', 03:03:40 INFO - 'tpaint', 03:03:40 INFO - 'sessionrestore', 03:03:40 INFO - 'sessionrestore_no_auto_restore', 03:03:40 INFO - 'tabpaint']}, 03:03:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:03:40 INFO - 'ts_paint', 03:03:40 INFO - 'tpaint', 03:03:40 INFO - 'sessionrestore', 03:03:40 INFO - 'sessionrestore_no_auto_restore', 03:03:40 INFO - 'tabpaint']}, 03:03:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:03:40 INFO - 'ts_paint', 03:03:40 INFO - 'tpaint', 03:03:40 INFO - 'sessionrestore', 03:03:40 INFO - 'sessionrestore_no_auto_restore', 03:03:40 INFO - 'tabpaint']}, 03:03:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:03:40 INFO - 'tests': ['a11yr', 03:03:40 INFO - 'ts_paint', 03:03:40 INFO - 'tpaint', 03:03:40 INFO - 'sessionrestore', 03:03:40 INFO - 'sessionrestore_no_auto_restore', 03:03:40 INFO - 'tabpaint']}, 03:03:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:03:40 INFO - 'tests': ['a11yr', 03:03:40 INFO - 'ts_paint', 03:03:40 INFO - 'tpaint', 03:03:40 INFO - 'sessionrestore', 03:03:40 INFO - 'sessionrestore_no_auto_restore', 03:03:40 INFO - 'tabpaint']}, 03:03:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:03:40 INFO - 'tests': ['tsvgx', 03:03:40 INFO - 'tsvgr_opacity', 03:03:40 INFO - 'tart', 03:03:40 INFO - 'tscrollx', 03:03:40 INFO - 'cart']}, 03:03:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:03:40 INFO - 'tsvgr_opacity', 03:03:40 INFO - 'tart', 03:03:40 INFO - 'tscrollx', 03:03:40 INFO - 'cart']}, 03:03:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:03:40 INFO - 'talos_options': ['--disable-e10s'], 03:03:40 INFO - 'tests': ['tp5o']}, 03:03:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:03:40 INFO - 'tests': ['tp5o']}, 03:03:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:03:40 INFO - 'talos_options': ['--disable-e10s', 03:03:40 INFO - '--xperf_path', 03:03:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:03:40 INFO - 'tests': ['tp5n']}, 03:03:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:03:40 INFO - 'talos_options': ['--xperf_path', 03:03:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:03:40 INFO - 'tests': ['tp5n']}}, 03:03:40 INFO - 'talos.zip': {'path': '', 03:03:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:03:40 INFO - Running post-action listener: _resource_record_post_action 03:03:40 INFO - ##### 03:03:40 INFO - ##### Finished populate-webroot step (success) 03:03:40 INFO - ##### 03:03:40 INFO - ##### 03:03:40 INFO - ##### Running create-virtualenv step. 03:03:40 INFO - ##### 03:03:40 INFO - Running pre-action listener: _resource_record_pre_action 03:03:40 INFO - Running main action method: create_virtualenv 03:03:40 INFO - Creating virtualenv /builds/slave/test/build/venv 03:03:40 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 03:03:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:03:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:03:40 INFO - Using real prefix '/tools/python27' 03:03:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:03:41 INFO - Installing distribute.............................................................................................................................................................................................done. 03:03:44 INFO - Installing pip.................done. 03:03:44 INFO - Return code: 0 03:03:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:03:44 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')]} 03:03:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:44 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')]} 03:03:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:44 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 0x100b65a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bfa618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8e156c0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ac9d30>, '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 0x10082edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ac1b20>, '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.pOPZrHlnlN/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.K6829h2fJM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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 03:03:44 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 03:03:44 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 03:03:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pOPZrHlnlN/Render', 03:03:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:03:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:03:44 INFO - 'HOME': '/Users/cltbld', 03:03:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:03:44 INFO - 'LOGNAME': 'cltbld', 03:03:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:44 INFO - 'MOZ_NO_REMOTE': '1', 03:03:44 INFO - 'NO_EM_RESTART': '1', 03:03:44 INFO - 'PAGER': '/bin/cat', 03:03:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:03:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:44 INFO - 'PWD': '/builds/slave/test', 03:03:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:03:44 INFO - 'SHELL': '/bin/bash', 03:03:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K6829h2fJM/Listeners', 03:03:44 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 03:03:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:03:44 INFO - 'USER': 'cltbld', 03:03:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:03:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:03:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:44 INFO - 'XPC_FLAGS': '0x0', 03:03:44 INFO - 'XPC_SERVICE_NAME': '0', 03:03:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:03:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:44 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 03:03:44 INFO - Cleaning up... 03:03:44 INFO - Return code: 0 03:03:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:03:44 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')]} 03:03:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:44 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')]} 03:03:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:44 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 0x100b65a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bfa618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8e156c0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ac9d30>, '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 0x10082edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ac1b20>, '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.pOPZrHlnlN/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.K6829h2fJM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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 03:03:44 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 03:03:44 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 03:03:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pOPZrHlnlN/Render', 03:03:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:03:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:03:44 INFO - 'HOME': '/Users/cltbld', 03:03:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:03:44 INFO - 'LOGNAME': 'cltbld', 03:03:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:44 INFO - 'MOZ_NO_REMOTE': '1', 03:03:44 INFO - 'NO_EM_RESTART': '1', 03:03:44 INFO - 'PAGER': '/bin/cat', 03:03:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:03:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:44 INFO - 'PWD': '/builds/slave/test', 03:03:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:03:44 INFO - 'SHELL': '/bin/bash', 03:03:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K6829h2fJM/Listeners', 03:03:44 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 03:03:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:03:44 INFO - 'USER': 'cltbld', 03:03:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:03:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:03:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:44 INFO - 'XPC_FLAGS': '0x0', 03:03:44 INFO - 'XPC_SERVICE_NAME': '0', 03:03:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:03:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:45 INFO - Downloading/unpacking psutil>=3.1.1 03:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:03:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:03:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:03:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:03:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:03:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:03:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:03:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:03:48 INFO - Installing collected packages: psutil 03:03:48 INFO - Running setup.py install for psutil 03:03:48 INFO - building 'psutil._psutil_osx' extension 03:03:48 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 03:03:48 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 03:03:48 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 03:03:48 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 03:03:48 INFO - building 'psutil._psutil_posix' extension 03:03:48 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 03:03:49 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:03:49 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:03:49 INFO - ^ 03:03:49 INFO - 1 warning generated. 03:03:49 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 03:03:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:03:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:03:49 INFO - Successfully installed psutil 03:03:49 INFO - Cleaning up... 03:03:49 INFO - Return code: 0 03:03:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:03: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')]} 03:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03: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')]} 03:03:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100b65a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bfa618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8e156c0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ac9d30>, '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 0x10082edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ac1b20>, '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.pOPZrHlnlN/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.K6829h2fJM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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 03:03: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:03: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 mozsystemmonitor==0.3 03:03:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pOPZrHlnlN/Render', 03:03:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:03:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:03:49 INFO - 'HOME': '/Users/cltbld', 03:03:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:03:49 INFO - 'LOGNAME': 'cltbld', 03:03:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:49 INFO - 'MOZ_NO_REMOTE': '1', 03:03:49 INFO - 'NO_EM_RESTART': '1', 03:03:49 INFO - 'PAGER': '/bin/cat', 03:03:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:03:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:49 INFO - 'PWD': '/builds/slave/test', 03:03:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:03:49 INFO - 'SHELL': '/bin/bash', 03:03:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K6829h2fJM/Listeners', 03:03:49 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 03:03:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:03:49 INFO - 'USER': 'cltbld', 03:03:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:03:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:03:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:49 INFO - 'XPC_FLAGS': '0x0', 03:03:49 INFO - 'XPC_SERVICE_NAME': '0', 03:03:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:03:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:03: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 03:03: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 03:03: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 03:03: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 03:03: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 03:03: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 03:03:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:03:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:03:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:03:52 INFO - Installing collected packages: mozsystemmonitor 03:03:52 INFO - Running setup.py install for mozsystemmonitor 03:03:52 INFO - Successfully installed mozsystemmonitor 03:03:52 INFO - Cleaning up... 03:03:52 INFO - Return code: 0 03:03:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:03: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')]} 03:03:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03: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')]} 03:03:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:52 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100b65a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bfa618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8e156c0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ac9d30>, '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 0x10082edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ac1b20>, '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.pOPZrHlnlN/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.K6829h2fJM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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 03:03:52 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==2.5.1'] in /builds/slave/test/build 03:03:52 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==2.5.1 03:03:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pOPZrHlnlN/Render', 03:03:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:03:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:03:52 INFO - 'HOME': '/Users/cltbld', 03:03:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:03:52 INFO - 'LOGNAME': 'cltbld', 03:03:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:52 INFO - 'MOZ_NO_REMOTE': '1', 03:03:52 INFO - 'NO_EM_RESTART': '1', 03:03:52 INFO - 'PAGER': '/bin/cat', 03:03:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:03:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:52 INFO - 'PWD': '/builds/slave/test', 03:03:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:03:52 INFO - 'SHELL': '/bin/bash', 03:03:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K6829h2fJM/Listeners', 03:03:52 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 03:03:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:03:52 INFO - 'USER': 'cltbld', 03:03:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:03:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:03:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:52 INFO - 'XPC_FLAGS': '0x0', 03:03:52 INFO - 'XPC_SERVICE_NAME': '0', 03:03:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:03:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:52 INFO - Downloading/unpacking jsonschema==2.5.1 03:03: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 03:03: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 03:03: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 03:03: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 03:03: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 03:03: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 03:03:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:03:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:03:55 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 03:03:55 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 03:03:55 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 03:03:55 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 03:03:55 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 03:03:55 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 03:03:55 INFO - Downloading functools32-3.2.3-2.tar.gz 03:03:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:03:55 INFO - warning: no files found matching '*.txt' 03:03:55 INFO - no previously-included directories found matching 'build' 03:03:55 INFO - no previously-included directories found matching 'dist' 03:03:55 INFO - no previously-included directories found matching '.git*' 03:03:55 INFO - Installing collected packages: jsonschema, functools32 03:03:55 INFO - Running setup.py install for functools32 03:03:55 INFO - warning: no files found matching '*.txt' 03:03:55 INFO - no previously-included directories found matching 'build' 03:03:55 INFO - no previously-included directories found matching 'dist' 03:03:55 INFO - no previously-included directories found matching '.git*' 03:03:55 INFO - Successfully installed jsonschema functools32 03:03:55 INFO - Cleaning up... 03:03:55 INFO - Return code: 0 03:03:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:03:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:03:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:55 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 0x100b65a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bfa618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8e156c0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ac9d30>, '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 0x10082edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ac1b20>, '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.pOPZrHlnlN/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.K6829h2fJM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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 03:03:55 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 03:03:55 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 03:03:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pOPZrHlnlN/Render', 03:03:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:03:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:03:55 INFO - 'HOME': '/Users/cltbld', 03:03:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:03:55 INFO - 'LOGNAME': 'cltbld', 03:03:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:55 INFO - 'MOZ_NO_REMOTE': '1', 03:03:55 INFO - 'NO_EM_RESTART': '1', 03:03:55 INFO - 'PAGER': '/bin/cat', 03:03:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:03:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:55 INFO - 'PWD': '/builds/slave/test', 03:03:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:03:55 INFO - 'SHELL': '/bin/bash', 03:03:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K6829h2fJM/Listeners', 03:03:55 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 03:03:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:03:55 INFO - 'USER': 'cltbld', 03:03:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:03:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:03:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:55 INFO - 'XPC_FLAGS': '0x0', 03:03:55 INFO - 'XPC_SERVICE_NAME': '0', 03:03:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:03:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:56 INFO - Downloading/unpacking blobuploader==1.2.4 03:03:56 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 03:03:56 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 03:03:56 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 03:03:56 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 03:03:56 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 03:03:56 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 03:03:58 INFO - Downloading blobuploader-1.2.4.tar.gz 03:03:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:03:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:03:58 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 03:03:58 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 03:03:58 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 03:03:58 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 03:03:58 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 03:03:58 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 03:03:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:03:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:03:59 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 03:03:59 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 03:03:59 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 03:03:59 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 03:03:59 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 03:03:59 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 03:03:59 INFO - Downloading docopt-0.6.1.tar.gz 03:03:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:03:59 INFO - Installing collected packages: blobuploader, requests, docopt 03:03:59 INFO - Running setup.py install for blobuploader 03:03:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:03:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:03:59 INFO - Running setup.py install for requests 03:04:00 INFO - Running setup.py install for docopt 03:04:00 INFO - Successfully installed blobuploader requests docopt 03:04:00 INFO - Cleaning up... 03:04:00 INFO - Return code: 0 03:04:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:04:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:04:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:04:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:00 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 0x100b65a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bfa618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8e156c0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ac9d30>, '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 0x10082edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ac1b20>, '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.pOPZrHlnlN/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.K6829h2fJM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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 03:04:00 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 03:04:00 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 03:04:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pOPZrHlnlN/Render', 03:04:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:04:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:04:00 INFO - 'HOME': '/Users/cltbld', 03:04:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:04:00 INFO - 'LOGNAME': 'cltbld', 03:04:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:00 INFO - 'MOZ_NO_REMOTE': '1', 03:04:00 INFO - 'NO_EM_RESTART': '1', 03:04:00 INFO - 'PAGER': '/bin/cat', 03:04:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:04:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:00 INFO - 'PWD': '/builds/slave/test', 03:04:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:04:00 INFO - 'SHELL': '/bin/bash', 03:04:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K6829h2fJM/Listeners', 03:04:00 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 03:04:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:04:00 INFO - 'USER': 'cltbld', 03:04:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:04:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:04:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:00 INFO - 'XPC_FLAGS': '0x0', 03:04:00 INFO - 'XPC_SERVICE_NAME': '0', 03:04:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:04:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:04:00 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-gCkN_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:04:01 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-QyiGCf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:04:01 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-VsEwrj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:04:01 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-o7WWuM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:04:01 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-gcv8rd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:04:01 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-WfkaQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:04:01 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-7RiMS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:04:01 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-dWm7DM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:04:01 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-hkrTzN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:04:01 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-7cGcDR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:04:02 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-FmgQYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:04:02 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-BXHTyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:04:02 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-XiMslc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:04:02 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-vbUrEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:04:02 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-Vi4i9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:04:02 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-0IakUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:04:02 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-S1QJmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:04:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:04:02 INFO - Running setup.py install for manifestparser 03:04:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:04:02 INFO - Running setup.py install for mozcrash 03:04:03 INFO - Running setup.py install for mozdebug 03:04:03 INFO - Running setup.py install for mozdevice 03:04:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:04:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:04:03 INFO - Running setup.py install for mozfile 03:04:03 INFO - Running setup.py install for mozhttpd 03:04:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:04:03 INFO - Running setup.py install for mozinfo 03:04:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:04:03 INFO - Running setup.py install for mozInstall 03:04:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:04:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:04:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:04:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:04:03 INFO - Running setup.py install for mozleak 03:04:04 INFO - Running setup.py install for mozlog 03:04:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:04:04 INFO - Running setup.py install for moznetwork 03:04:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:04:04 INFO - Running setup.py install for mozprocess 03:04:04 INFO - Running setup.py install for mozprofile 03:04:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:04:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:04:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:04:04 INFO - Running setup.py install for mozrunner 03:04:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:04:04 INFO - Running setup.py install for mozscreenshot 03:04:05 INFO - Running setup.py install for moztest 03:04:05 INFO - Running setup.py install for mozversion 03:04:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:04:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:04:05 INFO - Cleaning up... 03:04:05 INFO - Return code: 0 03:04:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:04:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:04:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:04:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:05 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 0x100b65a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bfa618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8e156c0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ac9d30>, '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 0x10082edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ac1b20>, '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.pOPZrHlnlN/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.K6829h2fJM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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 03:04:05 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 03:04:05 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 03:04:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pOPZrHlnlN/Render', 03:04:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:04:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:04:05 INFO - 'HOME': '/Users/cltbld', 03:04:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:04:05 INFO - 'LOGNAME': 'cltbld', 03:04:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:05 INFO - 'MOZ_NO_REMOTE': '1', 03:04:05 INFO - 'NO_EM_RESTART': '1', 03:04:05 INFO - 'PAGER': '/bin/cat', 03:04:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:04:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:05 INFO - 'PWD': '/builds/slave/test', 03:04:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:04:05 INFO - 'SHELL': '/bin/bash', 03:04:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K6829h2fJM/Listeners', 03:04:05 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 03:04:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:04:05 INFO - 'USER': 'cltbld', 03:04:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:04:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:04:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:05 INFO - 'XPC_FLAGS': '0x0', 03:04:05 INFO - 'XPC_SERVICE_NAME': '0', 03:04:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:04:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:04:05 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-7M5ZYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:04:05 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)) 03:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:04:05 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-EmEL7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:04:05 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)) 03:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:04:05 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-zSJ7kc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:04:05 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)) 03:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:04:05 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-JU5QGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:04:06 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)) 03:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:04:06 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-Z2SHBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:04:06 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)) 03:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:04:06 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-k_tNRM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:04:06 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)) 03:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:04:06 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-KKbJc_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:04:06 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)) 03:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:04:06 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-Cubmk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:04:06 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)) 03:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:04:06 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-r3vC8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:04:06 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)) 03:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:04:06 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-m9seBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:04:06 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)) 03:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:04:06 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-HsItgN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:04:06 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)) 03:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:04:06 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-hOwmp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:04:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 03:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:04:06 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-SvQxho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:04:06 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)) 03:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:04:06 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-4d5gpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:04:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 03:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:04:07 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-qSg59v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:04:07 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)) 03:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:04:07 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-tUqyJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:04:07 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)) 03:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:04:07 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-FACDh2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:04:07 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)) 03:04:07 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)) 03:04:07 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)) 03:04:07 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)) 03:04:07 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)) 03:04:07 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)) 03:04:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:04: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 03:04: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 03:04: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 03:04: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 03:04: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 03:04: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 03:04:09 INFO - Downloading blessings-1.6.tar.gz 03:04:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:04:09 INFO - Installing collected packages: blessings 03:04:09 INFO - Running setup.py install for blessings 03:04:10 INFO - Successfully installed blessings 03:04:10 INFO - Cleaning up... 03:04:10 INFO - Return code: 0 03:04:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:04:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:04:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:04:10 INFO - Reading from file tmpfile_stdout 03:04:10 INFO - Current package versions: 03:04:10 INFO - blessings == 1.6 03:04:10 INFO - blobuploader == 1.2.4 03:04:10 INFO - docopt == 0.6.1 03:04:10 INFO - functools32 == 3.2.3-2 03:04:10 INFO - jsonschema == 2.5.1 03:04:10 INFO - manifestparser == 1.1 03:04:10 INFO - mozInstall == 1.12 03:04:10 INFO - mozcrash == 0.17 03:04:10 INFO - mozdebug == 0.1 03:04:10 INFO - mozdevice == 0.48 03:04:10 INFO - mozfile == 1.2 03:04:10 INFO - mozhttpd == 0.7 03:04:10 INFO - mozinfo == 0.9 03:04:10 INFO - mozleak == 0.1 03:04:10 INFO - mozlog == 3.2 03:04:10 INFO - moznetwork == 0.27 03:04:10 INFO - mozprocess == 0.23 03:04:10 INFO - mozprofile == 0.28 03:04:10 INFO - mozrunner == 6.12 03:04:10 INFO - mozscreenshot == 0.1 03:04:10 INFO - mozsystemmonitor == 0.3 03:04:10 INFO - moztest == 0.7 03:04:10 INFO - mozversion == 1.4 03:04:10 INFO - psutil == 3.1.1 03:04:10 INFO - requests == 1.2.3 03:04:10 INFO - wsgiref == 0.1.2 03:04:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:04:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:04:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:04:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:10 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 0x100b65a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bfa618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8e156c0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ac9d30>, '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 0x10082edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ac1b20>, '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.pOPZrHlnlN/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.K6829h2fJM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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 03:04:10 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 03:04:10 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 03:04:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pOPZrHlnlN/Render', 03:04:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:04:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:04:10 INFO - 'HOME': '/Users/cltbld', 03:04:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:04:10 INFO - 'LOGNAME': 'cltbld', 03:04:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:10 INFO - 'MOZ_NO_REMOTE': '1', 03:04:10 INFO - 'NO_EM_RESTART': '1', 03:04:10 INFO - 'PAGER': '/bin/cat', 03:04:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:04:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:10 INFO - 'PWD': '/builds/slave/test', 03:04:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:04:10 INFO - 'SHELL': '/bin/bash', 03:04:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K6829h2fJM/Listeners', 03:04:10 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 03:04:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:04:10 INFO - 'USER': 'cltbld', 03:04:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:04:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:04:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:10 INFO - 'XPC_FLAGS': '0x0', 03:04:10 INFO - 'XPC_SERVICE_NAME': '0', 03:04:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:04:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:10 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)) 03:04:10 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)) 03:04:10 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)) 03:04:10 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)) 03:04:10 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)) 03:04:10 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)) 03:04:10 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)) 03:04:10 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)) 03:04:10 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)) 03:04:10 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)) 03:04:10 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)) 03:04:10 INFO - Cleaning up... 03:04:10 INFO - Return code: 0 03:04:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:04:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:04:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:04:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100b65a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bfa618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8e156c0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ac9d30>, '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 0x10082edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ac1b20>, '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.pOPZrHlnlN/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.K6829h2fJM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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 03:04:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:04:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:04:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pOPZrHlnlN/Render', 03:04:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:04:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:04:10 INFO - 'HOME': '/Users/cltbld', 03:04:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:04:10 INFO - 'LOGNAME': 'cltbld', 03:04:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:10 INFO - 'MOZ_NO_REMOTE': '1', 03:04:10 INFO - 'NO_EM_RESTART': '1', 03:04:10 INFO - 'PAGER': '/bin/cat', 03:04:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:04:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:10 INFO - 'PWD': '/builds/slave/test', 03:04:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:04:10 INFO - 'SHELL': '/bin/bash', 03:04:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K6829h2fJM/Listeners', 03:04:10 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 03:04:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:04:10 INFO - 'USER': 'cltbld', 03:04:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:04:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:04:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:10 INFO - 'XPC_FLAGS': '0x0', 03:04:10 INFO - 'XPC_SERVICE_NAME': '0', 03:04:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:04:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:04:11 INFO - Cleaning up... 03:04:11 INFO - Return code: 0 03:04:11 INFO - Running post-action listener: _resource_record_post_action 03:04:11 INFO - Running post-action listener: _start_resource_monitoring 03:04:11 INFO - Starting resource monitoring. 03:04:11 INFO - ##### 03:04:11 INFO - ##### Finished create-virtualenv step (success) 03:04:11 INFO - ##### 03:04:11 INFO - ##### 03:04:11 INFO - ##### Running install step. 03:04:11 INFO - ##### 03:04:11 INFO - Running pre-action listener: _resource_record_pre_action 03:04:11 INFO - Running main action method: install 03:04:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:04:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:04:11 INFO - Reading from file tmpfile_stdout 03:04:11 INFO - Detecting whether we're running mozinstall >=1.0... 03:04:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:04:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:04:11 INFO - Reading from file tmpfile_stdout 03:04:11 INFO - Output received: 03:04:11 INFO - Usage: mozinstall [options] installer 03:04:11 INFO - Options: 03:04:11 INFO - -h, --help show this help message and exit 03:04:11 INFO - -d DEST, --destination=DEST 03:04:11 INFO - Directory to install application into. [default: 03:04:11 INFO - "/builds/slave/test"] 03:04:11 INFO - --app=APP Application being installed. [default: firefox] 03:04:11 INFO - mkdir: /builds/slave/test/build/application 03:04:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:04:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 03:04:46 INFO - Reading from file tmpfile_stdout 03:04:46 INFO - Output received: 03:04:46 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:04:46 INFO - Running post-action listener: _resource_record_post_action 03:04:46 INFO - ##### 03:04:46 INFO - ##### Finished install step (success) 03:04:46 INFO - ##### 03:04:46 INFO - ##### 03:04:46 INFO - ##### Running run-tests step. 03:04:46 INFO - ##### 03:04:46 INFO - Running pre-action listener: _resource_record_pre_action 03:04:46 INFO - Running main action method: run_tests 03:04:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:04:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:04:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:04:46 INFO - 2016-07-13 03:04:46.240 screenresolution[1632:7536] starting screenresolution argv=screenresolution get 03:04:46 INFO - 2016-07-13 03:04:46.242 screenresolution[1632:7536] Display 0: 1600x1200x32@60 03:04:46 INFO - 2016-07-13 03:04:46.248 screenresolution[1633:7538] starting screenresolution argv=screenresolution list 03:04:46 INFO - Available Modes on Display 0 03:04:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:04:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:04:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:04:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:04:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:04:46 INFO - Intel Iris: 03:04:46 INFO - Chipset Model: Intel Iris 03:04:46 INFO - Type: GPU 03:04:46 INFO - Bus: Built-In 03:04:46 INFO - VRAM (Dynamic, Max): 1536 MB 03:04:46 INFO - Vendor: Intel (0x8086) 03:04:46 INFO - Device ID: 0x0a2e 03:04:46 INFO - Revision ID: 0x0009 03:04:46 INFO - Displays: 03:04:46 INFO - Display: 03:04:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:04:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:04:46 INFO - Display Serial Number: 1600x1200 60 03:04:46 INFO - Main Display: Yes 03:04:46 INFO - Mirror: Off 03:04:46 INFO - Online: Yes 03:04:46 INFO - Rotation: Supported 03:04:46 INFO - Return code: 0 03:04:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:04:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:04:46 INFO - Python 2.7.3 03:04:46 INFO - Return code: 0 03:04:46 INFO - grabbing minidump binary from tooltool 03:04: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')]} 03:04:46 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 0x100ac9d30>, '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 0x10082edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ac1b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:04:46 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 03:04:46 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 03:04:46 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 03:04:46 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:04:46 INFO - Return code: 0 03:04:46 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:04:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:04:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:04:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:04:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:04:46 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/eVSHIxfpSFaORQLGScN6yg/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0209', '--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 03:04:46 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/eVSHIxfpSFaORQLGScN6yg/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0209 --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 03:04:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pOPZrHlnlN/Render', 03:04:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:04:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:04:46 INFO - 'HOME': '/Users/cltbld', 03:04:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:04:46 INFO - 'LOGNAME': 'cltbld', 03:04:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:04:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:04:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:46 INFO - 'MOZ_NO_REMOTE': '1', 03:04:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:04:46 INFO - 'NO_EM_RESTART': '1', 03:04:46 INFO - 'PAGER': '/bin/cat', 03:04:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:04:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:46 INFO - 'PWD': '/builds/slave/test', 03:04:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:04:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:04:46 INFO - 'SHELL': '/bin/bash', 03:04:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K6829h2fJM/Listeners', 03:04:46 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 03:04:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:04:46 INFO - 'USER': 'cltbld', 03:04:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:04:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:04:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:46 INFO - 'XPC_FLAGS': '0x0', 03:04:46 INFO - 'XPC_SERVICE_NAME': '0', 03:04:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:04:46 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/eVSHIxfpSFaORQLGScN6yg/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0209', '--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 03:04:46 INFO - mozversion application_buildid: 20160713010309 03:04:46 INFO - mozversion application_changeset: 7054f1c4d2b11ed3511731565a264e4521cba9b4 03:04:46 INFO - mozversion application_display_name: Nightly 03:04:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:04:46 INFO - mozversion application_name: Firefox 03:04:46 INFO - mozversion application_remotingname: firefox 03:04:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:04:46 INFO - mozversion application_vendor: Mozilla 03:04:46 INFO - mozversion application_version: 50.0a1 03:04:46 INFO - mozversion platform_buildid: 20160713010309 03:04:46 INFO - mozversion platform_changeset: 7054f1c4d2b11ed3511731565a264e4521cba9b4 03:04:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:04:46 INFO - mozversion platform_version: 50.0a1 03:04:46 INFO - using testdate: 1468404286 03:04:46 INFO - actual date: 1468404286 03:04:46 INFO - starting webserver on 'localhost:49270' 03:04:46 INFO - SUITE-START | Running 2 tests 03:04:46 INFO - TEST-START | dromaeo_css 03:04:46 INFO - operating with platform_type : mac_ 03:04:46 INFO - Initialising browser for dromaeo_css test... 03:04:46 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/tmpXIrk3f/profile http://localhost:49270/getInfo.html) 03:04:49 INFO - PROCESS | 1643 | __metrics Screen width/height:1600/1200 03:04:49 INFO - PROCESS | 1643 | colorDepth:24 03:04:49 INFO - PROCESS | 1643 | Browser inner width/height: 1024/689 03:04:49 INFO - PROCESS | 1643 | __metrics 03:04:49 INFO - PROCESS | 1643 | 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" 03:04:49 INFO - PROCESS | 1643 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:04:50 INFO - TEST-INFO | 1643: exit 0 03:04:50 INFO - Browser initialized. 03:04:50 INFO - Running cycle 1/1 for dromaeo_css test... 03:04:50 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/tmpXIrk3f/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:05:01 INFO - PROCESS | 1645 | RSS: Main: 243568640 03:05:01 INFO - PROCESS | 1645 | 03:05:53 INFO - PROCESS | 1645 | 1468404353482 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] 03:08:04 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 03:08:06 INFO - PROCESS | 1645 | RSS: Main: 334213120 03:08:06 INFO - PROCESS | 1645 | 03:11:09 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 03:11:09 INFO - PROCESS | 1645 | RSS: Main: 379858944 03:11:09 INFO - PROCESS | 1645 | 03:14:11 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 03:14:12 INFO - PROCESS | 1645 | RSS: Main: 371118080 03:14:12 INFO - PROCESS | 1645 | 03:17:14 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 03:17:15 INFO - PROCESS | 1645 | RSS: Main: 369000448 03:17:15 INFO - PROCESS | 1645 | 03:20:18 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 03:20:19 INFO - PROCESS | 1645 | RSS: Main: 337207296 03:20:19 INFO - PROCESS | 1645 | 03:23:22 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 03:23:22 INFO - PROCESS | 1645 | RSS: Main: 430870528 03:23:22 INFO - PROCESS | 1645 | 03:23:22 INFO - PROCESS | 1645 | __start_tp_report 03:23:22 INFO - PROCESS | 1645 | _x_x_mozilla_page_load 03:23:22 INFO - PROCESS | 1645 | _x_x_mozilla_page_load_details 03:23:22 INFO - PROCESS | 1645 | |i|pagename|runs| 03:23:22 INFO - PROCESS | 1645 | |0;dojo.html;3340.89977300681;3355.8657653693854;3362.4283871741786;3383.340248651514;3435.728780351269;5519.31008623922;5578.916316255254;5589.496945274925;5679.687617181054;5682.801101961432;4398;4632.49042605314;5565.860853478655;5673.886522269552;5691.08942569189;5022.0709168803705;5043.117454445476;5082.08522465956;5092.719900405476;5179.2749015137915;4610.5850473457385;5209.531142197202;5223.242629818674;5234.136367499358;5263.947360526403;5062.038212739604;5081.085404627165;5094.541491265767;5120.92318615221;5155.742212889378;5050.823221187241;5133.486651334874;5139.974300128512;5143.665661731976;5150.484951504857;5007.774650140753;5025.849224523234;5083.262926875583;5097.923531147036;5166.147585648364;5585.106382978704;5642.181883626892;5646.57650676201;5668.943310566883;5673.063944449161;5963.373845746178;6028.879422411571;6096.359882212392;6115.877682446326;6121.348314606742;6125.2381759958735;6139.84650383744;6202.069689546559;6245.6252624842655;6262.342454042351;5719.742611582489;5750.05124154514;5772.365039845614;5777.162311464856;5778.5377169826315;6001.639901605918;6207.441330280297;6319.494440444753;6340.239171299474;6347.174867267226;6046.788362407295;6089.186564748667;6091.872015805945;6093.080679586005;6099.649921844167;6165.815025549241;6194.225721784777;6201.7519299228425;6209.285932117774;6210.968945155245;5984.491318237911;6030.065339872327;6074.301455332693;6125.96937015321;6137.478314343331;6106.206193194945;6145.508359331332;6151.138840562325;6191.84520386994;6193.009118541012;4859.416869975626;4866.7079975201605;4876;4900.387451568554;4908.730019848871;4349.760763158057;4358.997430590982;4381.079973205598;4382.53983331752;4409.669274804402;5685.147227915846;5696.829095127153;5706.144078388275;5716.714164291769;5721.056025755704;6207.968960155261;6250.781222657185;6265.467435267962;6267.091271765659;6291.087792270187;5685.459881311269;5703.771849125988;5752.7698892043845;5782.132680098019;5786.479216870502;5259.973700131552;5324.707141107277;5338.599605029561;5358.3837858645975;5374.623776335619;6229.53278504114;6304.211973503312;6308.716107775253;6313.55805093639;6315.715792789428;6194.287656919512;6205.5345849060595;6206.410391012847;6213.502919766317;6218.782342617987;6135.998322733915;6156.876862462636;6186.907196391968;6219.440250377488;6317.652529110943;6097.355064906588;6127.220070483952;6127.403330890726;6143.634700640197;6152.907706384497;5641.774329026957;5680.062789639664;6179.5056395489155;6198.535109866868;6206.06908963659;5864.501517371071;5981.162637230704;5999.100134979788;6027.156198132353;6041.24484439445;6037.849053773515;6045.093236014633;6054.3340232575265;6059.303180134165;6063.090536419572;4672.878509157709;5838.766449341979;5844.620099693507;5869.647821130746;5918.852028699317;5833.212516310244;5946.910796338145;6022.518198544193;6056.878862422815;6075.878482430238;5787.247657804459;5814.651120932757;5841.1238314253205;5859.20900678403;5869.031609784338 03:23:22 INFO - PROCESS | 1645 | |1;ext.html;493.4744497110578;497.72625056219084;501.61876973500154;505.7900971096995;507.6497216920325;30202.395952080944;40994.38508422372;42222;42229;44105.67682969516;43408.782956085175;43672.90817729558;43818.342724859074;43875.12249755003;43902.12195756083;8647.135286471366;9603.519824008807;9794.461304628243;9800.460974646392;9814.705558833246;8610.311175106008;11666.824997625043;11756.941875231227;11772.587959421422;12067.215630984001;11781.587644432446;11830.526778928832;11837.230580012314;11840.881591184107;11868.584599539017;8735.344849136276;11676.299422034705;11739;11770.941145294304;11926.986206172529;11808.468618912084;11877.16859819813;11888.405579720978;11891.989180919632;11895.762084758257;40424.79787601073;40856.591434085574;40864;40900.79549602233;40957.385639215136;3517.191046059395;3563.5367402237803;3672.779633222015;3751.2497500499735;3832.137769001952;25424.74575254242;32081.197970050704;32646.673533264602;33151.3369732604;33172.834135829406;3272.9509057364157;3288.901332960015;3312.337532493487;3325.384803811303;3420.6921377076183;515882;518935;519168;519716;519748;34629.82685086609;64312.35687643064;64815.35184648188;64972.05083847397;64990.70018599696;34881.47677784835;36085.63914360823;36148.45777313342;36149.27701445956;36207.094822629115;15206.391744330323;15216.239188040554;15390.153541555099;15395.923020384826;15406.460773873085;11570.132240081859;11814.173007889365;12696.809547856605;12826;12933.353332333345;7807.453478256468;7844.058712954368;7882.960585197037;7890.684372625145;7950.204979502004;3317.087800854736;3327.966720332766;3333.116724068124;3341.498775183742;3359.4792807114936;972.5817898303656;984.9015098490094;1016.5222345497752;1074.9731256718644;1119.776044791045;30977.380452390826;30979.845100774353;31080.844595776878;31645;31915.521267180546;1072.651388298806;1094.7208461842179;1097.1497089755503;1139.720768411728;1211.987880121205;16236.944598601052;16268.511944641443;16434.096124713255;16573.8398312117;16591.25339359732;608601;705817;713593;714257;716362;60508;61189.77620447566;61226.38773612296;61250.69374653098;61253;1071.6838532632892;1312.4422120598708;1377.393946663465;1405.3184205660248;1431.978520322196;28794.85602571974;30138.3972320548;30466.47667616566;32701.836490817393;32711;49767.50232497629;50017.99964000627;50612.73468163325;50643;50798;531757;536457;537777;540735;542180;23705.52588948246;24017.799110044776;26289.34276643023;27411.177664670093;27914.16257512278;48609.756951216434;49255.261171081744;49622.50377496179;49740;50286.245706313704;39066.80466597649;41147.765567033035;41451.7927410361;41721.79139104285;41850.37224441575;36003;39794.80102599585;40768.3884741735;40806.79596601998;41589;38122.856314310615;38879.41680874846;39290;39680.2063958725;39699.60300396959;34267.65732342745;35110.47334290039;35188.64811351854;35925.46111808273;35959.64040359563;26208;26230.4753904917;26256;26596.572243996223;27022.189334320003 03:23:22 INFO - PROCESS | 1645 | |2;jquery.html;351.1852502194909;372.91609387887723;381.96944244460445;384.4771111288647;403.1232070247212;16062.59843503913;16295;19114.808851911475;21504.89247553764;22224.222152224676;21971.780282197175;22521.98651060702;22854.08583656656;23014.769852301513;23054.538909221807;5996.130561068642;6002.519798416138;6227.470664993459;6228.252609686821;6232.781852635158;4230.97884510577;4459.509453960061;6162.044883043135;6177.598456100362;6629.171353580802;6866.519343645947;6928.307169283082;6940.993555934387;6941.167059952812;6963.338482844122;6639.302873198317;6896.965515172442;6941.895871561931;6942.548734332252;6955.1653801544135;5806;6008.098785182214;6032.095185722133;6038.728257228435;6055.757769689207;27651.58522622162;27735.722642773515;27737.306567335778;28030.299242518897;28137.85931070352;2271.193726227182;2371.762823717632;2393.664886915833;2539.746025397464;2766.363736340633;15212.011219270822;16706.081165535892;16917.3233070677;17347.392841250497;17383.30466781327;1896.0898768591017;1946.4647222013919;1957.2073310309206;1983.345495986321;2088.5300807318386;119346.44087967617;121231.99999999911;125939;126704;127151.36424317912;10941.56233750657;11000.944995274973;11467.31196128235;11475.655730328104;11614.709632259091;14158.292085395895;14281.071730337495;14428;14433.762766771168;14442.566722998326;8798.34012449056;8949.507777072324;9006.684766033157;9047.592858321392;9081;9050.773730656787;9074.410163339362;9074.954625226832;9076.48775927315;9193.37988673225;6990.475714321345;6990.4757143214465;6995.650217489105;7000.404965577881;7000.859982800417;1845.8403667708812;1891.2056936086876;1894.4032629721594;1895.781985071707;1938.9224431022883;884.478157886837;889.2219308105408;955.8422860228123;1002.5087707023652;1041.7760181561;21836.781632183476;22933.426664333525;23448.765512345;23833.642495362583;23843.642345364835;980.2109302011806;1013.8884722680499;1028.881678606955;1036.362636978268;1052.936823790575;12175;12370.257784532956;12587.622371328875;12666.873331266754;12732.363381830872;578031;586430.067849658;595734;598676;598682;116635.41682291534;128479.35760321326;128780;129031.35484322518;129823;1024.1499555369176;1038.050184081572;1047.423916845747;1071.3357718214756;1074.3661239868516;20625.48436289105;20716.124034881806;20752;20968.47578810542;20970.790292097496;36206.818965905004;53776.84892604252;53929.46070539401;55196.62008449821;55597.054103106195;80539.19460805316;80778.59610701908;80809;82246.4613566743;83018;8004.557470603871;8390.748277551684;8460.323174146177;8474.406791524782;8688.30493560501;14030.158190508602;14053.789193161907;14209.50266740659;14237.64405889861;14299.57101286963;6111.847203819762;9509.857352139585;11153.609623663457;12119.939400302943;12125.75748485043;11582.015528680156;11675;11808.409579521162;11984.10119241043;12053.035757139583;11338.489767960627;11404.201705880509;11665.183437159318;11886.702832429259;12159.878401216229;8410.411271211202;8421.95789021051;8463.069062403007;8609.569521523774;8630.180132887366;11822.645320640395;11823;11982.460789264329;11995.160338776202;12011 03:23:22 INFO - PROCESS | 1645 | |3;mootools.html;1384.7161331926957;1553.658195197057;1581.699477099351;1680.2522877319582;1788.955276118097;7697.923020769791;8430.283425908798;8679.69621063263;8685.86971195431;8773.078826723198;8434.03008654005;8546.316294696426;8617.698380556682;8625.698100566482;8631;2328.161861729776;2352.0591763294647;2360.6104992676273;2362.1024010875844;2362.492064206195;2330.312557795446;2345;2370.158593699229;2370.1941339944415;2372.596658568039;2321.2223904991847;2350.2949115265437;2353.8587684738973;2358.1510656163855;2359.4337359033793;2301.7237931448335;2325.093213646679;2332.055517515409;2334.7781960713705;2342.0748804222235;1946.63987162374;2329.394357467054;2330.7552706965694;2336.0889253191267;2336.205690065386;8473.02560205578;8663;8668.826623467558;8743.56282185888;8753.255973242281;4467.441569803775;5076.314697515825;5240.606954478391;5248.895022099575;5252.4222335543445;3402.1834759657504;3506.8947931562093;3551.3430015447225;3567.4292113261754;3569.928601427983;1071.7588542577935;1093.4095588382263;1096.6052221200441;1117.212365282474;1119.4290911635044;11257.54969801207;11361.943190284079;11368.147388945863;11368.545258189662;11384.260023098472;3580.874669386559;4337.262665346899;4553.7267763933605;4557.202489564379;4562.201614717411;9008.909910900808;9017.594208260643;9031.45811251327;9043.864342034874;9054.86417703735;4586.656000799953;5028.5977121830165;5202.73986300691;5210.713410762369;5211.478852114834;4393.231184542692;4526.79629416677;4705.1765940960195;4866.46468888422;4894.021195760862;3155.8106513608795;3197.1847178969215;3748.2503499299705;3834.9424758628643;3874.2251549690177;1121.9551217951355;1157.988420115805;1160.477784996738;1160.651804458659;1173.20808454293;580.9912851307233;656.7208936202095;814.2386868278061;856.9785755356041;978.574320170728;5818.738156782955;5882.794102206402;6096.69516524172;6106.877862442726;6121.296050954108;960.3853533738413;967.9951600242094;970.2335155227291;976.9804603907882;998.8401855703198;3576.8911637392494;4048.149888523443;4121.402396652468;4184.456020717287;4188.643965262926;9888;10671.413072281099;10673.412962286993;10687.73280667974;10726.249162558546;10484.947575262227;10610.57557697699;10682.145428365711;10692.679219623424;10695.518701658444;8189.303909167668;8306.54314012735;8310.70912518059;8325.791855203548;8328.8334233315;5287.259783630372;5746.741396637078;5990.221271234712;6046.818595442144;6051.243594550681;9695.321327507007;9852.162566181954;9992.850107248543;10042.297039207186;10122.038406351385;9951.054649808257;10180.949095254773;10196.133328667147;10277.640282590373;10292.794144117226;7036.788896333118;7113.715451381887;7184.6048467334795;7193.640317983975;7196.928030719626;8108.837823243384;8337.124601916712;8347.207015333533;8355.749327520183;8374.162583741578;7462.134466383404;7517.511361761468;7521.360684341892;7526.887096693445;7645.044369453818;7277.199508054004;7312.5246858954;7377.77866664001;7403.222661620668;7442.404607631484;6836.794896152925;6931.237563868071;7000.50996430245;7004.3696067354185;7030.824229394306;4817.5182481752945;5025.572826309804;5067.721275329893;5102.2346648003095;5207.375114986075;5003.899922001612;5044.873878153076;5076.619253555924;5182.689038657692;5211.062008838446 03:23:22 INFO - PROCESS | 1645 | |4;prototype.html;302.35598175885366;309.3488207323584;311.5451440896292;315.29531497103983;317.85696436603536;4989.7754601043;5430;5439.292891924049;5439.972800136004;5457.699826509545;4527.501974782779;4721.285260974944;5049.772760225789;5239.380309845077;5386.78452861885;3518.8768393106247;3619.954725580052;3967.1867267210155;4093.3859921011936;4196.58034196581;4088.4889388826396;4129.421880936671;4133.8966525836795;4166.7708276044805;4176.206520761061;4093.6725061995116;4101.487314085739;4101.569335219804;4126.8968275793195;4137.834486620532;3375.375555522236;3789.886303410902;3909.4135879618;4114.876553703393;4126.834926602933;3576.7853928764357;3587.121155316938;3590.407582748843;3593.3711600469815;3596.604373518911;5229.450907654679;5241.842744717665;5250.684958902478;5264.710440925747;5296.179092240709;4504.414426124616;4699.342092107107;4715.575598196178;4720.905581888377;4730.337752714623;5214.009338225725;5371.301730774974;5387.78448862045;5606.831795046155;5634.619518218063;3586.8923932282073;3982.780947047911;3992.680585553149;4009.799510024516;4013.876114687892;5237.345331833482;5610.326760788732;5905.114232865061;5921.447131720933;5932.050871860525;3711.2763011213096;3766.248694357137;4009.0779120801794;4050.41269015991;4074.409210664437;4106.829553577276;4126.896827579335;4130.318497447947;4135.7518548887165;4148.585141485827;3364.2430453148336;4547.794834368895;4718.9292160617615;4723.149833030087;4726.361941137971;5184.455632158644;5491.75287112073;5667.688277144714;5681.204631351614;5700.458456446631;1142.5372724046774;1194.9484453680705;1274.5475356248583;1361.6247589934237;1373.8488766235705;796.8167321516083;818.3167055508717;831.3972370031679;835.8495470815311;839.5046922315863;4734.739589322551;4939.259111133287;5163.509466600667;5333.733313334318;5334.759935802898;5757.971210143923;5758.74085666146;5769.567282453832;5783.8554036149435;5788.305403351625;4415.66882483815;4794.856154315376;5300.966311569207;5430.592705547021;5507.889842203133;2801.481725880678;2818.1122946271857;3011.3224524481816;3016.3967206558777;3038.0885734279627;5841.50347220491;5888.087346461305;6002.819915402545;6021.3677563856045;6026.638401695912;5699.834063056012;5726.971365143231;5930.094253815686;5946.494547963385;6023.45788879003;6002.219711437398;6029.939700602938;6036.215292012011;6089.969550152221;6091.543134264859;4855.854324370274;5064.645474816874;5420.918686219631;5736.512396446349;5763.7118144093465;4993.500649934977;5541.5289700375915;5727.97136014334;5729.799457018984;5733.627314224562;6024.608400453956;6051.213342265477;6064.332923378513;6098.451139397475;6110.327863934875;3838.9040273992255;4038.7980600969245;4049.4128351388295;4063.3701776224734;4066.8983275417168;5802.390748971297;5823.621464604787;5869.765209391748;5871.2073870027;5888.970555147368;5448.291722076105;5677.914831277451;5692.544596432358;5707.828765137053;5744.684042377709;4709.9529004710885;4836.975815120902;5143.4085080216255;5588.720563971867;5631.662859913254;4511.774411279489;5228.568715547289;5462.91805622908;5498.340199176125;5536.425562113636;4973.52751488608;5096.51583099605;5392.514673679388;5578.665280083208;5644.8306550803545;4845.297431872288;4926.4088309403105;5208.24480450325;5516.73115183502;5525.640833345819 03:23:22 INFO - PROCESS | 1645 | |5;yui.html;694.3958755882383;771.3906014248744;812.2243257688906;813.3899575318508;817.9631916563754;13801;15325.846741532581;16571.917140414313;16620.66758664826;16627.83372166278;15061.548153555412;15217.163056031914;15318.540443786676;15318.540443786704;15349.462768803067;708.2775568919699;718.9460790440712;730.1420830524113;918.3112665500875;921.2031592672324;898.9280857531414;911.7720569857536;914.8078903430288;916.2120576304372;916.5142474488498;817.1787353709514;970.1559643110504;971.121135372489;971.4414211828192;972.9562169702381;760.4334770595914;943.2501161576495;969.7963427680196;971.3637567393368;971.8930917599058;717.5909731453074;718.3391280022392;718.5473151914313;718.622723070387;720.3049057659332;15266.313015914311;15268.16025118618;15333.616659583487;15343.693126137527;15348.539543813704;14325.283735813167;14445.927770361186;14486.20325882076;14539.636509087251;14656.41374345025;13168.539101131415;13258.40337184829;13287.269200193985;13321.800172997317;13689.110207836458;4564.1556312082375;4702.670813043088;4726.456457507396;4793.952060479385;4849.078675051729;114526.85473145245;114657.42671286674;114873.42563287214;115022;115430.26854597103;11363.715907102223;11645.12661550387;11646.301221926711;11760.823587646191;11880.76238475243;22884.885575572014;23131;23132.7686723134;23156.76843231546;23167;7704.191059938737;8226.42415030954;8372.120927302667;8403.41176117666;8413.831723365498;4462.152191083684;4517.887052823706;4588.242939914943;4698.271767875985;4740;3512.7189824813954;3630.745847790682;3633.0372451300427;3635.2184280379847;3654.543182102237;608.1030480041903;621.0963048764038;630.1178350309511;631.4474834519796;634.0995785983914;550.6613432738836;570.7945139749687;609.6829648582712;615.8029430582171;678.5385937562406;8641.524716140673;8776.561171941377;9106.31702622306;9207.815843683089;9249.445033298023;559.720139930035;591.249113625693;599.7810799058312;620.6369273974685;640.2029473305764;3757.9248415032093;4406.237504998026;4549.909001820011;4566.1552612766745;4610.976945115253;136080;151006;152611;152823;153712;127195;127691;128817;130080;131368.3431582855;75487.62256188794;103566.48216758868;112014.43992779985;115208;117432.41283793526;8551.444156129832;8572.785680358042;8708.346873984603;8719.52042637661;8787;61015.69492152511;62653;64068.3593164081;64125.3587464138;66280;46009.539904600526;60264.09603855858;65006.34993650003;65257.69484610186;90571.5471422665;11790.23363481371;11799.587014454797;11850.407479626158;12120.393980300772;12365.938170309091;11977.880221197676;12037.759244814879;12055.35459989945;12118.697032574257;12443.37783110859;11655.125865559947;11818.645440636794;11982.281063136239;12046.75906481883;12201.938990304992;11575.305481671126;11795.056395488513;11893;12207.694807629525;12237.143399962273;11657.242279251821;11839.822402663794;12138.393080345772;12152.75694486123;12208;10038.397696138256;10118.696439106838;10167.898321016695;10216.233782466195;10470.267081304235;9379.202767764817;9577.664781732607;10097.5456104474;10129.544170512492;10141.594336226468 03:23:22 INFO - PROCESS | 1645 | __end_tp_report 03:23:22 INFO - PROCESS | 1645 | __start_cc_report 03:23:22 INFO - PROCESS | 1645 | _x_x_mozilla_cycle_collect,1316 03:23:22 INFO - PROCESS | 1645 | __end_cc_report 03:23:22 INFO - PROCESS | 1645 | __startTimestamp1468405402669__endTimestamp 03:23:22 INFO - PROCESS | 1645 | 03:23:22 INFO - PROCESS | 1645 | ------- Summary: start ------- 03:23:22 INFO - PROCESS | 1645 | Number of tests: 6 03:23:22 INFO - PROCESS | 1645 | 03:23:22 INFO - PROCESS | 1645 | [#0] dojo.html Cycles:165 Average:5657.04 Median:5841.12 stddev:650.55 (11.1%) stddev-sans-first:626.66 03:23:22 INFO - PROCESS | 1645 | Values: 3340.9 3355.9 3362.4 3383.3 3435.7 5519.3 5578.9 5589.5 5679.7 5682.8 4398.0 4632.5 5565.9 5673.9 5691.1 5022.1 5043.1 5082.1 5092.7 5179.3 4610.6 5209.5 5223.2 5234.1 5263.9 5062.0 5081.1 5094.5 5120.9 5155.7 5050.8 5133.5 5140.0 5143.7 5150.5 5007.8 5025.8 5083.3 5097.9 5166.1 5585.1 5642.2 5646.6 5668.9 5673.1 5963.4 6028.9 6096.4 6115.9 6121.3 6125.2 6139.8 6202.1 6245.6 6262.3 5719.7 5750.1 5772.4 5777.2 5778.5 6001.6 6207.4 6319.5 6340.2 6347.2 6046.8 6089.2 6091.9 6093.1 6099.6 6165.8 6194.2 6201.8 6209.3 6211.0 5984.5 6030.1 6074.3 6126.0 6137.5 6106.2 6145.5 6151.1 6191.8 6193.0 4859.4 4866.7 4876.0 4900.4 4908.7 4349.8 4359.0 4381.1 4382.5 4409.7 5685.1 5696.8 5706.1 5716.7 5721.1 6208.0 6250.8 6265.5 6267.1 6291.1 5685.5 5703.8 5752.8 5782.1 5786.5 5260.0 5324.7 5338.6 5358.4 5374.6 6229.5 6304.2 6308.7 6313.6 6315.7 6194.3 6205.5 6206.4 6213.5 6218.8 6136.0 6156.9 6186.9 6219.4 6317.7 6097.4 6127.2 6127.4 6143.6 6152.9 5641.8 5680.1 6179.5 6198.5 6206.1 5864.5 5981.2 5999.1 6027.2 6041.2 6037.8 6045.1 6054.3 6059.3 6063.1 4672.9 5838.8 5844.6 5869.6 5918.9 5833.2 5946.9 6022.5 6056.9 6075.9 5787.2 5814.7 5841.1 5859.2 5869.0 03:23:22 INFO - PROCESS | 1645 | 03:23:22 INFO - PROCESS | 1645 | [#1] ext.html Cycles:180 Average:70870.12 Median:35981.32 stddev:157513.54 (437.8%) stddev-sans-first:157866.78 03:23:22 INFO - PROCESS | 1645 | Values: 493.5 497.7 501.6 505.8 507.6 30202.4 40994.4 42222.0 42229.0 44105.7 43408.8 43672.9 43818.3 43875.1 43902.1 8647.1 9603.5 9794.5 9800.5 9814.7 8610.3 11666.8 11756.9 11772.6 12067.2 11781.6 11830.5 11837.2 11840.9 11868.6 8735.3 11676.3 11739.0 11770.9 11927.0 11808.5 11877.2 11888.4 11892.0 11895.8 40424.8 40856.6 40864.0 40900.8 40957.4 3517.2 3563.5 3672.8 3751.2 3832.1 25424.7 32081.2 32646.7 33151.3 33172.8 3273.0 3288.9 3312.3 3325.4 3420.7 515882.0 518935.0 519168.0 519716.0 519748.0 34629.8 64312.4 64815.4 64972.1 64990.7 34881.5 36085.6 36148.5 36149.3 36207.1 15206.4 15216.2 15390.2 15395.9 15406.5 11570.1 11814.2 12696.8 12826.0 12933.4 7807.5 7844.1 7883.0 7890.7 7950.2 3317.1 3328.0 3333.1 3341.5 3359.5 972.6 984.9 1016.5 1075.0 1119.8 30977.4 30979.8 31080.8 31645.0 31915.5 1072.7 1094.7 1097.1 1139.7 1212.0 16236.9 16268.5 16434.1 16573.8 16591.3 608601.0 705817.0 713593.0 714257.0 716362.0 60508.0 61189.8 61226.4 61250.7 61253.0 1071.7 1312.4 1377.4 1405.3 1432.0 28794.9 30138.4 30466.5 32701.8 32711.0 49767.5 50018.0 50612.7 50643.0 50798.0 531757.0 536457.0 537777.0 540735.0 542180.0 23705.5 24017.8 26289.3 27411.2 27914.2 48609.8 49255.3 49622.5 49740.0 50286.2 39066.8 41147.8 41451.8 41721.8 41850.4 36003.0 39794.8 40768.4 40806.8 41589.0 38122.9 38879.4 39290.0 39680.2 39699.6 34267.7 35110.5 35188.6 35925.5 35959.6 26208.0 26230.5 26256.0 26596.6 27022.2 03:23:22 INFO - PROCESS | 1645 | 03:23:22 INFO - PROCESS | 1645 | [#2] jquery.html Cycles:180 Average:35721.68 Median:23034.65 stddev:98798.46 (428.9%) stddev-sans-first:99039.92 03:23:22 INFO - PROCESS | 1645 | Values: 351.2 372.9 382.0 384.5 403.1 16062.6 16295.0 19114.8 21504.9 22224.2 21971.8 22522.0 22854.1 23014.8 23054.5 5996.1 6002.5 6227.5 6228.3 6232.8 4231.0 4459.5 6162.0 6177.6 6629.2 6866.5 6928.3 6941.0 6941.2 6963.3 6639.3 6897.0 6941.9 6942.5 6955.2 5806.0 6008.1 6032.1 6038.7 6055.8 27651.6 27735.7 27737.3 28030.3 28137.9 2271.2 2371.8 2393.7 2539.7 2766.4 15212.0 16706.1 16917.3 17347.4 17383.3 1896.1 1946.5 1957.2 1983.3 2088.5 119346.4 121232.0 125939.0 126704.0 127151.4 10941.6 11000.9 11467.3 11475.7 11614.7 14158.3 14281.1 14428.0 14433.8 14442.6 8798.3 8949.5 9006.7 9047.6 9081.0 9050.8 9074.4 9075.0 9076.5 9193.4 6990.5 6990.5 6995.7 7000.4 7000.9 1845.8 1891.2 1894.4 1895.8 1938.9 884.5 889.2 955.8 1002.5 1041.8 21836.8 22933.4 23448.8 23833.6 23843.6 980.2 1013.9 1028.9 1036.4 1052.9 12175.0 12370.3 12587.6 12666.9 12732.4 578031.0 586430.1 595734.0 598676.0 598682.0 116635.4 128479.4 128780.0 129031.4 129823.0 1024.1 1038.1 1047.4 1071.3 1074.4 20625.5 20716.1 20752.0 20968.5 20970.8 36206.8 53776.8 53929.5 55196.6 55597.1 80539.2 80778.6 80809.0 82246.5 83018.0 8004.6 8390.7 8460.3 8474.4 8688.3 14030.2 14053.8 14209.5 14237.6 14299.6 6111.8 9509.9 11153.6 12119.9 12125.8 11582.0 11675.0 11808.4 11984.1 12053.0 11338.5 11404.2 11665.2 11886.7 12159.9 8410.4 8422.0 8463.1 8609.6 8630.2 11822.6 11823.0 11982.5 11995.2 12011.0 03:23:22 INFO - PROCESS | 1645 | 03:23:22 INFO - PROCESS | 1645 | [#3] mootools.html Cycles:180 Average:5621.61 Median:5036.74 stddev:3154.70 (62.6%) stddev-sans-first:3147.48 03:23:22 INFO - PROCESS | 1645 | Values: 1384.7 1553.7 1581.7 1680.3 1789.0 7697.9 8430.3 8679.7 8685.9 8773.1 8434.0 8546.3 8617.7 8625.7 8631.0 2328.2 2352.1 2360.6 2362.1 2362.5 2330.3 2345.0 2370.2 2370.2 2372.6 2321.2 2350.3 2353.9 2358.2 2359.4 2301.7 2325.1 2332.1 2334.8 2342.1 1946.6 2329.4 2330.8 2336.1 2336.2 8473.0 8663.0 8668.8 8743.6 8753.3 4467.4 5076.3 5240.6 5248.9 5252.4 3402.2 3506.9 3551.3 3567.4 3569.9 1071.8 1093.4 1096.6 1117.2 1119.4 11257.5 11361.9 11368.1 11368.5 11384.3 3580.9 4337.3 4553.7 4557.2 4562.2 9008.9 9017.6 9031.5 9043.9 9054.9 4586.7 5028.6 5202.7 5210.7 5211.5 4393.2 4526.8 4705.2 4866.5 4894.0 3155.8 3197.2 3748.3 3834.9 3874.2 1122.0 1158.0 1160.5 1160.7 1173.2 581.0 656.7 814.2 857.0 978.6 5818.7 5882.8 6096.7 6106.9 6121.3 960.4 968.0 970.2 977.0 998.8 3576.9 4048.1 4121.4 4184.5 4188.6 9888.0 10671.4 10673.4 10687.7 10726.2 10484.9 10610.6 10682.1 10692.7 10695.5 8189.3 8306.5 8310.7 8325.8 8328.8 5287.3 5746.7 5990.2 6046.8 6051.2 9695.3 9852.2 9992.9 10042.3 10122.0 9951.1 10180.9 10196.1 10277.6 10292.8 7036.8 7113.7 7184.6 7193.6 7196.9 8108.8 8337.1 8347.2 8355.7 8374.2 7462.1 7517.5 7521.4 7526.9 7645.0 7277.2 7312.5 7377.8 7403.2 7442.4 6836.8 6931.2 7000.5 7004.4 7030.8 4817.5 5025.6 5067.7 5102.2 5207.4 5003.9 5044.9 5076.6 5182.7 5211.1 03:23:22 INFO - PROCESS | 1645 | 03:23:22 INFO - PROCESS | 1645 | [#4] prototype.html Cycles:180 Average:4599.79 Median:5196.35 stddev:1414.96 (27.2%) stddev-sans-first:1381.68 03:23:22 INFO - PROCESS | 1645 | Values: 302.4 309.3 311.5 315.3 317.9 4989.8 5430.0 5439.3 5440.0 5457.7 4527.5 4721.3 5049.8 5239.4 5386.8 3518.9 3620.0 3967.2 4093.4 4196.6 4088.5 4129.4 4133.9 4166.8 4176.2 4093.7 4101.5 4101.6 4126.9 4137.8 3375.4 3789.9 3909.4 4114.9 4126.8 3576.8 3587.1 3590.4 3593.4 3596.6 5229.5 5241.8 5250.7 5264.7 5296.2 4504.4 4699.3 4715.6 4720.9 4730.3 5214.0 5371.3 5387.8 5606.8 5634.6 3586.9 3982.8 3992.7 4009.8 4013.9 5237.3 5610.3 5905.1 5921.4 5932.1 3711.3 3766.2 4009.1 4050.4 4074.4 4106.8 4126.9 4130.3 4135.8 4148.6 3364.2 4547.8 4718.9 4723.1 4726.4 5184.5 5491.8 5667.7 5681.2 5700.5 1142.5 1194.9 1274.5 1361.6 1373.8 796.8 818.3 831.4 835.8 839.5 4734.7 4939.3 5163.5 5333.7 5334.8 5758.0 5758.7 5769.6 5783.9 5788.3 4415.7 4794.9 5301.0 5430.6 5507.9 2801.5 2818.1 3011.3 3016.4 3038.1 5841.5 5888.1 6002.8 6021.4 6026.6 5699.8 5727.0 5930.1 5946.5 6023.5 6002.2 6029.9 6036.2 6090.0 6091.5 4855.9 5064.6 5420.9 5736.5 5763.7 4993.5 5541.5 5728.0 5729.8 5733.6 6024.6 6051.2 6064.3 6098.5 6110.3 3838.9 4038.8 4049.4 4063.4 4066.9 5802.4 5823.6 5869.8 5871.2 5889.0 5448.3 5677.9 5692.5 5707.8 5744.7 4710.0 4837.0 5143.4 5588.7 5631.7 4511.8 5228.6 5462.9 5498.3 5536.4 4973.5 5096.5 5392.5 5578.7 5644.8 4845.3 4926.4 5208.2 5516.7 5525.6 03:23:22 INFO - PROCESS | 1645 | 03:23:22 INFO - PROCESS | 1645 | [#5] yui.html Cycles:180 Average:24058.12 Median:3644.88 stddev:38867.91 (1066.4%) stddev-sans-first:38937.35 03:23:22 INFO - PROCESS | 1645 | Values: 694.4 771.4 812.2 813.4 818.0 13801.0 15325.8 16571.9 16620.7 16627.8 15061.5 15217.2 15318.5 15318.5 15349.5 708.3 718.9 730.1 918.3 921.2 898.9 911.8 914.8 916.2 916.5 817.2 970.2 971.1 971.4 973.0 760.4 943.3 969.8 971.4 971.9 717.6 718.3 718.5 718.6 720.3 15266.3 15268.2 15333.6 15343.7 15348.5 14325.3 14445.9 14486.2 14539.6 14656.4 13168.5 13258.4 13287.3 13321.8 13689.1 4564.2 4702.7 4726.5 4794.0 4849.1 114526.9 114657.4 114873.4 115022.0 115430.3 11363.7 11645.1 11646.3 11760.8 11880.8 22884.9 23131.0 23132.8 23156.8 23167.0 7704.2 8226.4 8372.1 8403.4 8413.8 4462.2 4517.9 4588.2 4698.3 4740.0 3512.7 3630.7 3633.0 3635.2 3654.5 608.1 621.1 630.1 631.4 634.1 550.7 570.8 609.7 615.8 678.5 8641.5 8776.6 9106.3 9207.8 9249.4 559.7 591.2 599.8 620.6 640.2 3757.9 4406.2 4549.9 4566.2 4611.0 136080.0 151006.0 152611.0 152823.0 153712.0 127195.0 127691.0 128817.0 130080.0 131368.3 75487.6 103566.5 112014.4 115208.0 117432.4 8551.4 8572.8 8708.3 8719.5 8787.0 61015.7 62653.0 64068.4 64125.4 66280.0 46009.5 60264.1 65006.3 65257.7 90571.5 11790.2 11799.6 11850.4 12120.4 12365.9 11977.9 12037.8 12055.4 12118.7 12443.4 11655.1 11818.6 11982.3 12046.8 12201.9 11575.3 11795.1 11893.0 12207.7 12237.1 11657.2 11839.8 12138.4 12152.8 12208.0 10038.4 10118.7 10167.9 10216.2 10470.3 9379.2 9577.7 10097.5 10129.5 10141.6 03:23:22 INFO - PROCESS | 1645 | -------- Summary: end -------- 03:23:22 INFO - PROCESS | 1645 | 03:23:23 INFO - TEST-INFO | 1645: exit 0 03:23:23 INFO - TEST-OK | dromaeo_css | took 1116480ms 03:23:23 INFO - TEST-START | kraken 03:23:23 INFO - operating with platform_type : mac_ 03:23:23 INFO - Initialising browser for kraken test... 03:23:23 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/tmpgWIdIc/profile http://localhost:49270/getInfo.html) 03:23:25 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 03:23:25 INFO - PROCESS | 1654 | colorDepth:24 03:23:25 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 03:23:25 INFO - PROCESS | 1654 | __metrics 03:23:25 INFO - PROCESS | 1654 | 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" 03:23:25 INFO - PROCESS | 1654 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:23:26 INFO - TEST-INFO | 1654: exit 0 03:23:26 INFO - Browser initialized. 03:23:26 INFO - Running cycle 1/1 for kraken test... 03:23:26 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/tmpgWIdIc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:23:38 INFO - PROCESS | 1655 | RSS: Main: 243769344 03:23:38 INFO - PROCESS | 1655 | 03:23:40 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 03:23:41 INFO - PROCESS | 1655 | RSS: Main: 294092800 03:23:41 INFO - PROCESS | 1655 | 03:23:44 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 03:23:44 INFO - PROCESS | 1655 | RSS: Main: 303996928 03:23:44 INFO - PROCESS | 1655 | 03:23:48 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 03:23:49 INFO - PROCESS | 1655 | RSS: Main: 388849664 03:23:49 INFO - PROCESS | 1655 | 03:23:51 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 03:23:51 INFO - PROCESS | 1655 | RSS: Main: 290336768 03:23:51 INFO - PROCESS | 1655 | 03:23:53 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:23:54 INFO - PROCESS | 1655 | RSS: Main: 294088704 03:23:54 INFO - PROCESS | 1655 | 03:23:57 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 03:23:57 INFO - PROCESS | 1655 | RSS: Main: 330948608 03:23:57 INFO - PROCESS | 1655 | 03:24:00 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 03:24:01 INFO - PROCESS | 1655 | RSS: Main: 333545472 03:24:01 INFO - PROCESS | 1655 | 03:24:04 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 03:24:04 INFO - PROCESS | 1655 | RSS: Main: 331005952 03:24:04 INFO - PROCESS | 1655 | 03:24:06 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:24:07 INFO - PROCESS | 1655 | RSS: Main: 311824384 03:24:07 INFO - PROCESS | 1655 | 03:24:09 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:24:09 INFO - PROCESS | 1655 | RSS: Main: 318115840 03:24:09 INFO - PROCESS | 1655 | 03:24:11 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:24:12 INFO - PROCESS | 1655 | RSS: Main: 318025728 03:24:12 INFO - PROCESS | 1655 | 03:24:15 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:24:16 INFO - PROCESS | 1655 | RSS: Main: 324825088 03:24:16 INFO - PROCESS | 1655 | 03:24:18 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:24:19 INFO - PROCESS | 1655 | RSS: Main: 326299648 03:24:19 INFO - PROCESS | 1655 | 03:24:21 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 03:24:21 INFO - PROCESS | 1655 | RSS: Main: 369586176 03:24:21 INFO - PROCESS | 1655 | 03:24:21 INFO - PROCESS | 1655 | __start_tp_report 03:24:21 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 03:24:21 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 03:24:21 INFO - PROCESS | 1655 | |i|pagename|runs| 03:24:21 INFO - PROCESS | 1655 | |0;ai-astar;99;111;119;164;161;109;110;110;110;110 03:24:21 INFO - PROCESS | 1655 | |1;audio-beat-detection;140;108;105;157;110;103;126;106;139;104 03:24:21 INFO - PROCESS | 1655 | |2;audio-dft;182;182;185;183;179;181;179;183;182;182 03:24:21 INFO - PROCESS | 1655 | |3;audio-fft;82;74;58;106;58;57;59;60;126;57 03:24:21 INFO - PROCESS | 1655 | |4;audio-oscillator;82;87;92;69;79;68;95;71;68;108 03:24:21 INFO - PROCESS | 1655 | |5;imaging-gaussian-blur;89;86;89;86;87;85;89;86;88;85 03:24:21 INFO - PROCESS | 1655 | |6;imaging-darkroom;95;95;95;95;95;95;104;150;123;95 03:24:21 INFO - PROCESS | 1655 | |7;imaging-desaturate;85;86;85;84;87;101;139;83;84;84 03:24:21 INFO - PROCESS | 1655 | |8;json-parse-financial;53;55;54;54;54;54;55;54;56;86 03:24:21 INFO - PROCESS | 1655 | |9;json-stringify-tinderbox;65;66;76;78;72;73;71;71;72;73 03:24:21 INFO - PROCESS | 1655 | |10;stanford-crypto-aes;75;82;84;82;81;81;85;84;83;86 03:24:21 INFO - PROCESS | 1655 | |11;stanford-crypto-ccm;132;134;134;134;151;153;141;137;185;141 03:24:21 INFO - PROCESS | 1655 | |12;stanford-crypto-pbkdf2;162;168;162;162;162;163;163;156;162;162 03:24:21 INFO - PROCESS | 1655 | |13;stanford-crypto-sha256-iterative;67;75;81;85;71;66;65;66;66;66 03:24:21 INFO - PROCESS | 1655 | __end_tp_report 03:24:21 INFO - PROCESS | 1655 | __start_cc_report 03:24:21 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,2077 03:24:21 INFO - PROCESS | 1655 | __end_cc_report 03:24:21 INFO - PROCESS | 1655 | __startTimestamp1468405461575__endTimestamp 03:24:21 INFO - PROCESS | 1655 | 03:24:21 INFO - PROCESS | 1655 | ------- Summary: start ------- 03:24:21 INFO - PROCESS | 1655 | Number of tests: 14 03:24:21 INFO - PROCESS | 1655 | 03:24:21 INFO - PROCESS | 1655 | [#0] ai-astar Cycles:10 Average:120.30 Median:115.00 stddev:22.75 (19.8%) stddev-sans-first:22.79 03:24:21 INFO - PROCESS | 1655 | Values: 99.0 111.0 119.0 164.0 161.0 109.0 110.0 110.0 110.0 110.0 03:24:21 INFO - PROCESS | 1655 | 03:24:21 INFO - PROCESS | 1655 | [#1] audio-beat-detection Cycles:10 Average:119.80 Median:118.00 stddev:19.37 (16.4%) stddev-sans-first:19.11 03:24:21 INFO - PROCESS | 1655 | Values: 140.0 108.0 105.0 157.0 110.0 103.0 126.0 106.0 139.0 104.0 03:24:21 INFO - PROCESS | 1655 | 03:24:21 INFO - PROCESS | 1655 | [#2] audio-dft Cycles:10 Average:181.80 Median:182.00 stddev:1.81 (1.0%) stddev-sans-first:1.92 03:24:21 INFO - PROCESS | 1655 | Values: 182.0 182.0 185.0 183.0 179.0 181.0 179.0 183.0 182.0 182.0 03:24:21 INFO - PROCESS | 1655 | 03:24:21 INFO - PROCESS | 1655 | [#3] audio-fft Cycles:10 Average:73.70 Median:58.50 stddev:24.27 (41.5%) stddev-sans-first:25.56 03:24:21 INFO - PROCESS | 1655 | Values: 82.0 74.0 58.0 106.0 58.0 57.0 59.0 60.0 126.0 57.0 03:24:21 INFO - PROCESS | 1655 | 03:24:21 INFO - PROCESS | 1655 | [#4] audio-oscillator Cycles:10 Average:81.90 Median:80.50 stddev:13.58 (16.9%) stddev-sans-first:14.41 03:24:21 INFO - PROCESS | 1655 | Values: 82.0 87.0 92.0 69.0 79.0 68.0 95.0 71.0 68.0 108.0 03:24:21 INFO - PROCESS | 1655 | 03:24:21 INFO - PROCESS | 1655 | [#5] imaging-gaussian-blur Cycles:10 Average:87.00 Median:87.50 stddev:1.63 (1.9%) stddev-sans-first:1.56 03:24:21 INFO - PROCESS | 1655 | Values: 89.0 86.0 89.0 86.0 87.0 85.0 89.0 86.0 88.0 85.0 03:24:21 INFO - PROCESS | 1655 | 03:24:21 INFO - PROCESS | 1655 | [#6] imaging-darkroom Cycles:10 Average:104.20 Median:95.00 stddev:18.39 (19.4%) stddev-sans-first:19.20 03:24:21 INFO - PROCESS | 1655 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 104.0 150.0 123.0 95.0 03:24:21 INFO - PROCESS | 1655 | 03:24:21 INFO - PROCESS | 1655 | [#7] imaging-desaturate Cycles:10 Average:91.80 Median:84.50 stddev:17.39 (20.6%) stddev-sans-first:18.27 03:24:21 INFO - PROCESS | 1655 | Values: 85.0 86.0 85.0 84.0 87.0 101.0 139.0 83.0 84.0 84.0 03:24:21 INFO - PROCESS | 1655 | 03:24:21 INFO - PROCESS | 1655 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:54.50 stddev:10.05 (18.4%) stddev-sans-first:10.52 03:24:21 INFO - PROCESS | 1655 | Values: 53.0 55.0 54.0 54.0 54.0 54.0 55.0 54.0 56.0 86.0 03:24:21 INFO - PROCESS | 1655 | 03:24:21 INFO - PROCESS | 1655 | [#9] json-stringify-tinderbox Cycles:10 Average:71.70 Median:72.50 stddev:3.95 (5.4%) stddev-sans-first:3.36 03:24:21 INFO - PROCESS | 1655 | Values: 65.0 66.0 76.0 78.0 72.0 73.0 71.0 71.0 72.0 73.0 03:24:21 INFO - PROCESS | 1655 | 03:24:21 INFO - PROCESS | 1655 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:83.50 stddev:3.06 (3.7%) stddev-sans-first:1.76 03:24:21 INFO - PROCESS | 1655 | Values: 75.0 82.0 84.0 82.0 81.0 81.0 85.0 84.0 83.0 86.0 03:24:21 INFO - PROCESS | 1655 | 03:24:21 INFO - PROCESS | 1655 | [#11] stanford-crypto-ccm Cycles:10 Average:144.20 Median:141.00 stddev:16.06 (11.4%) stddev-sans-first:16.42 03:24:21 INFO - PROCESS | 1655 | Values: 132.0 134.0 134.0 134.0 151.0 153.0 141.0 137.0 185.0 141.0 03:24:21 INFO - PROCESS | 1655 | 03:24:21 INFO - PROCESS | 1655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.20 Median:162.00 stddev:2.86 (1.8%) stddev-sans-first:3.03 03:24:21 INFO - PROCESS | 1655 | Values: 162.0 168.0 162.0 162.0 162.0 163.0 163.0 156.0 162.0 162.0 03:24:21 INFO - PROCESS | 1655 | 03:24:21 INFO - PROCESS | 1655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.80 Median:69.00 stddev:7.18 (10.4%) stddev-sans-first:7.48 03:24:21 INFO - PROCESS | 1655 | Values: 67.0 75.0 81.0 85.0 71.0 66.0 65.0 66.0 66.0 66.0 03:24:21 INFO - PROCESS | 1655 | -------- Summary: end -------- 03:24:21 INFO - PROCESS | 1655 | 03:24:22 INFO - TEST-INFO | 1655: exit 0 03:24:22 INFO - TEST-OK | kraken | took 59125ms 03:24:22 INFO - SUITE-END | took 1175s 03:24:22 INFO - Completed test suite (00:19:35) 03:24:22 INFO - javascript benchmark 03:24:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3340.89977300681, 3355.8657653693854, 3362.4283871741786, 3383.340248651514, 3435.728780351269, 5519.31008623922, 5578.916316255254, 5589.496945274925, 5679.687617181054, 5682.801101961432, 4398.0, 4632.49042605314, 5565.860853478655, 5673.886522269552, 5691.08942569189, 5022.0709168803705, 5043.117454445476, 5082.08522465956, 5092.719900405476, 5179.2749015137915, 4610.5850473457385, 5209.531142197202, 5223.242629818674, 5234.136367499358, 5263.947360526403, 5062.038212739604, 5081.085404627165, 5094.541491265767, 5120.92318615221, 5155.742212889378, 5050.823221187241, 5133.486651334874, 5139.974300128512, 5143.665661731976, 5150.484951504857, 5007.774650140753, 5025.849224523234, 5083.262926875583, 5097.923531147036, 5166.147585648364, 5585.106382978704, 5642.181883626892, 5646.57650676201, 5668.943310566883, 5673.063944449161, 5963.373845746178, 6028.879422411571, 6096.359882212392, 6115.877682446326, 6121.348314606742, 6125.2381759958735, 6139.84650383744, 6202.069689546559, 6245.6252624842655, 6262.342454042351, 5719.742611582489, 5750.05124154514, 5772.365039845614, 5777.162311464856, 5778.5377169826315, 6001.639901605918, 6207.441330280297, 6319.494440444753, 6340.239171299474, 6347.174867267226, 6046.788362407295, 6089.186564748667, 6091.872015805945, 6093.080679586005, 6099.649921844167, 6165.815025549241, 6194.225721784777, 6201.7519299228425, 6209.285932117774, 6210.968945155245, 5984.491318237911, 6030.065339872327, 6074.301455332693, 6125.96937015321, 6137.478314343331, 6106.206193194945, 6145.508359331332, 6151.138840562325, 6191.84520386994, 6193.009118541012, 4859.416869975626, 4866.7079975201605, 4876.0, 4900.387451568554, 4908.730019848871, 4349.760763158057, 4358.997430590982, 4381.079973205598, 4382.53983331752, 4409.669274804402, 5685.147227915846, 5696.829095127153, 5706.144078388275, 5716.714164291769, 5721.056025755704, 6207.968960155261, 6250.781222657185, 6265.467435267962, 6267.091271765659, 6291.087792270187, 5685.459881311269, 5703.771849125988, 5752.7698892043845, 5782.132680098019, 5786.479216870502, 5259.973700131552, 5324.707141107277, 5338.599605029561, 5358.3837858645975, 5374.623776335619, 6229.53278504114, 6304.211973503312, 6308.716107775253, 6313.55805093639, 6315.715792789428, 6194.287656919512, 6205.5345849060595, 6206.410391012847, 6213.502919766317, 6218.782342617987, 6135.998322733915, 6156.876862462636, 6186.907196391968, 6219.440250377488, 6317.652529110943, 6097.355064906588, 6127.220070483952, 6127.403330890726, 6143.634700640197, 6152.907706384497, 5641.774329026957, 5680.062789639664, 6179.5056395489155, 6198.535109866868, 6206.06908963659, 5864.501517371071, 5981.162637230704, 5999.100134979788, 6027.156198132353, 6041.24484439445, 6037.849053773515, 6045.093236014633, 6054.3340232575265, 6059.303180134165, 6063.090536419572, 4672.878509157709, 5838.766449341979, 5844.620099693507, 5869.647821130746, 5918.852028699317, 5833.212516310244, 5946.910796338145, 6022.518198544193, 6056.878862422815, 6075.878482430238, 5787.247657804459, 5814.651120932757, 5841.1238314253205, 5859.20900678403, 5869.031609784338], "value": 5615.8337755918, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [493.4744497110578, 497.72625056219084, 501.61876973500154, 505.7900971096995, 507.6497216920325, 30202.395952080944, 40994.38508422372, 42222.0, 42229.0, 44105.67682969516, 43408.782956085175, 43672.90817729558, 43818.342724859074, 43875.12249755003, 43902.12195756083, 8647.135286471366, 9603.519824008807, 9794.461304628243, 9800.460974646392, 9814.705558833246, 8610.311175106008, 11666.824997625043, 11756.941875231227, 11772.587959421422, 12067.215630984001, 11781.587644432446, 11830.526778928832, 11837.230580012314, 11840.881591184107, 11868.584599539017, 8735.344849136276, 11676.299422034705, 11739.0, 11770.941145294304, 11926.986206172529, 11808.468618912084, 11877.16859819813, 11888.405579720978, 11891.989180919632, 11895.762084758257, 40424.79787601073, 40856.591434085574, 40864.0, 40900.79549602233, 40957.385639215136, 3517.191046059395, 3563.5367402237803, 3672.779633222015, 3751.2497500499735, 3832.137769001952, 25424.74575254242, 32081.197970050704, 32646.673533264602, 33151.3369732604, 33172.834135829406, 3272.9509057364157, 3288.901332960015, 3312.337532493487, 3325.384803811303, 3420.6921377076183, 515882.0, 518935.0, 519168.0, 519716.0, 519748.0, 34629.82685086609, 64312.35687643064, 64815.35184648188, 64972.05083847397, 64990.70018599696, 34881.47677784835, 36085.63914360823, 36148.45777313342, 36149.27701445956, 36207.094822629115, 15206.391744330323, 15216.239188040554, 15390.153541555099, 15395.923020384826, 15406.460773873085, 11570.132240081859, 11814.173007889365, 12696.809547856605, 12826.0, 12933.353332333345, 7807.453478256468, 7844.058712954368, 7882.960585197037, 7890.684372625145, 7950.204979502004, 3317.087800854736, 3327.966720332766, 3333.116724068124, 3341.498775183742, 3359.4792807114936, 972.5817898303656, 984.9015098490094, 1016.5222345497752, 1074.9731256718644, 1119.776044791045, 30977.380452390826, 30979.845100774353, 31080.844595776878, 31645.0, 31915.521267180546, 1072.651388298806, 1094.7208461842179, 1097.1497089755503, 1139.720768411728, 1211.987880121205, 16236.944598601052, 16268.511944641443, 16434.096124713255, 16573.8398312117, 16591.25339359732, 608601.0, 705817.0, 713593.0, 714257.0, 716362.0, 60508.0, 61189.77620447566, 61226.38773612296, 61250.69374653098, 61253.0, 1071.6838532632892, 1312.4422120598708, 1377.393946663465, 1405.3184205660248, 1431.978520322196, 28794.85602571974, 30138.3972320548, 30466.47667616566, 32701.836490817393, 32711.0, 49767.50232497629, 50017.99964000627, 50612.73468163325, 50643.0, 50798.0, 531757.0, 536457.0, 537777.0, 540735.0, 542180.0, 23705.52588948246, 24017.799110044776, 26289.34276643023, 27411.177664670093, 27914.16257512278, 48609.756951216434, 49255.261171081744, 49622.50377496179, 49740.0, 50286.245706313704, 39066.80466597649, 41147.765567033035, 41451.7927410361, 41721.79139104285, 41850.37224441575, 36003.0, 39794.80102599585, 40768.3884741735, 40806.79596601998, 41589.0, 38122.856314310615, 38879.41680874846, 39290.0, 39680.2063958725, 39699.60300396959, 34267.65732342745, 35110.47334290039, 35188.64811351854, 35925.46111808273, 35959.64040359563, 26208.0, 26230.4753904917, 26256.0, 26596.572243996223, 27022.189334320003], "value": 19479.939429532726, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.1852502194909, 372.91609387887723, 381.96944244460445, 384.4771111288647, 403.1232070247212, 16062.59843503913, 16295.0, 19114.808851911475, 21504.89247553764, 22224.222152224676, 21971.780282197175, 22521.98651060702, 22854.08583656656, 23014.769852301513, 23054.538909221807, 5996.130561068642, 6002.519798416138, 6227.470664993459, 6228.252609686821, 6232.781852635158, 4230.97884510577, 4459.509453960061, 6162.044883043135, 6177.598456100362, 6629.171353580802, 6866.519343645947, 6928.307169283082, 6940.993555934387, 6941.167059952812, 6963.338482844122, 6639.302873198317, 6896.965515172442, 6941.895871561931, 6942.548734332252, 6955.1653801544135, 5806.0, 6008.098785182214, 6032.095185722133, 6038.728257228435, 6055.757769689207, 27651.58522622162, 27735.722642773515, 27737.306567335778, 28030.299242518897, 28137.85931070352, 2271.193726227182, 2371.762823717632, 2393.664886915833, 2539.746025397464, 2766.363736340633, 15212.011219270822, 16706.081165535892, 16917.3233070677, 17347.392841250497, 17383.30466781327, 1896.0898768591017, 1946.4647222013919, 1957.2073310309206, 1983.345495986321, 2088.5300807318386, 119346.44087967617, 121231.99999999911, 125939.0, 126704.0, 127151.36424317912, 10941.56233750657, 11000.944995274973, 11467.31196128235, 11475.655730328104, 11614.709632259091, 14158.292085395895, 14281.071730337495, 14428.0, 14433.762766771168, 14442.566722998326, 8798.34012449056, 8949.507777072324, 9006.684766033157, 9047.592858321392, 9081.0, 9050.773730656787, 9074.410163339362, 9074.954625226832, 9076.48775927315, 9193.37988673225, 6990.475714321345, 6990.4757143214465, 6995.650217489105, 7000.404965577881, 7000.859982800417, 1845.8403667708812, 1891.2056936086876, 1894.4032629721594, 1895.781985071707, 1938.9224431022883, 884.478157886837, 889.2219308105408, 955.8422860228123, 1002.5087707023652, 1041.7760181561, 21836.781632183476, 22933.426664333525, 23448.765512345, 23833.642495362583, 23843.642345364835, 980.2109302011806, 1013.8884722680499, 1028.881678606955, 1036.362636978268, 1052.936823790575, 12175.0, 12370.257784532956, 12587.622371328875, 12666.873331266754, 12732.363381830872, 578031.0, 586430.067849658, 595734.0, 598676.0, 598682.0, 116635.41682291534, 128479.35760321326, 128780.0, 129031.35484322518, 129823.0, 1024.1499555369176, 1038.050184081572, 1047.423916845747, 1071.3357718214756, 1074.3661239868516, 20625.48436289105, 20716.124034881806, 20752.0, 20968.47578810542, 20970.790292097496, 36206.818965905004, 53776.84892604252, 53929.46070539401, 55196.62008449821, 55597.054103106195, 80539.19460805316, 80778.59610701908, 80809.0, 82246.4613566743, 83018.0, 8004.557470603871, 8390.748277551684, 8460.323174146177, 8474.406791524782, 8688.30493560501, 14030.158190508602, 14053.789193161907, 14209.50266740659, 14237.64405889861, 14299.57101286963, 6111.847203819762, 9509.857352139585, 11153.609623663457, 12119.939400302943, 12125.75748485043, 11582.015528680156, 11675.0, 11808.409579521162, 11984.10119241043, 12053.035757139583, 11338.489767960627, 11404.201705880509, 11665.183437159318, 11886.702832429259, 12159.878401216229, 8410.411271211202, 8421.95789021051, 8463.069062403007, 8609.569521523774, 8630.180132887366, 11822.645320640395, 11823.0, 11982.460789264329, 11995.160338776202, 12011.0], "value": 10266.312145417578, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1384.7161331926957, 1553.658195197057, 1581.699477099351, 1680.2522877319582, 1788.955276118097, 7697.923020769791, 8430.283425908798, 8679.69621063263, 8685.86971195431, 8773.078826723198, 8434.03008654005, 8546.316294696426, 8617.698380556682, 8625.698100566482, 8631.0, 2328.161861729776, 2352.0591763294647, 2360.6104992676273, 2362.1024010875844, 2362.492064206195, 2330.312557795446, 2345.0, 2370.158593699229, 2370.1941339944415, 2372.596658568039, 2321.2223904991847, 2350.2949115265437, 2353.8587684738973, 2358.1510656163855, 2359.4337359033793, 2301.7237931448335, 2325.093213646679, 2332.055517515409, 2334.7781960713705, 2342.0748804222235, 1946.63987162374, 2329.394357467054, 2330.7552706965694, 2336.0889253191267, 2336.205690065386, 8473.02560205578, 8663.0, 8668.826623467558, 8743.56282185888, 8753.255973242281, 4467.441569803775, 5076.314697515825, 5240.606954478391, 5248.895022099575, 5252.4222335543445, 3402.1834759657504, 3506.8947931562093, 3551.3430015447225, 3567.4292113261754, 3569.928601427983, 1071.7588542577935, 1093.4095588382263, 1096.6052221200441, 1117.212365282474, 1119.4290911635044, 11257.54969801207, 11361.943190284079, 11368.147388945863, 11368.545258189662, 11384.260023098472, 3580.874669386559, 4337.262665346899, 4553.7267763933605, 4557.202489564379, 4562.201614717411, 9008.909910900808, 9017.594208260643, 9031.45811251327, 9043.864342034874, 9054.86417703735, 4586.656000799953, 5028.5977121830165, 5202.73986300691, 5210.713410762369, 5211.478852114834, 4393.231184542692, 4526.79629416677, 4705.1765940960195, 4866.46468888422, 4894.021195760862, 3155.8106513608795, 3197.1847178969215, 3748.2503499299705, 3834.9424758628643, 3874.2251549690177, 1121.9551217951355, 1157.988420115805, 1160.477784996738, 1160.651804458659, 1173.20808454293, 580.9912851307233, 656.7208936202095, 814.2386868278061, 856.9785755356041, 978.574320170728, 5818.738156782955, 5882.794102206402, 6096.69516524172, 6106.877862442726, 6121.296050954108, 960.3853533738413, 967.9951600242094, 970.2335155227291, 976.9804603907882, 998.8401855703198, 3576.8911637392494, 4048.149888523443, 4121.402396652468, 4184.456020717287, 4188.643965262926, 9888.0, 10671.413072281099, 10673.412962286993, 10687.73280667974, 10726.249162558546, 10484.947575262227, 10610.57557697699, 10682.145428365711, 10692.679219623424, 10695.518701658444, 8189.303909167668, 8306.54314012735, 8310.70912518059, 8325.791855203548, 8328.8334233315, 5287.259783630372, 5746.741396637078, 5990.221271234712, 6046.818595442144, 6051.243594550681, 9695.321327507007, 9852.162566181954, 9992.850107248543, 10042.297039207186, 10122.038406351385, 9951.054649808257, 10180.949095254773, 10196.133328667147, 10277.640282590373, 10292.794144117226, 7036.788896333118, 7113.715451381887, 7184.6048467334795, 7193.640317983975, 7196.928030719626, 8108.837823243384, 8337.124601916712, 8347.207015333533, 8355.749327520183, 8374.162583741578, 7462.134466383404, 7517.511361761468, 7521.360684341892, 7526.887096693445, 7645.044369453818, 7277.199508054004, 7312.5246858954, 7377.77866664001, 7403.222661620668, 7442.404607631484, 6836.794896152925, 6931.237563868071, 7000.50996430245, 7004.3696067354185, 7030.824229394306, 4817.5182481752945, 5025.572826309804, 5067.721275329893, 5102.2346648003095, 5207.375114986075, 5003.899922001612, 5044.873878153076, 5076.619253555924, 5182.689038657692, 5211.062008838446], "value": 4505.34374581466, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.35598175885366, 309.3488207323584, 311.5451440896292, 315.29531497103983, 317.85696436603536, 4989.7754601043, 5430.0, 5439.292891924049, 5439.972800136004, 5457.699826509545, 4527.501974782779, 4721.285260974944, 5049.772760225789, 5239.380309845077, 5386.78452861885, 3518.8768393106247, 3619.954725580052, 3967.1867267210155, 4093.3859921011936, 4196.58034196581, 4088.4889388826396, 4129.421880936671, 4133.8966525836795, 4166.7708276044805, 4176.206520761061, 4093.6725061995116, 4101.487314085739, 4101.569335219804, 4126.8968275793195, 4137.834486620532, 3375.375555522236, 3789.886303410902, 3909.4135879618, 4114.876553703393, 4126.834926602933, 3576.7853928764357, 3587.121155316938, 3590.407582748843, 3593.3711600469815, 3596.604373518911, 5229.450907654679, 5241.842744717665, 5250.684958902478, 5264.710440925747, 5296.179092240709, 4504.414426124616, 4699.342092107107, 4715.575598196178, 4720.905581888377, 4730.337752714623, 5214.009338225725, 5371.301730774974, 5387.78448862045, 5606.831795046155, 5634.619518218063, 3586.8923932282073, 3982.780947047911, 3992.680585553149, 4009.799510024516, 4013.876114687892, 5237.345331833482, 5610.326760788732, 5905.114232865061, 5921.447131720933, 5932.050871860525, 3711.2763011213096, 3766.248694357137, 4009.0779120801794, 4050.41269015991, 4074.409210664437, 4106.829553577276, 4126.896827579335, 4130.318497447947, 4135.7518548887165, 4148.585141485827, 3364.2430453148336, 4547.794834368895, 4718.9292160617615, 4723.149833030087, 4726.361941137971, 5184.455632158644, 5491.75287112073, 5667.688277144714, 5681.204631351614, 5700.458456446631, 1142.5372724046774, 1194.9484453680705, 1274.5475356248583, 1361.6247589934237, 1373.8488766235705, 796.8167321516083, 818.3167055508717, 831.3972370031679, 835.8495470815311, 839.5046922315863, 4734.739589322551, 4939.259111133287, 5163.509466600667, 5333.733313334318, 5334.759935802898, 5757.971210143923, 5758.74085666146, 5769.567282453832, 5783.8554036149435, 5788.305403351625, 4415.66882483815, 4794.856154315376, 5300.966311569207, 5430.592705547021, 5507.889842203133, 2801.481725880678, 2818.1122946271857, 3011.3224524481816, 3016.3967206558777, 3038.0885734279627, 5841.50347220491, 5888.087346461305, 6002.819915402545, 6021.3677563856045, 6026.638401695912, 5699.834063056012, 5726.971365143231, 5930.094253815686, 5946.494547963385, 6023.45788879003, 6002.219711437398, 6029.939700602938, 6036.215292012011, 6089.969550152221, 6091.543134264859, 4855.854324370274, 5064.645474816874, 5420.918686219631, 5736.512396446349, 5763.7118144093465, 4993.500649934977, 5541.5289700375915, 5727.97136014334, 5729.799457018984, 5733.627314224562, 6024.608400453956, 6051.213342265477, 6064.332923378513, 6098.451139397475, 6110.327863934875, 3838.9040273992255, 4038.7980600969245, 4049.4128351388295, 4063.3701776224734, 4066.8983275417168, 5802.390748971297, 5823.621464604787, 5869.765209391748, 5871.2073870027, 5888.970555147368, 5448.291722076105, 5677.914831277451, 5692.544596432358, 5707.828765137053, 5744.684042377709, 4709.9529004710885, 4836.975815120902, 5143.4085080216255, 5588.720563971867, 5631.662859913254, 4511.774411279489, 5228.568715547289, 5462.91805622908, 5498.340199176125, 5536.425562113636, 4973.52751488608, 5096.51583099605, 5392.514673679388, 5578.665280083208, 5644.8306550803545, 4845.297431872288, 4926.4088309403105, 5208.24480450325, 5516.73115183502, 5525.640833345819], "value": 4137.848141772126, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [694.3958755882383, 771.3906014248744, 812.2243257688906, 813.3899575318508, 817.9631916563754, 13801.0, 15325.846741532581, 16571.917140414313, 16620.66758664826, 16627.83372166278, 15061.548153555412, 15217.163056031914, 15318.540443786676, 15318.540443786704, 15349.462768803067, 708.2775568919699, 718.9460790440712, 730.1420830524113, 918.3112665500875, 921.2031592672324, 898.9280857531414, 911.7720569857536, 914.8078903430288, 916.2120576304372, 916.5142474488498, 817.1787353709514, 970.1559643110504, 971.121135372489, 971.4414211828192, 972.9562169702381, 760.4334770595914, 943.2501161576495, 969.7963427680196, 971.3637567393368, 971.8930917599058, 717.5909731453074, 718.3391280022392, 718.5473151914313, 718.622723070387, 720.3049057659332, 15266.313015914311, 15268.16025118618, 15333.616659583487, 15343.693126137527, 15348.539543813704, 14325.283735813167, 14445.927770361186, 14486.20325882076, 14539.636509087251, 14656.41374345025, 13168.539101131415, 13258.40337184829, 13287.269200193985, 13321.800172997317, 13689.110207836458, 4564.1556312082375, 4702.670813043088, 4726.456457507396, 4793.952060479385, 4849.078675051729, 114526.85473145245, 114657.42671286674, 114873.42563287214, 115022.0, 115430.26854597103, 11363.715907102223, 11645.12661550387, 11646.301221926711, 11760.823587646191, 11880.76238475243, 22884.885575572014, 23131.0, 23132.7686723134, 23156.76843231546, 23167.0, 7704.191059938737, 8226.42415030954, 8372.120927302667, 8403.41176117666, 8413.831723365498, 4462.152191083684, 4517.887052823706, 4588.242939914943, 4698.271767875985, 4740.0, 3512.7189824813954, 3630.745847790682, 3633.0372451300427, 3635.2184280379847, 3654.543182102237, 608.1030480041903, 621.0963048764038, 630.1178350309511, 631.4474834519796, 634.0995785983914, 550.6613432738836, 570.7945139749687, 609.6829648582712, 615.8029430582171, 678.5385937562406, 8641.524716140673, 8776.561171941377, 9106.31702622306, 9207.815843683089, 9249.445033298023, 559.720139930035, 591.249113625693, 599.7810799058312, 620.6369273974685, 640.2029473305764, 3757.9248415032093, 4406.237504998026, 4549.909001820011, 4566.1552612766745, 4610.976945115253, 136080.0, 151006.0, 152611.0, 152823.0, 153712.0, 127195.0, 127691.0, 128817.0, 130080.0, 131368.3431582855, 75487.62256188794, 103566.48216758868, 112014.43992779985, 115208.0, 117432.41283793526, 8551.444156129832, 8572.785680358042, 8708.346873984603, 8719.52042637661, 8787.0, 61015.69492152511, 62653.0, 64068.3593164081, 64125.3587464138, 66280.0, 46009.539904600526, 60264.09603855858, 65006.34993650003, 65257.69484610186, 90571.5471422665, 11790.23363481371, 11799.587014454797, 11850.407479626158, 12120.393980300772, 12365.938170309091, 11977.880221197676, 12037.759244814879, 12055.35459989945, 12118.697032574257, 12443.37783110859, 11655.125865559947, 11818.645440636794, 11982.281063136239, 12046.75906481883, 12201.938990304992, 11575.305481671126, 11795.056395488513, 11893.0, 12207.694807629525, 12237.143399962273, 11657.242279251821, 11839.822402663794, 12138.393080345772, 12152.75694486123, 12208.0, 10038.397696138256, 10118.696439106838, 10167.898321016695, 10216.233782466195, 10470.267081304235, 9379.202767764817, 9577.664781732607, 10097.5456104474, 10129.544170512492, 10141.594336226468], "value": 7704.472281801167, "unit": "score"}], "name": "dromaeo_css", "value": 7378.215906333525, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 111.0, 119.0, 164.0, 161.0, 109.0, 110.0, 110.0, 110.0, 110.0], "value": 120.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 108.0, 105.0, 157.0, 110.0, 103.0, 126.0, 106.0, 139.0, 104.0], "value": 119.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 182.0, 185.0, 183.0, 179.0, 181.0, 179.0, 183.0, 182.0, 182.0], "value": 181.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 74.0, 58.0, 106.0, 58.0, 57.0, 59.0, 60.0, 126.0, 57.0], "value": 73.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 87.0, 92.0, 69.0, 79.0, 68.0, 95.0, 71.0, 68.0, 108.0], "value": 81.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 89.0, 86.0, 87.0, 85.0, 89.0, 86.0, 88.0, 85.0], "value": 87.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 104.0, 150.0, 123.0, 95.0], "value": 104.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 85.0, 84.0, 87.0, 101.0, 139.0, 83.0, 84.0, 84.0], "value": 91.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 54.0, 54.0, 54.0, 54.0, 55.0, 54.0, 56.0, 86.0], "value": 57.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 76.0, 78.0, 72.0, 73.0, 71.0, 71.0, 72.0, 73.0], "value": 71.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 82.0, 84.0, 82.0, 81.0, 81.0, 85.0, 84.0, 83.0, 86.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 134.0, 134.0, 134.0, 151.0, 153.0, 141.0, 137.0, 185.0, 141.0], "value": 144.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 168.0, 162.0, 162.0, 162.0, 163.0, 163.0, 156.0, 162.0, 162.0], "value": 162.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 75.0, 81.0, 85.0, 71.0, 66.0, 65.0, 66.0, 66.0, 66.0], "value": 70.8, "unit": "score"}], "name": "kraken", "value": 1449.2, "alertThreshold": 2.0}]} 03:24:22 INFO - Return code: 0 03:24:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:24:22 INFO - # TBPL SUCCESS # 03:24:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:24:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:24:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:24:22 INFO - 2016-07-13 03:24:22.923 screenresolution[1659:9874] starting screenresolution argv=screenresolution get 03:24:22 INFO - 2016-07-13 03:24:22.925 screenresolution[1659:9874] Display 0: 1600x1200x32@60 03:24:22 INFO - 2016-07-13 03:24:22.931 screenresolution[1660:9877] starting screenresolution argv=screenresolution list 03:24:22 INFO - Available Modes on Display 0 03:24:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:24:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:24:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:24:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:24:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:24:23 INFO - Intel Iris: 03:24:23 INFO - Chipset Model: Intel Iris 03:24:23 INFO - Type: GPU 03:24:23 INFO - Bus: Built-In 03:24:23 INFO - VRAM (Dynamic, Max): 1536 MB 03:24:23 INFO - Vendor: Intel (0x8086) 03:24:23 INFO - Device ID: 0x0a2e 03:24:23 INFO - Revision ID: 0x0009 03:24:23 INFO - Displays: 03:24:23 INFO - Display: 03:24:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:24:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:24:23 INFO - Display Serial Number: 1600x1200 60 03:24:23 INFO - Main Display: Yes 03:24:23 INFO - Mirror: Off 03:24:23 INFO - Online: Yes 03:24:23 INFO - Rotation: Supported 03:24:23 INFO - Return code: 0 03:24:23 INFO - Running post-action listener: _resource_record_post_action 03:24:23 INFO - ##### 03:24:23 INFO - ##### Finished run-tests step (success) 03:24:23 INFO - ##### 03:24:23 INFO - Running post-run listener: _resource_record_post_run 03:24:23 INFO - Total resource usage - Wall time: 1211s; CPU: 53.0%; Read bytes: 37029376; Write bytes: 705086464; Read time: 239; Write time: 1920 03:24:23 INFO - TinderboxPrint: CPU usage
53.2% 03:24:23 INFO - TinderboxPrint: I/O read bytes / time
37,029,376 / 239 03:24:23 INFO - TinderboxPrint: I/O write bytes / time
705,086,464 / 1,920 03:24:23 INFO - TinderboxPrint: CPU idle
2,265.4 (46.8%) 03:24:23 INFO - TinderboxPrint: CPU system
962.2 (19.9%) 03:24:23 INFO - TinderboxPrint: CPU user
1,618.0 (33.4%) 03:24:23 INFO - TinderboxPrint: Swap in / out
443,826,176 / 0 03:24:23 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 407888384; Write bytes: 409781760; Read time: 31023; Write time: 833 03:24:23 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 34407936; Write bytes: 293867008; Read time: 215; Write time: 1079 03:24:23 INFO - Running post-run listener: _upload_blobber_files 03:24:23 INFO - Blob upload gear active. 03:24:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:24:23 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 03:24:23 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'] 03:24:23 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 03:24:24 INFO - (blobuploader) - INFO - Open directory for files ... 03:24:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:24:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:24:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:24:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:24:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:24:25 INFO - (blobuploader) - INFO - Done attempting. 03:24:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:24:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:24:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:24:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:24:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:24:25 INFO - (blobuploader) - INFO - Done attempting. 03:24:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:24:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:24:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:24:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:24:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:24:28 INFO - (blobuploader) - INFO - Done attempting. 03:24:28 INFO - (blobuploader) - INFO - Iteration through files over. 03:24:28 INFO - Return code: 0 03:24:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:24:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:24:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/801d7ba93151482e9c047f5f84727c374a72740c105227d4761a0fe853d86c24a61e2ba3643ae0abc0694021a04edae23eb79d2d30cdddea9f069ad30cda2dca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a2bc267f33b2c42d5064895207f905dfe85ecb57455ff74dba36da4a30d82043d3a87bc5e1c7c65deaaa40db3d83b762db83c8281d3e244f879e0ffc73c18c7b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/27f7cf3bb23d5c5bac8a9edba81485de96e677915d4940aece317d33575be8562c0d020d8ebe72196b93f268e36d95061ef5433cd1fa1612883325f250b793c7"} 03:24:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:24:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:24:28 INFO - Contents: 03:24:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/801d7ba93151482e9c047f5f84727c374a72740c105227d4761a0fe853d86c24a61e2ba3643ae0abc0694021a04edae23eb79d2d30cdddea9f069ad30cda2dca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a2bc267f33b2c42d5064895207f905dfe85ecb57455ff74dba36da4a30d82043d3a87bc5e1c7c65deaaa40db3d83b762db83c8281d3e244f879e0ffc73c18c7b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/27f7cf3bb23d5c5bac8a9edba81485de96e677915d4940aece317d33575be8562c0d020d8ebe72196b93f268e36d95061ef5433cd1fa1612883325f250b793c7"} 03:24:28 INFO - Running post-run listener: copy_logs_to_upload_dir 03:24:28 INFO - Copying logs to upload dir... 03:24:28 INFO - mkdir: /builds/slave/test/build/upload/logs 03:24:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.575884 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-07-13 03:24:28.305336) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 03:24:28.309188) ========= 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.pOPZrHlnlN/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.K6829h2fJM/Listeners TMPDIR=/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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/801d7ba93151482e9c047f5f84727c374a72740c105227d4761a0fe853d86c24a61e2ba3643ae0abc0694021a04edae23eb79d2d30cdddea9f069ad30cda2dca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a2bc267f33b2c42d5064895207f905dfe85ecb57455ff74dba36da4a30d82043d3a87bc5e1c7c65deaaa40db3d83b762db83c8281d3e244f879e0ffc73c18c7b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/27f7cf3bb23d5c5bac8a9edba81485de96e677915d4940aece317d33575be8562c0d020d8ebe72196b93f268e36d95061ef5433cd1fa1612883325f250b793c7"} build_url:https://queue.taskcluster.net/v1/task/eVSHIxfpSFaORQLGScN6yg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010093 build_url: 'https://queue.taskcluster.net/v1/task/eVSHIxfpSFaORQLGScN6yg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/801d7ba93151482e9c047f5f84727c374a72740c105227d4761a0fe853d86c24a61e2ba3643ae0abc0694021a04edae23eb79d2d30cdddea9f069ad30cda2dca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a2bc267f33b2c42d5064895207f905dfe85ecb57455ff74dba36da4a30d82043d3a87bc5e1c7c65deaaa40db3d83b762db83c8281d3e244f879e0ffc73c18c7b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/27f7cf3bb23d5c5bac8a9edba81485de96e677915d4940aece317d33575be8562c0d020d8ebe72196b93f268e36d95061ef5433cd1fa1612883325f250b793c7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 03:24:28.339794) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 03:24:28.340184) ========= 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.pOPZrHlnlN/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.K6829h2fJM/Listeners TMPDIR=/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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.004834 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 03:24:28.388812) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 03:24:28.389170) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 03:24:28.389534) ========= ========= Total master_lag: 0.17 =========