builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0061 starttime: 1461255159.4 results: success (0) buildid: 20160421072021 builduid: db4c775fd49a41908af68c84f0e47439 revision: be6f45632b33c2578b1daca6d09c9be0df142e96 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 09:12:39.398033) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 09:12:39.398750) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-04-21 09:12:39.399216) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-04-21 09:12:40.601698) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 09:12:40.601952) ========= 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.ncRsBKQ7nB/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.XVj3NI3NmH/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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-04-21 09:12:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 70.2M=0s 2016-04-21 09:12:40 (70.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.172831 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 09:12:40.812812) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 09:12:40.813082) ========= 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.ncRsBKQ7nB/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.XVj3NI3NmH/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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.019717 ========= master_lag: 0.25 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 09:12:41.083186) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-21 09:12:41.083499) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev be6f45632b33c2578b1daca6d09c9be0df142e96 --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 be6f45632b33c2578b1daca6d09c9be0df142e96 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ncRsBKQ7nB/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.XVj3NI3NmH/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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-04-21 09:12:41,153 truncating revision to first 12 chars 2016-04-21 09:12:41,153 Setting DEBUG logging. 2016-04-21 09:12:41,153 attempt 1/10 2016-04-21 09:12:41,153 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/be6f45632b33?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-21 09:12:42,182 unpacking tar archive at: fx-team-be6f45632b33/testing/mozharness/ program finished with exit code 0 elapsedTime=1.276598 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-21 09:12:42.402662) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 09:12:42.402952) ========= script_repo_revision: be6f45632b33c2578b1daca6d09c9be0df142e96 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 09:12:42.403325) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 09:12:42.403589) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 09:12:43.207551) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-04-21 09:12:43.207956) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.ncRsBKQ7nB/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.XVj3NI3NmH/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 09:12:43 INFO - MultiFileLogger online at 20160421 09:12:43 in /builds/slave/test 09:12:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 09:12:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:12:43 INFO - {'append_to_log': False, 09:12:43 INFO - 'base_work_dir': '/builds/slave/test', 09:12:43 INFO - 'blob_upload_branch': 'Fx-Team', 09:12:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:12:43 INFO - 'branch': 'Fx-Team', 09:12:43 INFO - 'buildbot_json_path': 'buildprops.json', 09:12:43 INFO - 'config_files': ('talos/mac_config.py',), 09:12:43 INFO - 'default_actions': ('clobber', 09:12:43 INFO - 'read-buildbot-config', 09:12:43 INFO - 'download-and-extract', 09:12:43 INFO - 'populate-webroot', 09:12:43 INFO - 'create-virtualenv', 09:12:43 INFO - 'install', 09:12:43 INFO - 'run-tests'), 09:12:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:12:43 INFO - 'download_minidump_stackwalk': True, 09:12:43 INFO - 'download_symbols': 'ondemand', 09:12:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:12:43 INFO - 'tooltool.py': '/tools/tooltool.py', 09:12:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:12:43 INFO - '/tools/misc-python/virtualenv.py')}, 09:12:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:12:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:12:43 INFO - 'installer_path': 'installer.exe', 09:12:43 INFO - 'log_level': 'info', 09:12:43 INFO - 'log_name': 'talos', 09:12:43 INFO - 'log_to_console': True, 09:12:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:12:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:12:43 INFO - 'opt_config_files': (), 09:12:43 INFO - 'pip_index': False, 09:12:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:12:43 INFO - 'cmd': ('bash', 09:12:43 INFO - '-c', 09:12:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:12:43 INFO - 'enabled': True, 09:12:43 INFO - 'halt_on_failure': False, 09:12:43 INFO - 'name': 'check_screen_resolution'},), 09:12:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:12:43 INFO - 'cmd': ('bash', 09:12:43 INFO - '-c', 09:12:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:12:43 INFO - 'enabled': True, 09:12:43 INFO - 'halt_on_failure': False, 09:12:43 INFO - 'name': 'check_screen_resolution'},), 09:12:43 INFO - 'run_cmd_checks_enabled': True, 09:12:43 INFO - 'sps_profile': False, 09:12:43 INFO - 'sps_profile_interval': 0, 09:12:43 INFO - 'suite': 'dromaeojs-e10s', 09:12:43 INFO - 'system_bits': '32', 09:12:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:12:43 INFO - 'title': 't-yosemite-r7-0061', 09:12:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:12:43 INFO - 'use_talos_json': True, 09:12:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:12:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:12:43 INFO - 'work_dir': 'build'} 09:12:43 INFO - ##### 09:12:43 INFO - ##### Running clobber step. 09:12:43 INFO - ##### 09:12:43 INFO - Running pre-action listener: _resource_record_pre_action 09:12:43 INFO - Running main action method: clobber 09:12:43 INFO - rmtree: /builds/slave/test/build 09:12:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:12:45 INFO - Running post-action listener: _resource_record_post_action 09:12:45 INFO - ##### 09:12:45 INFO - ##### Running read-buildbot-config step. 09:12:45 INFO - ##### 09:12:45 INFO - Running pre-action listener: _resource_record_pre_action 09:12:45 INFO - Running main action method: read_buildbot_config 09:12:45 INFO - Using buildbot properties: 09:12:45 INFO - { 09:12:45 INFO - "project": "", 09:12:45 INFO - "product": "firefox", 09:12:45 INFO - "script_repo_revision": "production", 09:12:45 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 09:12:45 INFO - "repository": "", 09:12:45 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 09:12:45 INFO - "buildid": "20160421072021", 09:12:45 INFO - "pgo_build": "False", 09:12:45 INFO - "basedir": "/builds/slave/test", 09:12:45 INFO - "buildnumber": 615, 09:12:45 INFO - "slavename": "t-yosemite-r7-0061", 09:12:45 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 09:12:45 INFO - "platform": "yosemite_r7", 09:12:45 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 09:12:45 INFO - "branch": "fx-team", 09:12:45 INFO - "repo_path": "integration/fx-team", 09:12:45 INFO - "revision": "be6f45632b33c2578b1daca6d09c9be0df142e96", 09:12:45 INFO - "stage_platform": "macosx64", 09:12:45 INFO - "builduid": "db4c775fd49a41908af68c84f0e47439", 09:12:45 INFO - "slavebuilddir": "test" 09:12:45 INFO - } 09:12:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/CZ_pmHCsTuu0lX7fjxuIsw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 09:12:45 INFO - Running post-action listener: _resource_record_post_action 09:12:45 INFO - ##### 09:12:45 INFO - ##### Running download-and-extract step. 09:12:45 INFO - ##### 09:12:45 INFO - Running pre-action listener: _resource_record_pre_action 09:12:45 INFO - Running main action method: download_and_extract 09:12:45 INFO - mkdir: /builds/slave/test/build/tests 09:12:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:12:45 INFO - https://queue.taskcluster.net/v1/task/CZ_pmHCsTuu0lX7fjxuIsw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 09:12:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZ_pmHCsTuu0lX7fjxuIsw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 09:12:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZ_pmHCsTuu0lX7fjxuIsw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 09:12:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZ_pmHCsTuu0lX7fjxuIsw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 09:12:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZ_pmHCsTuu0lX7fjxuIsw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 09:12:46 INFO - Downloaded 1199 bytes. 09:12:46 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 09:12:46 INFO - Using the following test package requirements: 09:12:46 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 09:12:46 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:12:46 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 09:12:46 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:12:46 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 09:12:46 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:12:46 INFO - u'jsshell-mac.zip'], 09:12:46 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:12:46 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 09:12:46 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 09:12:46 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:12:46 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 09:12:46 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:12:46 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 09:12:46 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:12:46 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 09:12:46 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:12:46 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 09:12:46 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:12: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')]} 09:12:46 INFO - https://queue.taskcluster.net/v1/task/CZ_pmHCsTuu0lX7fjxuIsw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:12:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZ_pmHCsTuu0lX7fjxuIsw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:12:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZ_pmHCsTuu0lX7fjxuIsw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:12:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZ_pmHCsTuu0lX7fjxuIsw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:12:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZ_pmHCsTuu0lX7fjxuIsw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:12:51 INFO - Downloaded 18099892 bytes. 09:12:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:12:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:12:54 INFO - Return code: 0 09:12:54 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 09:12:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:12:54 INFO - https://queue.taskcluster.net/v1/task/CZ_pmHCsTuu0lX7fjxuIsw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:12:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZ_pmHCsTuu0lX7fjxuIsw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:12:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZ_pmHCsTuu0lX7fjxuIsw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:12:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZ_pmHCsTuu0lX7fjxuIsw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:12:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZ_pmHCsTuu0lX7fjxuIsw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:12:56 INFO - Downloaded 18099892 bytes. 09:12:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:12:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:12:59 INFO - Return code: 0 09:12:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:12:59 INFO - https://queue.taskcluster.net/v1/task/CZ_pmHCsTuu0lX7fjxuIsw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:12:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZ_pmHCsTuu0lX7fjxuIsw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 09:12:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZ_pmHCsTuu0lX7fjxuIsw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 09:12:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZ_pmHCsTuu0lX7fjxuIsw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 09:12:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZ_pmHCsTuu0lX7fjxuIsw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:13:01 INFO - Downloaded 10845952 bytes. 09:13:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:13:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 09:13:01 INFO - Return code: 0 09:13:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:13:01 INFO - https://queue.taskcluster.net/v1/task/CZ_pmHCsTuu0lX7fjxuIsw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 09:13:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZ_pmHCsTuu0lX7fjxuIsw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 09:13:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZ_pmHCsTuu0lX7fjxuIsw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 09:13:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZ_pmHCsTuu0lX7fjxuIsw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 09:13:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZ_pmHCsTuu0lX7fjxuIsw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 09:13:06 INFO - Downloaded 109956921 bytes. 09:13:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CZ_pmHCsTuu0lX7fjxuIsw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 09:13:06 INFO - mkdir: /builds/slave/test/properties 09:13:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:13:06 INFO - Writing to file /builds/slave/test/properties/build_url 09:13:06 INFO - Contents: 09:13:06 INFO - build_url:https://queue.taskcluster.net/v1/task/CZ_pmHCsTuu0lX7fjxuIsw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 09:13:07 INFO - Running post-action listener: _resource_record_post_action 09:13:07 INFO - Running post-action listener: set_extra_try_arguments 09:13:07 INFO - ##### 09:13:07 INFO - ##### Running populate-webroot step. 09:13:07 INFO - ##### 09:13:07 INFO - Running pre-action listener: _resource_record_pre_action 09:13:07 INFO - Running main action method: populate_webroot 09:13:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:13:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:13:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:13:07 INFO - '--tppagecycles', 09:13:07 INFO - '7'], 09:13:07 INFO - 'tests': ['tsvgm']}}, 09:13:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:13:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:13:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:13:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:13:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:13:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:13:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:13:07 INFO - 'talos_options': ['--disable-e10s'], 09:13:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:13:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:13:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:13:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:13:07 INFO - 'talos_options': ['--disable-e10s'], 09:13:07 INFO - 'tests': ['damp', 'tps']}, 09:13:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:13:07 INFO - 'tests': ['damp', 'tps']}, 09:13:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:13:07 INFO - 'tests': ['dromaeo_dom']}, 09:13:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:13:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:13:07 INFO - 'tests': ['a11yr', 09:13:07 INFO - 'ts_paint', 09:13:07 INFO - 'tpaint', 09:13:07 INFO - 'sessionrestore', 09:13:07 INFO - 'sessionrestore_no_auto_restore', 09:13:07 INFO - 'tabpaint']}, 09:13:07 INFO - 'other-e10s': {'tests': ['a11yr', 09:13:07 INFO - 'ts_paint', 09:13:07 INFO - 'tpaint', 09:13:07 INFO - 'sessionrestore', 09:13:07 INFO - 'sessionrestore_no_auto_restore', 09:13:07 INFO - 'tabpaint']}, 09:13:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:13:07 INFO - 'ts_paint', 09:13:07 INFO - 'tpaint', 09:13:07 INFO - 'sessionrestore', 09:13:07 INFO - 'sessionrestore_no_auto_restore', 09:13:07 INFO - 'tabpaint']}, 09:13:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:13:07 INFO - 'ts_paint', 09:13:07 INFO - 'tpaint', 09:13:07 INFO - 'sessionrestore', 09:13:07 INFO - 'sessionrestore_no_auto_restore', 09:13:07 INFO - 'tabpaint']}, 09:13:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:13:07 INFO - 'tests': ['a11yr', 09:13:07 INFO - 'ts_paint', 09:13:07 INFO - 'tpaint', 09:13:07 INFO - 'sessionrestore', 09:13:07 INFO - 'sessionrestore_no_auto_restore', 09:13:07 INFO - 'tabpaint']}, 09:13:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:13:07 INFO - 'tests': ['a11yr', 09:13:07 INFO - 'ts_paint', 09:13:07 INFO - 'tpaint', 09:13:07 INFO - 'sessionrestore', 09:13:07 INFO - 'sessionrestore_no_auto_restore', 09:13:07 INFO - 'tabpaint']}, 09:13:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:13:07 INFO - 'tests': ['tsvgx', 09:13:07 INFO - 'tsvgr_opacity', 09:13:07 INFO - 'tart', 09:13:07 INFO - 'tscrollx', 09:13:07 INFO - 'cart']}, 09:13:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:13:07 INFO - 'tsvgr_opacity', 09:13:07 INFO - 'tart', 09:13:07 INFO - 'tscrollx', 09:13:07 INFO - 'cart']}, 09:13:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:13:07 INFO - 'talos_options': ['--disable-e10s'], 09:13:07 INFO - 'tests': ['tp5o']}, 09:13:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:13:07 INFO - 'tests': ['tp5o']}, 09:13:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:13:07 INFO - 'talos_options': ['--disable-e10s', 09:13:07 INFO - '--xperf_path', 09:13:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:13:07 INFO - 'tests': ['tp5n']}, 09:13:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:13:07 INFO - 'talos_options': ['--xperf_path', 09:13:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:13:07 INFO - 'tests': ['tp5n']}}, 09:13:07 INFO - 'talos.zip': {'path': '', 09:13:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:13:07 INFO - Running post-action listener: _resource_record_post_action 09:13:07 INFO - ##### 09:13:07 INFO - ##### Running create-virtualenv step. 09:13:07 INFO - ##### 09:13:07 INFO - Running pre-action listener: _resource_record_pre_action 09:13:07 INFO - Running main action method: create_virtualenv 09:13:07 INFO - Creating virtualenv /builds/slave/test/build/venv 09:13:07 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 09:13:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:13:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:13:07 INFO - Using real prefix '/tools/python27' 09:13:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:13:08 INFO - Installing distribute.............................................................................................................................................................................................done. 09:13:11 INFO - Installing pip.................done. 09:13:11 INFO - Return code: 0 09:13:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:13:11 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')]} 09:13:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:11 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')]} 09:13:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:11 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 0x1067e9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067f9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e385accf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106688e00>, '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 0x1064f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106683b20>, '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.ncRsBKQ7nB/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.XVj3NI3NmH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 09:13:11 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 09:13:11 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 09:13:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ncRsBKQ7nB/Render', 09:13:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:13:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:13:11 INFO - 'HOME': '/Users/cltbld', 09:13:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:13:11 INFO - 'LOGNAME': 'cltbld', 09:13:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:11 INFO - 'MOZ_NO_REMOTE': '1', 09:13:11 INFO - 'NO_EM_RESTART': '1', 09:13:11 INFO - 'PAGER': '/bin/cat', 09:13:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:13:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:11 INFO - 'PWD': '/builds/slave/test', 09:13:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:13:11 INFO - 'SHELL': '/bin/bash', 09:13:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XVj3NI3NmH/Listeners', 09:13:11 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 09:13:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:13:11 INFO - 'USER': 'cltbld', 09:13:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:13:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:13:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:11 INFO - 'XPC_FLAGS': '0x0', 09:13:11 INFO - 'XPC_SERVICE_NAME': '0', 09:13:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:13:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:11 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 09:13:11 INFO - Cleaning up... 09:13:11 INFO - Return code: 0 09:13:11 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:13:11 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')]} 09:13:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:11 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')]} 09:13:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1067e9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067f9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e385accf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106688e00>, '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 0x1064f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106683b20>, '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.ncRsBKQ7nB/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.XVj3NI3NmH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 09:13:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 09:13:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:13:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ncRsBKQ7nB/Render', 09:13:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:13:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:13:11 INFO - 'HOME': '/Users/cltbld', 09:13:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:13:11 INFO - 'LOGNAME': 'cltbld', 09:13:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:11 INFO - 'MOZ_NO_REMOTE': '1', 09:13:11 INFO - 'NO_EM_RESTART': '1', 09:13:11 INFO - 'PAGER': '/bin/cat', 09:13:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:13:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:11 INFO - 'PWD': '/builds/slave/test', 09:13:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:13:11 INFO - 'SHELL': '/bin/bash', 09:13:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XVj3NI3NmH/Listeners', 09:13:11 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 09:13:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:13:11 INFO - 'USER': 'cltbld', 09:13:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:13:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:13:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:11 INFO - 'XPC_FLAGS': '0x0', 09:13:11 INFO - 'XPC_SERVICE_NAME': '0', 09:13:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:13:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:11 INFO - Downloading/unpacking psutil>=0.7.1 09:13:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:13:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:13:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:13:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:13:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:13:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:13:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:13:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:13:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:13:14 INFO - Installing collected packages: psutil 09:13:14 INFO - Running setup.py install for psutil 09:13:14 INFO - building 'psutil._psutil_osx' extension 09:13:14 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 09:13:15 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 09:13:15 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 09:13:15 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 09:13:15 INFO - building 'psutil._psutil_posix' extension 09:13:15 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 09:13:15 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:13:15 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:13:15 INFO - ^ 09:13:15 INFO - 1 warning generated. 09:13:15 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 09:13:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:13:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:13:15 INFO - Successfully installed psutil 09:13:15 INFO - Cleaning up... 09:13:15 INFO - Return code: 0 09:13:15 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:13:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:13:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1067e9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067f9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e385accf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106688e00>, '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 0x1064f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106683b20>, '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.ncRsBKQ7nB/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.XVj3NI3NmH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 09:13:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:13:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:13:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ncRsBKQ7nB/Render', 09:13:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:13:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:13:15 INFO - 'HOME': '/Users/cltbld', 09:13:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:13:15 INFO - 'LOGNAME': 'cltbld', 09:13:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:15 INFO - 'MOZ_NO_REMOTE': '1', 09:13:15 INFO - 'NO_EM_RESTART': '1', 09:13:15 INFO - 'PAGER': '/bin/cat', 09:13:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:13:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:15 INFO - 'PWD': '/builds/slave/test', 09:13:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:13:15 INFO - 'SHELL': '/bin/bash', 09:13:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XVj3NI3NmH/Listeners', 09:13:15 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 09:13:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:13:15 INFO - 'USER': 'cltbld', 09:13:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:13:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:13:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:15 INFO - 'XPC_FLAGS': '0x0', 09:13:15 INFO - 'XPC_SERVICE_NAME': '0', 09:13:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:13:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:15 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:13:15 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 09:13:15 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 09:13:15 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 09:13:15 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 09:13:15 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 09:13:15 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 09:13:18 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:13:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:13:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:13:18 INFO - Installing collected packages: mozsystemmonitor 09:13:18 INFO - Running setup.py install for mozsystemmonitor 09:13:18 INFO - Successfully installed mozsystemmonitor 09:13:18 INFO - Cleaning up... 09:13:18 INFO - Return code: 0 09:13:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:13:18 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')]} 09:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:18 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')]} 09:13:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:18 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 0x1067e9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067f9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e385accf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106688e00>, '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 0x1064f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106683b20>, '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.ncRsBKQ7nB/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.XVj3NI3NmH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 09:13:18 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 09:13:18 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 09:13:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ncRsBKQ7nB/Render', 09:13:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:13:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:13:18 INFO - 'HOME': '/Users/cltbld', 09:13:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:13:18 INFO - 'LOGNAME': 'cltbld', 09:13:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:18 INFO - 'MOZ_NO_REMOTE': '1', 09:13:18 INFO - 'NO_EM_RESTART': '1', 09:13:18 INFO - 'PAGER': '/bin/cat', 09:13:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:13:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:18 INFO - 'PWD': '/builds/slave/test', 09:13:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:13:18 INFO - 'SHELL': '/bin/bash', 09:13:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XVj3NI3NmH/Listeners', 09:13:18 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 09:13:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:13:18 INFO - 'USER': 'cltbld', 09:13:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:13:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:13:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:18 INFO - 'XPC_FLAGS': '0x0', 09:13:18 INFO - 'XPC_SERVICE_NAME': '0', 09:13:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:13:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:18 INFO - Downloading/unpacking blobuploader==1.2.4 09:13:18 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 09:13:18 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 09:13:18 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 09:13:18 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 09:13:18 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 09:13:18 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 09:13:21 INFO - Downloading blobuploader-1.2.4.tar.gz 09:13:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:13:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:13:21 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 09:13:21 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 09:13:21 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 09:13:21 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 09:13:21 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 09:13:21 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 09:13:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:13:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:13:22 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 09:13:22 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 09:13:22 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 09:13:22 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 09:13:22 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 09:13:22 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 09:13:22 INFO - Downloading docopt-0.6.1.tar.gz 09:13:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:13:22 INFO - Installing collected packages: blobuploader, requests, docopt 09:13:22 INFO - Running setup.py install for blobuploader 09:13:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:13:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:13:22 INFO - Running setup.py install for requests 09:13:23 INFO - Running setup.py install for docopt 09:13:23 INFO - Successfully installed blobuploader requests docopt 09:13:23 INFO - Cleaning up... 09:13:23 INFO - Return code: 0 09:13:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:13: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')]} 09:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13: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')]} 09:13:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:23 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 0x1067e9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067f9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e385accf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106688e00>, '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 0x1064f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106683b20>, '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.ncRsBKQ7nB/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.XVj3NI3NmH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 09:13:23 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 09:13:23 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 09:13:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ncRsBKQ7nB/Render', 09:13:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:13:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:13:23 INFO - 'HOME': '/Users/cltbld', 09:13:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:13:23 INFO - 'LOGNAME': 'cltbld', 09:13:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:23 INFO - 'MOZ_NO_REMOTE': '1', 09:13:23 INFO - 'NO_EM_RESTART': '1', 09:13:23 INFO - 'PAGER': '/bin/cat', 09:13:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:13:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:23 INFO - 'PWD': '/builds/slave/test', 09:13:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:13:23 INFO - 'SHELL': '/bin/bash', 09:13:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XVj3NI3NmH/Listeners', 09:13:23 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 09:13:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:13:23 INFO - 'USER': 'cltbld', 09:13:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:13:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:13:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:23 INFO - 'XPC_FLAGS': '0x0', 09:13:23 INFO - 'XPC_SERVICE_NAME': '0', 09:13:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:13:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:13:23 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-GumKdO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:13:23 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-uRN3bf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:13:23 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-Q1rozw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:13:24 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-8Hucmd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:13:24 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-U6UjAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:13:24 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-1iJR8Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:13:24 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-iyC_uK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:13:24 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-U3TSyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:13:24 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-8VlmD3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:13:24 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-iHU8HJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:13:24 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-qi_c5J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:13:24 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-nfcXD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:13:24 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-o6xHJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:13:25 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-UTg9jC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:13:25 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-kmJVqM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:13:25 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-EqgYpo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:13:25 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-j7xcOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:13:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:13:25 INFO - Running setup.py install for manifestparser 09:13:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:13:25 INFO - Running setup.py install for mozcrash 09:13:25 INFO - Running setup.py install for mozdebug 09:13:25 INFO - Running setup.py install for mozdevice 09:13:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:13:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:13:26 INFO - Running setup.py install for mozfile 09:13:26 INFO - Running setup.py install for mozhttpd 09:13:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:13:26 INFO - Running setup.py install for mozinfo 09:13:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:13:26 INFO - Running setup.py install for mozInstall 09:13:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:13:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:13:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:13:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:13:26 INFO - Running setup.py install for mozleak 09:13:26 INFO - Running setup.py install for mozlog 09:13:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:13:26 INFO - Running setup.py install for moznetwork 09:13:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:13:27 INFO - Running setup.py install for mozprocess 09:13:27 INFO - Running setup.py install for mozprofile 09:13:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:13:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:13:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:13:27 INFO - Running setup.py install for mozrunner 09:13:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:13:27 INFO - Running setup.py install for mozscreenshot 09:13:27 INFO - Running setup.py install for moztest 09:13:27 INFO - Running setup.py install for mozversion 09:13:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:13:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:13:27 INFO - Cleaning up... 09:13:28 INFO - Return code: 0 09:13:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:13:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:13:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:28 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 0x1067e9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067f9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e385accf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106688e00>, '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 0x1064f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106683b20>, '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.ncRsBKQ7nB/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.XVj3NI3NmH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 09:13:28 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 09:13:28 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 09:13:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ncRsBKQ7nB/Render', 09:13:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:13:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:13:28 INFO - 'HOME': '/Users/cltbld', 09:13:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:13:28 INFO - 'LOGNAME': 'cltbld', 09:13:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:28 INFO - 'MOZ_NO_REMOTE': '1', 09:13:28 INFO - 'NO_EM_RESTART': '1', 09:13:28 INFO - 'PAGER': '/bin/cat', 09:13:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:13:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:28 INFO - 'PWD': '/builds/slave/test', 09:13:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:13:28 INFO - 'SHELL': '/bin/bash', 09:13:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XVj3NI3NmH/Listeners', 09:13:28 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 09:13:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:13:28 INFO - 'USER': 'cltbld', 09:13:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:13:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:13:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:28 INFO - 'XPC_FLAGS': '0x0', 09:13:28 INFO - 'XPC_SERVICE_NAME': '0', 09:13:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:13:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:13:28 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-2E8MWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:13:28 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)) 09:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:13:28 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-yhiLl6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:13:28 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)) 09:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:13:28 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-wzxSTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:13:28 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)) 09:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:13:28 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-7U354j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:13:28 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)) 09:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:13:28 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-VEuO1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:13:28 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)) 09:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:13:28 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-EEGcwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:13:28 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)) 09:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:13:28 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-ZDrqXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:13:29 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)) 09:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:13:29 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-bFt8Ke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:13:29 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)) 09:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:13:29 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-h27uRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:13:29 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)) 09:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:13:29 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-cE8rt1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:13:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:13:29 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-aR52w1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:13:29 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)) 09:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:13:29 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-x0XEgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:13:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:13:29 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-ymTMua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:13:29 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)) 09:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:13:29 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-6YDZMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:13:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:13:29 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-ORkGJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:13:29 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)) 09:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:13:29 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-DNCB_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:13:29 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)) 09:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:13:29 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-E7I_JH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:13:30 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)) 09:13:30 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)) 09:13:30 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)) 09:13:30 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)) 09:13:30 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)) 09:13:30 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)) 09:13:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:13:30 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 09:13:30 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 09:13:30 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 09:13:30 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 09:13:30 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 09:13:30 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 09:13:32 INFO - Downloading blessings-1.6.tar.gz 09:13:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:13:32 INFO - Installing collected packages: blessings 09:13:32 INFO - Running setup.py install for blessings 09:13:32 INFO - Successfully installed blessings 09:13:32 INFO - Cleaning up... 09:13:32 INFO - Return code: 0 09:13:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:13:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:13:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:13:33 INFO - Reading from file tmpfile_stdout 09:13:33 INFO - Current package versions: 09:13:33 INFO - blessings == 1.6 09:13:33 INFO - blobuploader == 1.2.4 09:13:33 INFO - docopt == 0.6.1 09:13:33 INFO - manifestparser == 1.1 09:13:33 INFO - mozInstall == 1.12 09:13:33 INFO - mozcrash == 0.17 09:13:33 INFO - mozdebug == 0.1 09:13:33 INFO - mozdevice == 0.48 09:13:33 INFO - mozfile == 1.2 09:13:33 INFO - mozhttpd == 0.7 09:13:33 INFO - mozinfo == 0.9 09:13:33 INFO - mozleak == 0.1 09:13:33 INFO - mozlog == 3.1 09:13:33 INFO - moznetwork == 0.27 09:13:33 INFO - mozprocess == 0.22 09:13:33 INFO - mozprofile == 0.28 09:13:33 INFO - mozrunner == 6.11 09:13:33 INFO - mozscreenshot == 0.1 09:13:33 INFO - mozsystemmonitor == 0.0 09:13:33 INFO - moztest == 0.7 09:13:33 INFO - mozversion == 1.4 09:13:33 INFO - psutil == 3.1.1 09:13:33 INFO - requests == 1.2.3 09:13:33 INFO - wsgiref == 0.1.2 09:13:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:13:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:13:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:33 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 0x1067e9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067f9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e385accf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106688e00>, '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 0x1064f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106683b20>, '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.ncRsBKQ7nB/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.XVj3NI3NmH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 09:13:33 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 09:13:33 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 09:13:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ncRsBKQ7nB/Render', 09:13:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:13:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:13:33 INFO - 'HOME': '/Users/cltbld', 09:13:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:13:33 INFO - 'LOGNAME': 'cltbld', 09:13:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:33 INFO - 'MOZ_NO_REMOTE': '1', 09:13:33 INFO - 'NO_EM_RESTART': '1', 09:13:33 INFO - 'PAGER': '/bin/cat', 09:13:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:13:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:33 INFO - 'PWD': '/builds/slave/test', 09:13:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:13:33 INFO - 'SHELL': '/bin/bash', 09:13:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XVj3NI3NmH/Listeners', 09:13:33 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 09:13:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:13:33 INFO - 'USER': 'cltbld', 09:13:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:13:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:13:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:33 INFO - 'XPC_FLAGS': '0x0', 09:13:33 INFO - 'XPC_SERVICE_NAME': '0', 09:13:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:13:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:33 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)) 09:13:33 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)) 09:13:33 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)) 09:13:33 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)) 09:13:33 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)) 09:13:33 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)) 09:13:33 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)) 09:13:33 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)) 09:13:33 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)) 09:13:33 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)) 09:13:33 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)) 09:13:33 INFO - Cleaning up... 09:13:33 INFO - Return code: 0 09:13:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:13:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:13:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:33 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 0x1067e9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067f9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e385accf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106688e00>, '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 0x1064f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106683b20>, '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.ncRsBKQ7nB/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.XVj3NI3NmH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 09:13:33 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 09:13:33 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 09:13:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ncRsBKQ7nB/Render', 09:13:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:13:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:13:33 INFO - 'HOME': '/Users/cltbld', 09:13:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:13:33 INFO - 'LOGNAME': 'cltbld', 09:13:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:33 INFO - 'MOZ_NO_REMOTE': '1', 09:13:33 INFO - 'NO_EM_RESTART': '1', 09:13:33 INFO - 'PAGER': '/bin/cat', 09:13:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:13:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:33 INFO - 'PWD': '/builds/slave/test', 09:13:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:13:33 INFO - 'SHELL': '/bin/bash', 09:13:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XVj3NI3NmH/Listeners', 09:13:33 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 09:13:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:13:33 INFO - 'USER': 'cltbld', 09:13:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:13:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:13:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:33 INFO - 'XPC_FLAGS': '0x0', 09:13:33 INFO - 'XPC_SERVICE_NAME': '0', 09:13:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:13:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:33 INFO - Downloading/unpacking jsonschema 09:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:13:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:13:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:13:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:13:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:13:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:13:35 INFO - Downloading/unpacking functools32 (from jsonschema) 09:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:13:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:13:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:13:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:13:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:13:36 INFO - Downloading functools32-3.2.3-2.tar.gz 09:13:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:13:36 INFO - warning: no files found matching '*.txt' 09:13:36 INFO - no previously-included directories found matching 'build' 09:13:36 INFO - no previously-included directories found matching 'dist' 09:13:36 INFO - no previously-included directories found matching '.git*' 09:13:36 INFO - Installing collected packages: jsonschema, functools32 09:13:36 INFO - Running setup.py install for functools32 09:13:36 INFO - warning: no files found matching '*.txt' 09:13:36 INFO - no previously-included directories found matching 'build' 09:13:36 INFO - no previously-included directories found matching 'dist' 09:13:36 INFO - no previously-included directories found matching '.git*' 09:13:36 INFO - Successfully installed jsonschema functools32 09:13:36 INFO - Cleaning up... 09:13:36 INFO - Return code: 0 09:13:36 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:13: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')]} 09:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13: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')]} 09:13:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1067e9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067f9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e385accf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106688e00>, '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 0x1064f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106683b20>, '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.ncRsBKQ7nB/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.XVj3NI3NmH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 09:13:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 09:13:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:13:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ncRsBKQ7nB/Render', 09:13:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:13:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:13:36 INFO - 'HOME': '/Users/cltbld', 09:13:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:13:36 INFO - 'LOGNAME': 'cltbld', 09:13:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:36 INFO - 'MOZ_NO_REMOTE': '1', 09:13:36 INFO - 'NO_EM_RESTART': '1', 09:13:36 INFO - 'PAGER': '/bin/cat', 09:13:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:13:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:36 INFO - 'PWD': '/builds/slave/test', 09:13:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:13:36 INFO - 'SHELL': '/bin/bash', 09:13:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XVj3NI3NmH/Listeners', 09:13:36 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 09:13:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:13:36 INFO - 'USER': 'cltbld', 09:13:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:13:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:13:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:36 INFO - 'XPC_FLAGS': '0x0', 09:13:36 INFO - 'XPC_SERVICE_NAME': '0', 09:13:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:13:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:36 INFO - Downloading/unpacking flake8 09:13:36 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 09:13:36 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 09:13:36 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 09:13:36 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 09:13:36 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 09:13:36 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 09:13:39 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:13:39 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:13:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:13:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:13:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:13:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:13:39 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:13:39 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:13:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:13:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:13:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:13:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:13:40 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:13:40 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 09:13:40 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 09:13:40 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 09:13:40 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 09:13:40 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 09:13:40 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 09:13:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:13:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:13:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:13:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:13:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:13:40 INFO - no previously-included directories found matching 'docs/_build' 09:13:40 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:13:40 INFO - Running setup.py install for pep8 09:13:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:13:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:13:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:13:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:13:40 INFO - no previously-included directories found matching 'docs/_build' 09:13:40 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:13:40 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:13:40 INFO - Cleaning up... 09:13:40 INFO - Return code: 0 09:13:40 INFO - Running post-action listener: _resource_record_post_action 09:13:40 INFO - Running post-action listener: _start_resource_monitoring 09:13:40 INFO - Starting resource monitoring. 09:13:41 INFO - ##### 09:13:41 INFO - ##### Running install step. 09:13:41 INFO - ##### 09:13:41 INFO - Running pre-action listener: _resource_record_pre_action 09:13:41 INFO - Running main action method: install 09:13:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:13:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:13:41 INFO - Reading from file tmpfile_stdout 09:13:41 INFO - Detecting whether we're running mozinstall >=1.0... 09:13:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:13:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:13:41 INFO - Reading from file tmpfile_stdout 09:13:41 INFO - Output received: 09:13:41 INFO - Usage: mozinstall [options] installer 09:13:41 INFO - Options: 09:13:41 INFO - -h, --help show this help message and exit 09:13:41 INFO - -d DEST, --destination=DEST 09:13:41 INFO - Directory to install application into. [default: 09:13:41 INFO - "/builds/slave/test"] 09:13:41 INFO - --app=APP Application being installed. [default: firefox] 09:13:41 INFO - mkdir: /builds/slave/test/build/application 09:13:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:13:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 09:14:14 INFO - Reading from file tmpfile_stdout 09:14:14 INFO - Output received: 09:14:14 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:14:14 INFO - Running post-action listener: _resource_record_post_action 09:14:14 INFO - ##### 09:14:14 INFO - ##### Running run-tests step. 09:14:14 INFO - ##### 09:14:14 INFO - Running pre-action listener: _resource_record_pre_action 09:14:14 INFO - Running main action method: run_tests 09:14:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:14:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:14:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:14:14 INFO - 2016-04-21 09:14:14.577 screenresolution[1934:18728] starting screenresolution argv=screenresolution get 09:14:14 INFO - 2016-04-21 09:14:14.580 screenresolution[1934:18728] Display 0: 1600x1200x32@60 09:14:14 INFO - 2016-04-21 09:14:14.586 screenresolution[1935:18730] starting screenresolution argv=screenresolution list 09:14:14 INFO - Available Modes on Display 0 09:14:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:14:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:14:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:14:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:14:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:14:14 INFO - Intel Iris: 09:14:14 INFO - Chipset Model: Intel Iris 09:14:14 INFO - Type: GPU 09:14:14 INFO - Bus: Built-In 09:14:14 INFO - VRAM (Dynamic, Max): 1536 MB 09:14:14 INFO - Vendor: Intel (0x8086) 09:14:14 INFO - Device ID: 0x0a2e 09:14:14 INFO - Revision ID: 0x0009 09:14:14 INFO - Displays: 09:14:14 INFO - Display: 09:14:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:14:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:14:14 INFO - Display Serial Number: 1600x1200 60 09:14:14 INFO - Main Display: Yes 09:14:14 INFO - Mirror: Off 09:14:14 INFO - Online: Yes 09:14:14 INFO - Rotation: Supported 09:14:14 INFO - Return code: 0 09:14:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:14:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:14:14 INFO - Python 2.7.3 09:14:14 INFO - Return code: 0 09:14:14 INFO - grabbing minidump binary from tooltool 09:14:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:14:14 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106688e00>, '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 0x1064f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106683b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:14:14 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 09:14:14 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 09:14:14 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:14:14 INFO - Return code: 0 09:14:14 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:14:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:14:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:14:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:14:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:14:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:14:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:14:16 INFO - Return code: 0 09:14:16 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-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CZ_pmHCsTuu0lX7fjxuIsw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:14:16 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-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CZ_pmHCsTuu0lX7fjxuIsw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0061 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:14:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ncRsBKQ7nB/Render', 09:14:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:14:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:14:16 INFO - 'HOME': '/Users/cltbld', 09:14:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:14:16 INFO - 'LOGNAME': 'cltbld', 09:14:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:14:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:14:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:16 INFO - 'MOZ_NO_REMOTE': '1', 09:14:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:14:16 INFO - 'NO_EM_RESTART': '1', 09:14:16 INFO - 'PAGER': '/bin/cat', 09:14:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:14:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:16 INFO - 'PWD': '/builds/slave/test', 09:14:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:14:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:14:16 INFO - 'SHELL': '/bin/bash', 09:14:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XVj3NI3NmH/Listeners', 09:14:16 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 09:14:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:14:16 INFO - 'USER': 'cltbld', 09:14:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:14:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:14:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:16 INFO - 'XPC_FLAGS': '0x0', 09:14:16 INFO - 'XPC_SERVICE_NAME': '0', 09:14:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:14:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CZ_pmHCsTuu0lX7fjxuIsw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:14:16 INFO - mozversion application_buildid: 20160421072021 09:14:16 INFO - mozversion application_changeset: be6f45632b33c2578b1daca6d09c9be0df142e96 09:14:16 INFO - mozversion application_display_name: Nightly 09:14:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:14:16 INFO - mozversion application_name: Firefox 09:14:16 INFO - mozversion application_remotingname: firefox 09:14:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:14:16 INFO - mozversion application_vendor: Mozilla 09:14:16 INFO - mozversion application_version: 48.0a1 09:14:16 INFO - mozversion platform_buildid: 20160421072021 09:14:16 INFO - mozversion platform_changeset: be6f45632b33c2578b1daca6d09c9be0df142e96 09:14:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:14:16 INFO - mozversion platform_version: 48.0a1 09:14:16 INFO - using testdate: 1461255256 09:14:16 INFO - actual date: 1461255256 09:14:16 INFO - starting webserver on 'localhost:57310' 09:14:16 INFO - SUITE-START | Running 2 tests 09:14:16 INFO - TEST-START | dromaeo_css 09:14:16 INFO - operating with platform_type : mac_ 09:14:16 INFO - Initialising browser for dromaeo_css test... 09:14:16 INFO - TEST-INFO | started process 1953 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/tmpgPcuFq/profile http://localhost:57310/getInfo.html) 09:14:19 INFO - PROCESS | 1953 | __metrics Screen width/height:1600/1200 09:14:19 INFO - PROCESS | 1953 | colorDepth:24 09:14:19 INFO - PROCESS | 1953 | Browser inner width/height: 1024/689 09:14:19 INFO - PROCESS | 1953 | __metrics 09:14:19 ERROR - PROCESS | 1953 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 09:14:19 INFO - TEST-INFO | 1953: exit 0 09:14:19 INFO - Browser initialized. 09:14:19 INFO - Running cycle 1/1 for dromaeo_css test... 09:14:19 INFO - TEST-INFO | started process 1956 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/tmpgPcuFq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:14:31 INFO - PROCESS | 1956 | RSS: Main: 248381440 09:14:31 INFO - PROCESS | 1956 | 09:15:21 INFO - PROCESS | 1956 | 1461255321422 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] 09:17:32 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:57310/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57310/tests/dromaeo/cssquery-ext.html) 09:17:33 INFO - PROCESS | 1956 | RSS: Main: 260411392 09:17:33 INFO - PROCESS | 1956 | 09:20:35 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:57310/tests/dromaeo/cssquery-ext.html (next: http://localhost:57310/tests/dromaeo/cssquery-jquery.html) 09:20:36 INFO - PROCESS | 1956 | RSS: Main: 272039936 09:20:36 INFO - PROCESS | 1956 | 09:23:37 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:57310/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57310/tests/dromaeo/cssquery-mootools.html) 09:23:38 INFO - PROCESS | 1956 | RSS: Main: 274575360 09:23:38 INFO - PROCESS | 1956 | 09:26:40 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:57310/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57310/tests/dromaeo/cssquery-prototype.html) 09:26:40 INFO - PROCESS | 1956 | RSS: Main: 275804160 09:26:40 INFO - PROCESS | 1956 | 09:29:43 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:57310/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57310/tests/dromaeo/cssquery-yui.html) 09:29:44 INFO - PROCESS | 1956 | RSS: Main: 278646784 09:29:44 INFO - PROCESS | 1956 | 09:32:46 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:57310/tests/dromaeo/cssquery-yui.html (next: http://localhost:57310/tests/dromaeo/cssquery-dojo.html) 09:32:47 INFO - PROCESS | 1956 | RSS: Main: 279678976 09:32:47 INFO - PROCESS | 1956 | 09:32:47 INFO - PROCESS | 1956 | __start_tp_report 09:32:47 INFO - PROCESS | 1956 | _x_x_mozilla_page_load 09:32:47 INFO - PROCESS | 1956 | _x_x_mozilla_page_load_details 09:32:47 INFO - PROCESS | 1956 | |i|pagename|runs| 09:32:47 INFO - PROCESS | 1956 | |0;dojo.html;2892.855357232138;3476.3047390521892;3485.3900567400706;3540.4866294387316;3564.073340931359;4528.43394575678;5934.792282270121;5963.8515341504235;5970.044792833142;5971.880562388755;5794.739236734346;5863.325717542484;5906.734196961136;5987.221661184051;6031.6984150792505;4505.504394516601;5242.868928276795;5311.468853114677;5362.2224777407255;5363.980843639715;95.21475168746943;5218.947810521903;5314.415414304423;5315.521603055724;5317.548008419289;4692.929606055912;5263.6841789492755;5273.709945952971;5306.893862122755;5327.920081198766;4527.4114365132655;5353.250544923714;5353.973230133864;5355.357357117132;5397.109476936301;4356.411884395598;5215.687058776485;5286.709230992294;5307.230451584499;5362.544183744348;4883.974365383274;5682.090865461506;5773.624714393551;5789.739461724233;5802.448767367136;6146.600470969417;6209.96895015522;6230.065490176465;6239.65681887496;6267.185265915447;5153.896922061575;6227.750889964442;6262.091996660459;6271;6283.465905398001;5975.671338076404;6020.096985452217;6026;6027.350836273736;6070.484008859208;6254.21822272216;6345.841353966188;6418.293987661354;6458.192725909262;6472.708728107246;6077.088436734525;6146.416090471398;6226.875462490725;6251.218597675291;6253.280872699698;6238.376162383725;6250.937490625036;6268.49852011838;6293.087502312139;6302.4958003359625;6176.598521096114;6215.409536094064;6230.096635987847;6243.656598887105;6263.029230469285;5222.477752224823;6217.160683307696;6224.253089629274;6229.221347331583;6232.189815323979;4981.900361992813;5030.0191462664425;5032.094223039888;5033.421156566968;5059.215821547666;3738.3271011218244;3785.6592906638534;4351.673624478113;4429.424174857312;4534.387857639176;5820.621659592113;5891.911621325684;5927.644341339534;5942.6731529766275;6024.096385542116;6233.557366796096;6287.811365659038;6302.936970630327;6315.842103947438;6320.652364119926;5700.486956173964;5893.145493903446;5934.317553481319;5938.673372964528;5954.07711804671;5454.181872719124;5521.503064724194;5530.198121272473;5538.0585300499015;5577.024020796425;6381.7128229228865;6512.413882750575;6513.73945042193;6522.706478208492;6532;5295.311609490742;6186.288576813724;6231.22109736283;6302.936970630235;6310.558260921875;6467.223933128054;6480.805575832733;6514.511411644051;6524.3149469305035;6557.147570815954;6264.655443950626;6286.905696414466;6292.150559674568;6302.275238347465;6303.842403939938;5750.166225897305;5904.645721256738;6158.753649854135;6175;6255.218097737783;5180.818671346485;6058.4244496772735;6242.406971337716;6264.843378915563;6284.497240220863;5053.797848086036;5831.212786273968;5946.316173640087;6197.690115494117;6260.593061450991;5680.71596420169;6117.827404800828;6131.8467038322615;6193.566450348432;6213.347598502092;6172.722227499863;6215.782447614311;6219.533534984804;6224.872520963381;6251.187345645037;6033.668148251712;6066.707997520149;6085.847853803691;6133.738055536083;6134.2332208473945 09:32:47 INFO - PROCESS | 1956 | |1;ext.html;491.78361520930787;515.5385929593015;540.629668676956;540.745849450758;577.7169187098323;38439.846804595836;39214.62748803789;39252.21495570087;39370.99999999993;39422;34135.65864341356;41194.97012574687;41203;41314.58685413145;41503.754887353425;9310.48792316424;9482.905170948272;9533.666321678742;9571.52142392881;9587.472689002103;9456.810863782755;9681;9681.75795605112;9706.223502119814;9742.951285243564;9676.806463870718;9711.61153553857;9723.416595004323;9746.366486178411;9763.75590610237;7955;9157.038510956354;9578.712638620853;9657.034296570322;9732.318737688365;9597.184239339664;9605.807883842284;9717.222622190278;9740.123388895034;9747.171490423323;33165.83417082899;38676.61323386758;39044.219115617816;39086;39239.41140882889;2841.531147360683;3023.8639261233297;3180.6660300668327;3183.4747266700965;3410.5054767058887;21563.029663665016;23212.651810222862;25916.35209119768;27335.589966150525;27439.039633612927;2578.9226323210332;2628.264086055888;2641.8414895106357;2738.0416854101104;2836.7163283671675;309898.4505077483;349193;373150;374098;376544.99999999726;30200.54699179514;36025;36940.26119477595;60830.78338433206;61008;31405.685943140732;35427;35437.29125417477;35709.64290357115;35975.4603680945;15234.466793662168;15398.384064637514;15438.305276262596;15457;15518.224088795516;12935.870641293655;12985.415656295489;12995.805062924064;13053.869461305456;13062.804057939138;8046.758597242092;8088.595570221465;8124.796880078045;8197.426180167331;8207.384446166441;2996.520556710959;3371.578552680915;3393.7963722176746;3421.7433692473164;3435.158386195398;969.3844408800462;979.5249304087512;1056.2975621211808;1090.7000574841982;1129.2998341028451;30574.79984826386;30642.846785765927;30652.540211896838;30853.228669283;31084.844575776977;1112;1139.4929256480953;1181.4151994762476;1194.1342526668095;1240.5596013415288;14741.96806223554;15022.19052147722;15318.693626127415;15365.846341536442;15793.763093553605;339121;339280;339920;342846;344127;60888;61386;62325;62575.06137407943;62631.37368626255;1463.5170393770243;1503.8872084593481;1512.8033355663913;1533.73007948235;1535.385845661722;26536.86731566407;28966.855165724035;29141;29481.557776633796;29530.557041643962;46883.53116468792;54078;54172.729136354064;54218.728906355216;54403.18395223995;527489;532682;532897;536266;542328;27381.589276160474;27576.448471030868;28048.43903121967;28120.85939570371;28197.01310454124;46512.53487465082;46999.29501057555;47547.76226118847;48263.034739305716;48801;37868.810655947644;38480.615193847705;39112.022199445244;39700.404493933194;40180.79909600433;37845.43231851579;38544.03639909025;38602.42096368501;39019.46373485714;39369.60630393774;33249.833750831094;37702.811485942395;38209;39350.2129957405;39422.01444963784;30870.69129308678;32164;32430.35139297248;32550.83724581362;32565.837170813993;20894.582108357445;24117.879410602836;24412.389690257885;24431.26706198817;24992 09:32:47 INFO - PROCESS | 1956 | |2;jquery.html;326.7745255773517;395.1504265828468;398.62728348993693;407.4051884248996;415.56780947814275;18976.146073426695;20233;20291.08690108945;20939.37181884546;21047.47381315468;20844.374668759963;21022.36932892012;21278.57442851142;21321.36035918925;21577.892110539426;4198.391233271189;5331.680099194061;5887.14636377726;5991.041433370661;6011;5714.399988001242;6601.141851559315;6608.2070151581875;6611.206655201383;6616.536842421033;6277.340879207686;6492.123563318963;6503.804885853432;6526.543141980063;6576.539642225046;6416.871662566722;6436.839079023039;6505.804825855208;6524.543281970264;6544.214694236698;5515.806946756844;5679.4036626154075;5760.481556659921;5761.423857614247;5776;25834.74165258361;25854.612180817116;26476.940922363083;26499.205023849314;26638;1910.6274276516085;2131.605652954193;2197.5824593327375;2371.5019845832394;2385.8667133111635;9474.147326740627;9686.75783105421;9709.563069661883;9811.11699947001;9864.852027219598;1433.6989232261237;1722.5865792209904;1729.5848996240939;1793.390247315919;1807.4577626712066;100822;108684.4565777174;110213.42759010349;123111.76888231182;124587;11566.248193867372;11693.064554835593;11715.238509496856;11744.94127529357;11876.524939002344;14724.631884202981;14927;15042.172680502677;15050.397984080733;15080.245987700571;8905.465672059698;8937.01692813803;8937.46375217489;8947.418417802952;9015.368924175245;7855.489393189425;8834.690785822466;8851.64593416269;8888.466691998501;8894.688685895962;4146.564610715892;4338.652907767371;4578.839740609063;4681.95318046822;4778.897285194573;1723.732821412683;1962.3524237001754;2010.7788143304224;2018.656828339186;2027.432318950696;815.7960509872532;861.9569021548898;933.7198840347869;940.7271891151627;1001.8697569315942;20426.38720838377;20446.284380046625;20486.18055277802;20536.486587835425;20808.85551294663;954.9379290346105;973.4889183178888;982.3761911186448;988.5798535622332;1005.5927349423495;10893.074088702391;11007.559697612165;11086.611968581223;11102.167337449724;11116.388598627153;589043;591845;593965;603779;635342;136030.31984840013;136920;137962;140158;141250;997.3915911294105;1062.7661914378825;1078.379931539368;1081.5295346524445;1092.3996345353935;18207.635847283243;18281.908590456962;18486;18695.719564206818;19045.714314285575;52782.94434111373;53410.46589534055;53553.66115847135;53762.46237537731;54202;79961.60019199867;80147.59926200565;80762.12724749565;80909;81913.59043204747;5075.77159027852;5294.338207724035;7081.929180708127;7721.884171737541;8531.061583225965;10392.792144157225;12125.757484850077;12492;12619.810702839648;12710.936445317715;10921.617743378943;11002.614908478165;11084.057855082408;11106.278091924;11384.544618215179;10798.946005269923;10811.945940270249;10906.618268360886;11220.046296064926;11266;9860.802783944424;11146.219764616399;11474.541018359507;11474.77050459003;11509.654710358702;8019.799505012421;8159.061707903667;8240.13478584764;8252.669893204446;8258.710945117133;10151.187904967732;11127.72180695489;11144.275622084539;11179.496922638338;11422.086233101165 09:32:47 INFO - PROCESS | 1956 | |3;mootools.html;1606.0684802814365;1637.5824164837968;1902.885826850389;1974.9802501974984;2002.439316991243;7245.3841423479;8826;8986.41588296761;8991;8996.505192214425;7838.92161078389;8567.228949394554;8781.209691127797;8801.119888011195;8818.4708917465;2446.425090103824;2474.7030356357172;2477.8017758579363;2477.925662230127;2485.5526005319034;2427.2232885476656;2493.5137648158616;2495.226479791261;2495.25142457263;2496.8252222344445;2441.121196369306;2450.0689737899575;2475.9752402476015;2490.5018996200743;2499.1003238834005;2447.8898449569724;2454.1165180534995;2461.5569197544523;2470.530599186167;2478.6529885816;2411.44536756547;2429.259075981825;2464.0759715106833;2473.4558397152596;2488.1913378151994;7718.421118416141;8850.380473366868;8899.510526921016;8954.417962832395;8973.461592304482;4773.904521909577;5306.973465132688;5499.340079190482;5522.144067669477;5525.585581081435;3568.678818906311;3623.438367053111;3628.1836586767768;3690.132818787583;3712.443133529965;985.5170966226569;999.5202302894579;1006.2754816532085;1022.7903279827692;1037.3257382701304;10260.768707755116;11535.538578456852;11731.589394371242;11759.764804703858;11762.882371176263;4088.9386659200136;4235.364695295731;4368.148211098869;4528.139653465831;4949.406071271398;9634.373765705346;10029.899701002896;10057.245706572035;10075.2368335541;10089.09198172168;5345.4654534546235;5366.758495867695;5398.703071331114;5431.1853222016225;5440.7551660174595;4517.2772356423475;4828.275758636232;4934.605231581465;5023.974880125576;5029.622778291569;4042.2510553037546;4058;4109.404136400205;4122.2786012448305;4144.274751918402;1361.360160724458;1370.2532119994628;1375.3192169875977;1382.315753701924;1394.219237227156;755.2598453515585;854.918782715641;889.7241855024963;892.906244844295;944.1832814615308;5823.30120385548;5976.671283079472;6030.065339872327;6033;6059.030555111161;950.1353768071023;969.6315400147898;980.5097451274363;995.2933417273672;1017.0897047142765;3994.7403418777685;4117.21772863155;4143.3370660694145;4158.106007208465;4160.084781348099;10651.041406273473;10887.183461240438;10956.068734157527;11011.229213955106;11014.834777478345;10723.731906702395;10802.837957430487;10851.348919064882;10978.615748448767;11040.171987101;7947.9205207948335;8225.218604232588;8247.587620618946;8268.462549934235;8289.544075075928;4905.386826646669;5779.017567013534;5828.883422331614;5916.526677865846;5953.196318496947;9701.951490242503;9988;9991.300608957303;10033.648822291476;10131.290809643255;8330.875036874573;10065.597376104874;10225.74435639115;10340.638077667547;10356.948215258875;7524.247575242432;7596.96201519011;7603.315701586884;7604.087509498674;7687.192844751221;8275;8383.706570270011;8395.664173432995;8396.496210227406;8406.243438090602;7341.596212208166;7508.361789247975;7578.772636820904;7614.771556853303;7615.847683046419;7349.595772232578;7373.483856130019;7393.408527317909;7519.924800752141;7524.661390237562;7086.964565177141;7170.713171473083;7182.245864184186;7189.892151617834;7191.3887319578425;4857;4970.801167953386;5068.645194836474;5072.898542029213;5077.619178561697;3975.8072578226993;4749.643776716829;4986.177280748636;5001.699898006132;5012.598992080552 09:32:47 INFO - PROCESS | 1956 | |4;prototype.html;305.36636479305434;319.9696028877257;321.45513354863505;328.0584721848295;332.9550510681057;6249.281332646747;6311.905321420182;6316.115743795872;6335.5565110442285;6338.524610654196;6190.669006163674;6196.628202307865;6198.597091189081;6200.813975580729;6281.309056003847;3749.531308586427;4179.72831765935;4564.931526027096;4615.238485649864;4649.093426781779;3656.305301992613;4609.608183304406;4637.559431853985;4638.768061596924;4643.628509719231;4132.982922466601;4637.768111594423;4654.3251228571835;4658.138244424776;4681.9297710534365;4463.73217606943;4611.30830375443;4618.838340658078;4640.535946405333;4653.650976176767;3959.0102474381406;3959.762414255154;3978.661813745835;3984.980075099635;4013.5986401359633;5953.315368732565;5979.491743201833;5990.9515834728745;6034.728437220336;6052.727627256784;4988.501149884983;5145.588352931756;5154.252633368178;5450.618456708032;5450.8909821803345;5479.287692599976;5821.359650438449;6447.194100737408;6468;6502.154719886432;4200.936985945214;4399.900024993752;4406.4271644686305;4409.338599210144;4415.602595766396;5573.909783831064;6804.761833335859;6908.1364829396325;6911.755883940888;6988.825279368006;4001.3997900314603;4482.529334419904;4497.595216430537;4515.14212299662;4518.2319005769095;4473.776311184428;4603.930941035887;4609.953900460952;4617.284320930261;4623.491415944243;4265.360195970629;5346.300118440163;5396.3524377075;5402.91895621566;5412.323459567554;5233.084210263265;5823.88352232953;6561.967190164114;6575.934240657532;6596.769113081019;1403.1370707015112;1522.3301747231403;1557.0501993783782;1581.6045988502874;1582.3385445282408;916.9495677737655;973.3138137612966;1028.3572767020612;1037.7146284771597;1043.8277684182026;5904.339309628058;6057.394260573908;6060.272767267956;6090.756369745249;6095;5698.344690360662;5795.246617939725;6752.5273230874345;6773.593584384953;6839.110915581042;5785.537157027427;6065.878682426415;6108.3280839107665;6110.541709371815;6163.96918015407;3180.45932191528;3321.9003429897143;3547.077759782475;3571.0716213245078;3576.3741345264475;6254.312025677172;6742.898856517156;6752.797416077427;7077.539959902693;7082.4503178855575;5914.319853216849;6559.442447392025;6847.109875716224;6897.172339319213;6945.687444064928;5889.204957330706;6116.847078822976;6726.630035348005;7010.334018268256;7046.401055910203;5491.533219676372;6145.231846019247;6647.235567909559;6692.196936367667;6744.831379215559;6213.65824879636;6292.182016337847;6493.928501797151;6629.502787291069;6641.833954151185;6534.856400129863;6873.828154296182;7199.460040497089;7207.71169153249;7224.277572242734;4219.518896910123;4340.761258130833;4400.471943366689;4404.427424434803;4432.689711720149;5776.747068643316;6019.157317975574;6510.804675859732;6886.793396198122;6892.965535172492;5889.263842019747;6530.967345163243;6608.7026083825385;6659.2008958925235;6668.733250669919;5342.98483288174;5560;6067.695445479243;6146.846328841814;6486.254080780771;5596.664200148004;5987.520998320211;6141.508679305555;6472.093906852951;6513.576617519846;6107;6414.005829096497;6618.338166183343;6637.303083176197;6646.268910419753;5509.834704958857;6488.416042556192;6490.383413575702;6497.415232629086;6509.674516274262 09:32:47 INFO - PROCESS | 1956 | |5;yui.html;649.409037775624;671.9496037797165;675.5743881354746;752.8720117580009;764.8623247815391;12056.81914771278;14993.47522836701;15236.1620110894;15268.389264429423;15559.844401556009;14227.146371217734;14328.140311581312;14354.354054067566;14379.137251764902;14401.63995900103;750.6209364271062;920.4569304110573;931.8415869302218;951.4766878216988;957.530809903146;956.6651671914843;956.9186619137382;959.151151231162;962.4081190068127;967.0184762466102;1004.136442659316;1004.8040632076747;1006.8640733500957;1009.6516701737926;1011.8077565262577;998.4159266828914;999.6151481679606;1000.6247657128577;1000.9949950250275;1001.7595777013464;705.9258777828356;723.8298999735058;725.8149171961169;728.8250819803209;735.246372468219;14855.851441485664;14927.776083358649;14947.327370268364;15168;15222.46721364747;12662.240265584001;12697.619071427873;12713;12789.1687040343;13009.154404963647;9820.098886042832;9913.90086099137;10143.746406339827;10391.272610917238;10392.220583456272;3496.997879098664;3507.386207413718;3511.4587321555464;3613.963860361389;3647.361711700442;83815.58092209561;84016;84804;87885.68171477433;88234;9501.809963800824;9517.5717092731;9618.134367906921;9662.75843103914;9971.351862128939;21977.67033494499;22108.115675372806;22133.33599992003;22171.113155473602;22229.11083556672;6484.902726459107;7134.785956421316;7243;7456.664450099758;7578.772636820904;4178.791060446965;4191.455110835572;4204.453421055243;4289.871303860889;4308.849190278388;3578.1949061461482;3682.963170368316;3684.6499582539614;3686.2996030754607;3689.612590677994;566.8271177290966;641.8170821315903;664.2560332427712;672.4082807129695;677.5257319876107;545.0347335771122;598.9041753319448;603.1435361786274;615.5260449453896;622.4522420270224;6586.560301921412;8167.183281671904;8174.7956301092945;8293.502389856629;8392.370572206986;487.78293659321264;572.8567858035491;598.8892054969845;613.1140501974604;616.9198004259417;3852.6725228355344;3866.5940076292145;3938.350172221609;3954.18939117486;3972.245273398045;68304.65847670729;87949;88212.55893720618;88461.67307490393;89929;76231;77166;77384.61307693426;77809;79088.604556978;68415.65792171107;68929.65535172392;69516;70038.2996170042;70190.64904675545;7650.579218143055;7728.227177282227;7820.335271501986;7947.245011723877;7978.162292959156;39517.40723889202;40550.1889962205;45015.32477012913;45343.31985020162;45946.77026614846;45758.771206143756;59250.70374648099;59778.70110649419;63940;64223;9646.951765241129;9845.113939745457;9875.358101723365;10121.89878101239;10193.592256309961;10838.295510791773;10985.61550345734;11126.165537584875;11351.432428378714;11421.714457138638;10324.22568307365;10494.160467162455;10526.473676316307;10781.083607893102;10843.132549395872;8572.894510059865;10060.899391006289;10451.581936722447;10639.521221544894;10704.89295107039;10140.342661279568;10216.744581385525;10296.794064118825;10571.788564228826;10597;8610.225079742853;8634.136586341567;8657;8732.91267087321;8801.339899507691;8909.242714369351;8914.687985920462;9003.54982250898;9065.184133428023;9237 09:32:47 INFO - PROCESS | 1956 | __end_tp_report 09:32:47 INFO - PROCESS | 1956 | __start_cc_report 09:32:47 INFO - PROCESS | 1956 | _x_x_mozilla_cycle_collect,392 09:32:47 INFO - PROCESS | 1956 | __end_cc_report 09:32:47 INFO - PROCESS | 1956 | __startTimestamp1461256367052__endTimestamp 09:32:47 INFO - PROCESS | 1956 | 09:32:47 INFO - PROCESS | 1956 | ------- Summary: start ------- 09:32:47 INFO - PROCESS | 1956 | Number of tests: 6 09:32:47 INFO - PROCESS | 1956 | 09:32:47 INFO - PROCESS | 1956 | [#0] dojo.html Cycles:165 Average:5736.38 Median:6031.70 stddev:832.28 (13.8%) stddev-sans-first:804.39 09:32:47 INFO - PROCESS | 1956 | Values: 2892.9 3476.3 3485.4 3540.5 3564.1 4528.4 5934.8 5963.9 5970.0 5971.9 5794.7 5863.3 5906.7 5987.2 6031.7 4505.5 5242.9 5311.5 5362.2 5364.0 95.2 5218.9 5314.4 5315.5 5317.5 4692.9 5263.7 5273.7 5306.9 5327.9 4527.4 5353.3 5354.0 5355.4 5397.1 4356.4 5215.7 5286.7 5307.2 5362.5 4884.0 5682.1 5773.6 5789.7 5802.4 6146.6 6210.0 6230.1 6239.7 6267.2 5153.9 6227.8 6262.1 6271.0 6283.5 5975.7 6020.1 6026.0 6027.4 6070.5 6254.2 6345.8 6418.3 6458.2 6472.7 6077.1 6146.4 6226.9 6251.2 6253.3 6238.4 6250.9 6268.5 6293.1 6302.5 6176.6 6215.4 6230.1 6243.7 6263.0 5222.5 6217.2 6224.3 6229.2 6232.2 4981.9 5030.0 5032.1 5033.4 5059.2 3738.3 3785.7 4351.7 4429.4 4534.4 5820.6 5891.9 5927.6 5942.7 6024.1 6233.6 6287.8 6302.9 6315.8 6320.7 5700.5 5893.1 5934.3 5938.7 5954.1 5454.2 5521.5 5530.2 5538.1 5577.0 6381.7 6512.4 6513.7 6522.7 6532.0 5295.3 6186.3 6231.2 6302.9 6310.6 6467.2 6480.8 6514.5 6524.3 6557.1 6264.7 6286.9 6292.2 6302.3 6303.8 5750.2 5904.6 6158.8 6175.0 6255.2 5180.8 6058.4 6242.4 6264.8 6284.5 5053.8 5831.2 5946.3 6197.7 6260.6 5680.7 6117.8 6131.8 6193.6 6213.3 6172.7 6215.8 6219.5 6224.9 6251.2 6033.7 6066.7 6085.8 6133.7 6134.2 09:32:47 INFO - PROCESS | 1956 | 09:32:47 INFO - PROCESS | 1956 | [#1] ext.html Cycles:180 Average:55210.75 Median:205045.13 stddev:111767.70 (54.5%) stddev-sans-first:112005.73 09:32:47 INFO - PROCESS | 1956 | Values: 491.8 515.5 540.6 540.7 577.7 38439.8 39214.6 39252.2 39371.0 39422.0 34135.7 41195.0 41203.0 41314.6 41503.8 9310.5 9482.9 9533.7 9571.5 9587.5 9456.8 9681.0 9681.8 9706.2 9743.0 9676.8 9711.6 9723.4 9746.4 9763.8 7955.0 9157.0 9578.7 9657.0 9732.3 9597.2 9605.8 9717.2 9740.1 9747.2 33165.8 38676.6 39044.2 39086.0 39239.4 2841.5 3023.9 3180.7 3183.5 3410.5 21563.0 23212.7 25916.4 27335.6 27439.0 2578.9 2628.3 2641.8 2738.0 2836.7 309898.5 349193.0 373150.0 374098.0 376545.0 30200.5 36025.0 36940.3 60830.8 61008.0 31405.7 35427.0 35437.3 35709.6 35975.5 15234.5 15398.4 15438.3 15457.0 15518.2 12935.9 12985.4 12995.8 13053.9 13062.8 8046.8 8088.6 8124.8 8197.4 8207.4 2996.5 3371.6 3393.8 3421.7 3435.2 969.4 979.5 1056.3 1090.7 1129.3 30574.8 30642.8 30652.5 30853.2 31084.8 1112.0 1139.5 1181.4 1194.1 1240.6 14742.0 15022.2 15318.7 15365.8 15793.8 339121.0 339280.0 339920.0 342846.0 344127.0 60888.0 61386.0 62325.0 62575.1 62631.4 1463.5 1503.9 1512.8 1533.7 1535.4 26536.9 28966.9 29141.0 29481.6 29530.6 46883.5 54078.0 54172.7 54218.7 54403.2 527489.0 532682.0 532897.0 536266.0 542328.0 27381.6 27576.4 28048.4 28120.9 28197.0 46512.5 46999.3 47547.8 48263.0 48801.0 37868.8 38480.6 39112.0 39700.4 40180.8 37845.4 38544.0 38602.4 39019.5 39369.6 33249.8 37702.8 38209.0 39350.2 39422.0 30870.7 32164.0 32430.4 32550.8 32565.8 20894.6 24117.9 24412.4 24431.3 24992.0 09:32:47 INFO - PROCESS | 1956 | 09:32:47 INFO - PROCESS | 1956 | [#2] jquery.html Cycles:180 Average:35455.11 Median:25844.68 stddev:100826.71 (390.1%) stddev-sans-first:101075.06 09:32:47 INFO - PROCESS | 1956 | Values: 326.8 395.2 398.6 407.4 415.6 18976.1 20233.0 20291.1 20939.4 21047.5 20844.4 21022.4 21278.6 21321.4 21577.9 4198.4 5331.7 5887.1 5991.0 6011.0 5714.4 6601.1 6608.2 6611.2 6616.5 6277.3 6492.1 6503.8 6526.5 6576.5 6416.9 6436.8 6505.8 6524.5 6544.2 5515.8 5679.4 5760.5 5761.4 5776.0 25834.7 25854.6 26476.9 26499.2 26638.0 1910.6 2131.6 2197.6 2371.5 2385.9 9474.1 9686.8 9709.6 9811.1 9864.9 1433.7 1722.6 1729.6 1793.4 1807.5 100822.0 108684.5 110213.4 123111.8 124587.0 11566.2 11693.1 11715.2 11744.9 11876.5 14724.6 14927.0 15042.2 15050.4 15080.2 8905.5 8937.0 8937.5 8947.4 9015.4 7855.5 8834.7 8851.6 8888.5 8894.7 4146.6 4338.7 4578.8 4682.0 4778.9 1723.7 1962.4 2010.8 2018.7 2027.4 815.8 862.0 933.7 940.7 1001.9 20426.4 20446.3 20486.2 20536.5 20808.9 954.9 973.5 982.4 988.6 1005.6 10893.1 11007.6 11086.6 11102.2 11116.4 589043.0 591845.0 593965.0 603779.0 635342.0 136030.3 136920.0 137962.0 140158.0 141250.0 997.4 1062.8 1078.4 1081.5 1092.4 18207.6 18281.9 18486.0 18695.7 19045.7 52782.9 53410.5 53553.7 53762.5 54202.0 79961.6 80147.6 80762.1 80909.0 81913.6 5075.8 5294.3 7081.9 7721.9 8531.1 10392.8 12125.8 12492.0 12619.8 12710.9 10921.6 11002.6 11084.1 11106.3 11384.5 10798.9 10811.9 10906.6 11220.0 11266.0 9860.8 11146.2 11474.5 11474.8 11509.7 8019.8 8159.1 8240.1 8252.7 8258.7 10151.2 11127.7 11144.3 11179.5 11422.1 09:32:47 INFO - PROCESS | 1956 | 09:32:47 INFO - PROCESS | 1956 | [#3] mootools.html Cycles:180 Average:5745.78 Median:4942.01 stddev:3173.86 (64.2%) stddev-sans-first:3167.52 09:32:47 INFO - PROCESS | 1956 | Values: 1606.1 1637.6 1902.9 1975.0 2002.4 7245.4 8826.0 8986.4 8991.0 8996.5 7838.9 8567.2 8781.2 8801.1 8818.5 2446.4 2474.7 2477.8 2477.9 2485.6 2427.2 2493.5 2495.2 2495.3 2496.8 2441.1 2450.1 2476.0 2490.5 2499.1 2447.9 2454.1 2461.6 2470.5 2478.7 2411.4 2429.3 2464.1 2473.5 2488.2 7718.4 8850.4 8899.5 8954.4 8973.5 4773.9 5307.0 5499.3 5522.1 5525.6 3568.7 3623.4 3628.2 3690.1 3712.4 985.5 999.5 1006.3 1022.8 1037.3 10260.8 11535.5 11731.6 11759.8 11762.9 4088.9 4235.4 4368.1 4528.1 4949.4 9634.4 10029.9 10057.2 10075.2 10089.1 5345.5 5366.8 5398.7 5431.2 5440.8 4517.3 4828.3 4934.6 5024.0 5029.6 4042.3 4058.0 4109.4 4122.3 4144.3 1361.4 1370.3 1375.3 1382.3 1394.2 755.3 854.9 889.7 892.9 944.2 5823.3 5976.7 6030.1 6033.0 6059.0 950.1 969.6 980.5 995.3 1017.1 3994.7 4117.2 4143.3 4158.1 4160.1 10651.0 10887.2 10956.1 11011.2 11014.8 10723.7 10802.8 10851.3 10978.6 11040.2 7947.9 8225.2 8247.6 8268.5 8289.5 4905.4 5779.0 5828.9 5916.5 5953.2 9702.0 9988.0 9991.3 10033.6 10131.3 8330.9 10065.6 10225.7 10340.6 10356.9 7524.2 7597.0 7603.3 7604.1 7687.2 8275.0 8383.7 8395.7 8396.5 8406.2 7341.6 7508.4 7578.8 7614.8 7615.8 7349.6 7373.5 7393.4 7519.9 7524.7 7087.0 7170.7 7182.2 7189.9 7191.4 4857.0 4970.8 5068.6 5072.9 5077.6 3975.8 4749.6 4986.2 5001.7 5012.6 09:32:47 INFO - PROCESS | 1956 | 09:32:47 INFO - PROCESS | 1956 | [#4] prototype.html Cycles:180 Average:5271.29 Median:5933.82 stddev:1642.44 (27.7%) stddev-sans-first:1604.20 09:32:47 INFO - PROCESS | 1956 | Values: 305.4 320.0 321.5 328.1 333.0 6249.3 6311.9 6316.1 6335.6 6338.5 6190.7 6196.6 6198.6 6200.8 6281.3 3749.5 4179.7 4564.9 4615.2 4649.1 3656.3 4609.6 4637.6 4638.8 4643.6 4133.0 4637.8 4654.3 4658.1 4681.9 4463.7 4611.3 4618.8 4640.5 4653.7 3959.0 3959.8 3978.7 3985.0 4013.6 5953.3 5979.5 5991.0 6034.7 6052.7 4988.5 5145.6 5154.3 5450.6 5450.9 5479.3 5821.4 6447.2 6468.0 6502.2 4200.9 4399.9 4406.4 4409.3 4415.6 5573.9 6804.8 6908.1 6911.8 6988.8 4001.4 4482.5 4497.6 4515.1 4518.2 4473.8 4603.9 4610.0 4617.3 4623.5 4265.4 5346.3 5396.4 5402.9 5412.3 5233.1 5823.9 6562.0 6575.9 6596.8 1403.1 1522.3 1557.1 1581.6 1582.3 916.9 973.3 1028.4 1037.7 1043.8 5904.3 6057.4 6060.3 6090.8 6095.0 5698.3 5795.2 6752.5 6773.6 6839.1 5785.5 6065.9 6108.3 6110.5 6164.0 3180.5 3321.9 3547.1 3571.1 3576.4 6254.3 6742.9 6752.8 7077.5 7082.5 5914.3 6559.4 6847.1 6897.2 6945.7 5889.2 6116.8 6726.6 7010.3 7046.4 5491.5 6145.2 6647.2 6692.2 6744.8 6213.7 6292.2 6493.9 6629.5 6641.8 6534.9 6873.8 7199.5 7207.7 7224.3 4219.5 4340.8 4400.5 4404.4 4432.7 5776.7 6019.2 6510.8 6886.8 6893.0 5889.3 6531.0 6608.7 6659.2 6668.7 5343.0 5560.0 6067.7 6146.8 6486.3 5596.7 5987.5 6141.5 6472.1 6513.6 6107.0 6414.0 6618.3 6637.3 6646.3 5509.8 6488.4 6490.4 6497.4 6509.7 09:32:47 INFO - PROCESS | 1956 | 09:32:47 INFO - PROCESS | 1956 | [#5] yui.html Cycles:180 Average:17585.15 Median:601.02 stddev:24830.32 (4131.3%) stddev-sans-first:24867.41 09:32:47 INFO - PROCESS | 1956 | Values: 649.4 671.9 675.6 752.9 764.9 12056.8 14993.5 15236.2 15268.4 15559.8 14227.1 14328.1 14354.4 14379.1 14401.6 750.6 920.5 931.8 951.5 957.5 956.7 956.9 959.2 962.4 967.0 1004.1 1004.8 1006.9 1009.7 1011.8 998.4 999.6 1000.6 1001.0 1001.8 705.9 723.8 725.8 728.8 735.2 14855.9 14927.8 14947.3 15168.0 15222.5 12662.2 12697.6 12713.0 12789.2 13009.2 9820.1 9913.9 10143.7 10391.3 10392.2 3497.0 3507.4 3511.5 3614.0 3647.4 83815.6 84016.0 84804.0 87885.7 88234.0 9501.8 9517.6 9618.1 9662.8 9971.4 21977.7 22108.1 22133.3 22171.1 22229.1 6484.9 7134.8 7243.0 7456.7 7578.8 4178.8 4191.5 4204.5 4289.9 4308.8 3578.2 3683.0 3684.6 3686.3 3689.6 566.8 641.8 664.3 672.4 677.5 545.0 598.9 603.1 615.5 622.5 6586.6 8167.2 8174.8 8293.5 8392.4 487.8 572.9 598.9 613.1 616.9 3852.7 3866.6 3938.4 3954.2 3972.2 68304.7 87949.0 88212.6 88461.7 89929.0 76231.0 77166.0 77384.6 77809.0 79088.6 68415.7 68929.7 69516.0 70038.3 70190.6 7650.6 7728.2 7820.3 7947.2 7978.2 39517.4 40550.2 45015.3 45343.3 45946.8 45758.8 59250.7 59778.7 63940.0 64223.0 9647.0 9845.1 9875.4 10121.9 10193.6 10838.3 10985.6 11126.2 11351.4 11421.7 10324.2 10494.2 10526.5 10781.1 10843.1 8572.9 10060.9 10451.6 10639.5 10704.9 10140.3 10216.7 10296.8 10571.8 10597.0 8610.2 8634.1 8657.0 8732.9 8801.3 8909.2 8914.7 9003.5 9065.2 9237.0 09:32:47 INFO - PROCESS | 1956 | -------- Summary: end -------- 09:32:47 INFO - PROCESS | 1956 | 09:32:47 INFO - TEST-INFO | 1956: exit 0 09:32:47 INFO - TEST-OK | dromaeo_css | took 1111306ms 09:32:47 INFO - TEST-START | kraken 09:32:47 INFO - operating with platform_type : mac_ 09:32:47 INFO - Initialising browser for kraken test... 09:32:47 INFO - TEST-INFO | started process 1963 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/tmpmCF9z4/profile http://localhost:57310/getInfo.html) 09:32:50 INFO - PROCESS | 1963 | __metrics Screen width/height:1600/1200 09:32:50 INFO - PROCESS | 1963 | colorDepth:24 09:32:50 INFO - PROCESS | 1963 | Browser inner width/height: 1024/689 09:32:50 INFO - PROCESS | 1963 | __metrics 09:32:50 ERROR - PROCESS | 1963 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 09:32:51 INFO - TEST-INFO | 1963: exit 0 09:32:51 INFO - Browser initialized. 09:32:51 INFO - Running cycle 1/1 for kraken test... 09:32:51 INFO - TEST-INFO | started process 1966 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/tmpmCF9z4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:33:03 INFO - PROCESS | 1966 | RSS: Main: 247926784 09:33:03 INFO - PROCESS | 1966 | 09:33:05 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:57310/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57310/tests/kraken/driver.html?testName=audio-beat-detection) 09:33:06 INFO - PROCESS | 1966 | RSS: Main: 260038656 09:33:06 INFO - PROCESS | 1966 | 09:33:09 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:57310/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57310/tests/kraken/driver.html?testName=audio-dft) 09:33:09 INFO - PROCESS | 1966 | RSS: Main: 269266944 09:33:09 INFO - PROCESS | 1966 | 09:33:13 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:57310/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57310/tests/kraken/driver.html?testName=audio-fft) 09:33:14 INFO - PROCESS | 1966 | RSS: Main: 272035840 09:33:14 INFO - PROCESS | 1966 | 09:33:16 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:57310/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57310/tests/kraken/driver.html?testName=audio-oscillator) 09:33:16 INFO - PROCESS | 1966 | RSS: Main: 272867328 09:33:16 INFO - PROCESS | 1966 | 09:33:18 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:57310/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57310/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:33:19 INFO - PROCESS | 1966 | RSS: Main: 275202048 09:33:19 INFO - PROCESS | 1966 | 09:33:22 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:57310/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57310/tests/kraken/driver.html?testName=imaging-darkroom) 09:33:22 INFO - PROCESS | 1966 | RSS: Main: 275542016 09:33:22 INFO - PROCESS | 1966 | 09:33:25 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:57310/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57310/tests/kraken/driver.html?testName=imaging-desaturate) 09:33:26 INFO - PROCESS | 1966 | RSS: Main: 275730432 09:33:26 INFO - PROCESS | 1966 | 09:33:29 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:57310/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57310/tests/kraken/driver.html?testName=json-parse-financial) 09:33:30 INFO - PROCESS | 1966 | RSS: Main: 275824640 09:33:30 INFO - PROCESS | 1966 | 09:33:31 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:57310/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57310/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:33:32 INFO - PROCESS | 1966 | RSS: Main: 274968576 09:33:32 INFO - PROCESS | 1966 | 09:33:34 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:57310/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57310/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:33:34 INFO - PROCESS | 1966 | RSS: Main: 275206144 09:33:34 INFO - PROCESS | 1966 | 09:33:36 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:57310/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57310/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:33:37 INFO - PROCESS | 1966 | RSS: Main: 275345408 09:33:37 INFO - PROCESS | 1966 | 09:33:40 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:57310/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57310/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:33:41 INFO - PROCESS | 1966 | RSS: Main: 275451904 09:33:41 INFO - PROCESS | 1966 | 09:33:44 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:57310/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57310/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:33:44 INFO - PROCESS | 1966 | RSS: Main: 275390464 09:33:44 INFO - PROCESS | 1966 | 09:33:46 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:57310/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57310/tests/kraken/driver.html?testName=ai-astar) 09:33:46 INFO - PROCESS | 1966 | RSS: Main: 277057536 09:33:46 INFO - PROCESS | 1966 | 09:33:46 INFO - PROCESS | 1966 | __start_tp_report 09:33:46 INFO - PROCESS | 1966 | _x_x_mozilla_page_load 09:33:46 INFO - PROCESS | 1966 | _x_x_mozilla_page_load_details 09:33:46 INFO - PROCESS | 1966 | |i|pagename|runs| 09:33:46 INFO - PROCESS | 1966 | |0;ai-astar;118;109;117;117;118;129;116;118;151;117 09:33:46 INFO - PROCESS | 1966 | |1;audio-beat-detection;154;121;149;221;119;141;147;128;172;121 09:33:46 INFO - PROCESS | 1966 | |2;audio-dft;195;201;207;227;250;278;197;247;201;195 09:33:46 INFO - PROCESS | 1966 | |3;audio-fft;79;72;77;162;80;81;75;61;128;62 09:33:46 INFO - PROCESS | 1966 | |4;audio-oscillator;76;93;125;77;81;83;120;81;81;124 09:33:46 INFO - PROCESS | 1966 | |5;imaging-gaussian-blur;88;87;88;86;89;86;90;86;89;102 09:33:46 INFO - PROCESS | 1966 | |6;imaging-darkroom;120;131;149;108;94;94;107;148;93;94 09:33:46 INFO - PROCESS | 1966 | |7;imaging-desaturate;90;90;98;92;90;109;147;110;92;92 09:33:46 INFO - PROCESS | 1966 | |8;json-parse-financial;61;59;61;61;60;60;62;75;61;57 09:33:46 INFO - PROCESS | 1966 | |9;json-stringify-tinderbox;62;65;69;74;71;74;72;66;67;67 09:33:46 INFO - PROCESS | 1966 | |10;stanford-crypto-aes;96;104;83;83;109;84;83;83;83;85 09:33:46 INFO - PROCESS | 1966 | |11;stanford-crypto-ccm;139;140;136;138;141;137;139;170;177;168 09:33:46 INFO - PROCESS | 1966 | |12;stanford-crypto-pbkdf2;216;167;222;204;174;174;170;168;170;173 09:33:46 INFO - PROCESS | 1966 | |13;stanford-crypto-sha256-iterative;69;70;69;68;72;92;67;62;95;99 09:33:46 INFO - PROCESS | 1966 | __end_tp_report 09:33:46 INFO - PROCESS | 1966 | __start_cc_report 09:33:46 INFO - PROCESS | 1966 | _x_x_mozilla_cycle_collect,1035 09:33:46 INFO - PROCESS | 1966 | __end_cc_report 09:33:46 INFO - PROCESS | 1966 | __startTimestamp1461256426708__endTimestamp 09:33:46 INFO - PROCESS | 1966 | 09:33:46 INFO - PROCESS | 1966 | ------- Summary: start ------- 09:33:46 INFO - PROCESS | 1966 | Number of tests: 14 09:33:46 INFO - PROCESS | 1966 | 09:33:46 INFO - PROCESS | 1966 | [#0] ai-astar Cycles:10 Average:121.00 Median:118.00 stddev:11.59 (9.8%) stddev-sans-first:12.24 09:33:46 INFO - PROCESS | 1966 | Values: 118.0 109.0 117.0 117.0 118.0 129.0 116.0 118.0 151.0 117.0 09:33:46 INFO - PROCESS | 1966 | 09:33:46 INFO - PROCESS | 1966 | [#1] audio-beat-detection Cycles:10 Average:147.30 Median:148.00 stddev:31.07 (21.0%) stddev-sans-first:32.86 09:33:46 INFO - PROCESS | 1966 | Values: 154.0 121.0 149.0 221.0 119.0 141.0 147.0 128.0 172.0 121.0 09:33:46 INFO - PROCESS | 1966 | 09:33:46 INFO - PROCESS | 1966 | [#2] audio-dft Cycles:10 Average:219.80 Median:217.00 stddev:29.27 (13.5%) stddev-sans-first:29.64 09:33:46 INFO - PROCESS | 1966 | Values: 195.0 201.0 207.0 227.0 250.0 278.0 197.0 247.0 201.0 195.0 09:33:46 INFO - PROCESS | 1966 | 09:33:46 INFO - PROCESS | 1966 | [#3] audio-fft Cycles:10 Average:87.70 Median:76.00 stddev:32.01 (42.1%) stddev-sans-first:33.79 09:33:46 INFO - PROCESS | 1966 | Values: 79.0 72.0 77.0 162.0 80.0 81.0 75.0 61.0 128.0 62.0 09:33:46 INFO - PROCESS | 1966 | 09:33:46 INFO - PROCESS | 1966 | [#4] audio-oscillator Cycles:10 Average:94.10 Median:81.00 stddev:20.49 (25.3%) stddev-sans-first:20.66 09:33:46 INFO - PROCESS | 1966 | Values: 76.0 93.0 125.0 77.0 81.0 83.0 120.0 81.0 81.0 124.0 09:33:46 INFO - PROCESS | 1966 | 09:33:46 INFO - PROCESS | 1966 | [#5] imaging-gaussian-blur Cycles:10 Average:89.10 Median:88.00 stddev:4.75 (5.4%) stddev-sans-first:5.02 09:33:46 INFO - PROCESS | 1966 | Values: 88.0 87.0 88.0 86.0 89.0 86.0 90.0 86.0 89.0 102.0 09:33:46 INFO - PROCESS | 1966 | 09:33:46 INFO - PROCESS | 1966 | [#6] imaging-darkroom Cycles:10 Average:113.80 Median:121.00 stddev:22.19 (18.3%) stddev-sans-first:23.42 09:33:46 INFO - PROCESS | 1966 | Values: 120.0 131.0 149.0 108.0 94.0 94.0 107.0 148.0 93.0 94.0 09:33:46 INFO - PROCESS | 1966 | 09:33:46 INFO - PROCESS | 1966 | [#7] imaging-desaturate Cycles:10 Average:101.00 Median:91.00 stddev:17.88 (19.6%) stddev-sans-first:18.51 09:33:46 INFO - PROCESS | 1966 | Values: 90.0 90.0 98.0 92.0 90.0 109.0 147.0 110.0 92.0 92.0 09:33:46 INFO - PROCESS | 1966 | 09:33:46 INFO - PROCESS | 1966 | [#8] json-parse-financial Cycles:10 Average:61.70 Median:61.00 stddev:4.88 (8.0%) stddev-sans-first:5.17 09:33:46 INFO - PROCESS | 1966 | Values: 61.0 59.0 61.0 61.0 60.0 60.0 62.0 75.0 61.0 57.0 09:33:46 INFO - PROCESS | 1966 | 09:33:46 INFO - PROCESS | 1966 | [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:70.00 stddev:4.00 (5.7%) stddev-sans-first:3.43 09:33:46 INFO - PROCESS | 1966 | Values: 62.0 65.0 69.0 74.0 71.0 74.0 72.0 66.0 67.0 67.0 09:33:46 INFO - PROCESS | 1966 | 09:33:46 INFO - PROCESS | 1966 | [#10] stanford-crypto-aes Cycles:10 Average:89.30 Median:83.00 stddev:9.97 (12.0%) stddev-sans-first:10.27 09:33:46 INFO - PROCESS | 1966 | Values: 96.0 104.0 83.0 83.0 109.0 84.0 83.0 83.0 83.0 85.0 09:33:46 INFO - PROCESS | 1966 | 09:33:46 INFO - PROCESS | 1966 | [#11] stanford-crypto-ccm Cycles:10 Average:148.50 Median:140.50 stddev:16.20 (11.5%) stddev-sans-first:16.82 09:33:46 INFO - PROCESS | 1966 | Values: 139.0 140.0 136.0 138.0 141.0 137.0 139.0 170.0 177.0 168.0 09:33:46 INFO - PROCESS | 1966 | 09:33:46 INFO - PROCESS | 1966 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.80 Median:174.00 stddev:21.41 (12.3%) stddev-sans-first:19.28 09:33:46 INFO - PROCESS | 1966 | Values: 216.0 167.0 222.0 204.0 174.0 174.0 170.0 168.0 170.0 173.0 09:33:46 INFO - PROCESS | 1966 | 09:33:46 INFO - PROCESS | 1966 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.30 Median:71.00 stddev:13.48 (19.0%) stddev-sans-first:14.04 09:33:46 INFO - PROCESS | 1966 | Values: 69.0 70.0 69.0 68.0 72.0 92.0 67.0 62.0 95.0 99.0 09:33:46 INFO - PROCESS | 1966 | -------- Summary: end -------- 09:33:46 INFO - PROCESS | 1966 | 09:33:47 INFO - TEST-INFO | 1966: exit 0 09:33:47 INFO - TEST-OK | kraken | took 59877ms 09:33:47 INFO - SUITE-END | took 1171s 09:33:47 INFO - Completed test suite (00:19:31) 09:33:47 INFO - javascript benchmark 09:33:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2892.855357232138, 3476.3047390521892, 3485.3900567400706, 3540.4866294387316, 3564.073340931359, 4528.43394575678, 5934.792282270121, 5963.8515341504235, 5970.044792833142, 5971.880562388755, 5794.739236734346, 5863.325717542484, 5906.734196961136, 5987.221661184051, 6031.6984150792505, 4505.504394516601, 5242.868928276795, 5311.468853114677, 5362.2224777407255, 5363.980843639715, 95.21475168746943, 5218.947810521903, 5314.415414304423, 5315.521603055724, 5317.548008419289, 4692.929606055912, 5263.6841789492755, 5273.709945952971, 5306.893862122755, 5327.920081198766, 4527.4114365132655, 5353.250544923714, 5353.973230133864, 5355.357357117132, 5397.109476936301, 4356.411884395598, 5215.687058776485, 5286.709230992294, 5307.230451584499, 5362.544183744348, 4883.974365383274, 5682.090865461506, 5773.624714393551, 5789.739461724233, 5802.448767367136, 6146.600470969417, 6209.96895015522, 6230.065490176465, 6239.65681887496, 6267.185265915447, 5153.896922061575, 6227.750889964442, 6262.091996660459, 6271.0, 6283.465905398001, 5975.671338076404, 6020.096985452217, 6026.0, 6027.350836273736, 6070.484008859208, 6254.21822272216, 6345.841353966188, 6418.293987661354, 6458.192725909262, 6472.708728107246, 6077.088436734525, 6146.416090471398, 6226.875462490725, 6251.218597675291, 6253.280872699698, 6238.376162383725, 6250.937490625036, 6268.49852011838, 6293.087502312139, 6302.4958003359625, 6176.598521096114, 6215.409536094064, 6230.096635987847, 6243.656598887105, 6263.029230469285, 5222.477752224823, 6217.160683307696, 6224.253089629274, 6229.221347331583, 6232.189815323979, 4981.900361992813, 5030.0191462664425, 5032.094223039888, 5033.421156566968, 5059.215821547666, 3738.3271011218244, 3785.6592906638534, 4351.673624478113, 4429.424174857312, 4534.387857639176, 5820.621659592113, 5891.911621325684, 5927.644341339534, 5942.6731529766275, 6024.096385542116, 6233.557366796096, 6287.811365659038, 6302.936970630327, 6315.842103947438, 6320.652364119926, 5700.486956173964, 5893.145493903446, 5934.317553481319, 5938.673372964528, 5954.07711804671, 5454.181872719124, 5521.503064724194, 5530.198121272473, 5538.0585300499015, 5577.024020796425, 6381.7128229228865, 6512.413882750575, 6513.73945042193, 6522.706478208492, 6532.0, 5295.311609490742, 6186.288576813724, 6231.22109736283, 6302.936970630235, 6310.558260921875, 6467.223933128054, 6480.805575832733, 6514.511411644051, 6524.3149469305035, 6557.147570815954, 6264.655443950626, 6286.905696414466, 6292.150559674568, 6302.275238347465, 6303.842403939938, 5750.166225897305, 5904.645721256738, 6158.753649854135, 6175.0, 6255.218097737783, 5180.818671346485, 6058.4244496772735, 6242.406971337716, 6264.843378915563, 6284.497240220863, 5053.797848086036, 5831.212786273968, 5946.316173640087, 6197.690115494117, 6260.593061450991, 5680.71596420169, 6117.827404800828, 6131.8467038322615, 6193.566450348432, 6213.347598502092, 6172.722227499863, 6215.782447614311, 6219.533534984804, 6224.872520963381, 6251.187345645037, 6033.668148251712, 6066.707997520149, 6085.847853803691, 6133.738055536083, 6134.2332208473945], "value": 5685.1918503399775, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [491.78361520930787, 515.5385929593015, 540.629668676956, 540.745849450758, 577.7169187098323, 38439.846804595836, 39214.62748803789, 39252.21495570087, 39370.99999999993, 39422.0, 34135.65864341356, 41194.97012574687, 41203.0, 41314.58685413145, 41503.754887353425, 9310.48792316424, 9482.905170948272, 9533.666321678742, 9571.52142392881, 9587.472689002103, 9456.810863782755, 9681.0, 9681.75795605112, 9706.223502119814, 9742.951285243564, 9676.806463870718, 9711.61153553857, 9723.416595004323, 9746.366486178411, 9763.75590610237, 7955.0, 9157.038510956354, 9578.712638620853, 9657.034296570322, 9732.318737688365, 9597.184239339664, 9605.807883842284, 9717.222622190278, 9740.123388895034, 9747.171490423323, 33165.83417082899, 38676.61323386758, 39044.219115617816, 39086.0, 39239.41140882889, 2841.531147360683, 3023.8639261233297, 3180.6660300668327, 3183.4747266700965, 3410.5054767058887, 21563.029663665016, 23212.651810222862, 25916.35209119768, 27335.589966150525, 27439.039633612927, 2578.9226323210332, 2628.264086055888, 2641.8414895106357, 2738.0416854101104, 2836.7163283671675, 309898.4505077483, 349193.0, 373150.0, 374098.0, 376544.99999999726, 30200.54699179514, 36025.0, 36940.26119477595, 60830.78338433206, 61008.0, 31405.685943140732, 35427.0, 35437.29125417477, 35709.64290357115, 35975.4603680945, 15234.466793662168, 15398.384064637514, 15438.305276262596, 15457.0, 15518.224088795516, 12935.870641293655, 12985.415656295489, 12995.805062924064, 13053.869461305456, 13062.804057939138, 8046.758597242092, 8088.595570221465, 8124.796880078045, 8197.426180167331, 8207.384446166441, 2996.520556710959, 3371.578552680915, 3393.7963722176746, 3421.7433692473164, 3435.158386195398, 969.3844408800462, 979.5249304087512, 1056.2975621211808, 1090.7000574841982, 1129.2998341028451, 30574.79984826386, 30642.846785765927, 30652.540211896838, 30853.228669283, 31084.844575776977, 1112.0, 1139.4929256480953, 1181.4151994762476, 1194.1342526668095, 1240.5596013415288, 14741.96806223554, 15022.19052147722, 15318.693626127415, 15365.846341536442, 15793.763093553605, 339121.0, 339280.0, 339920.0, 342846.0, 344127.0, 60888.0, 61386.0, 62325.0, 62575.06137407943, 62631.37368626255, 1463.5170393770243, 1503.8872084593481, 1512.8033355663913, 1533.73007948235, 1535.385845661722, 26536.86731566407, 28966.855165724035, 29141.0, 29481.557776633796, 29530.557041643962, 46883.53116468792, 54078.0, 54172.729136354064, 54218.728906355216, 54403.18395223995, 527489.0, 532682.0, 532897.0, 536266.0, 542328.0, 27381.589276160474, 27576.448471030868, 28048.43903121967, 28120.85939570371, 28197.01310454124, 46512.53487465082, 46999.29501057555, 47547.76226118847, 48263.034739305716, 48801.0, 37868.810655947644, 38480.615193847705, 39112.022199445244, 39700.404493933194, 40180.79909600433, 37845.43231851579, 38544.03639909025, 38602.42096368501, 39019.46373485714, 39369.60630393774, 33249.833750831094, 37702.811485942395, 38209.0, 39350.2129957405, 39422.01444963784, 30870.69129308678, 32164.0, 32430.35139297248, 32550.83724581362, 32565.837170813993, 20894.582108357445, 24117.879410602836, 24412.389690257885, 24431.26706198817, 24992.0], "value": 17939.728419849027, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.7745255773517, 395.1504265828468, 398.62728348993693, 407.4051884248996, 415.56780947814275, 18976.146073426695, 20233.0, 20291.08690108945, 20939.37181884546, 21047.47381315468, 20844.374668759963, 21022.36932892012, 21278.57442851142, 21321.36035918925, 21577.892110539426, 4198.391233271189, 5331.680099194061, 5887.14636377726, 5991.041433370661, 6011.0, 5714.399988001242, 6601.141851559315, 6608.2070151581875, 6611.206655201383, 6616.536842421033, 6277.340879207686, 6492.123563318963, 6503.804885853432, 6526.543141980063, 6576.539642225046, 6416.871662566722, 6436.839079023039, 6505.804825855208, 6524.543281970264, 6544.214694236698, 5515.806946756844, 5679.4036626154075, 5760.481556659921, 5761.423857614247, 5776.0, 25834.74165258361, 25854.612180817116, 26476.940922363083, 26499.205023849314, 26638.0, 1910.6274276516085, 2131.605652954193, 2197.5824593327375, 2371.5019845832394, 2385.8667133111635, 9474.147326740627, 9686.75783105421, 9709.563069661883, 9811.11699947001, 9864.852027219598, 1433.6989232261237, 1722.5865792209904, 1729.5848996240939, 1793.390247315919, 1807.4577626712066, 100822.0, 108684.4565777174, 110213.42759010349, 123111.76888231182, 124587.0, 11566.248193867372, 11693.064554835593, 11715.238509496856, 11744.94127529357, 11876.524939002344, 14724.631884202981, 14927.0, 15042.172680502677, 15050.397984080733, 15080.245987700571, 8905.465672059698, 8937.01692813803, 8937.46375217489, 8947.418417802952, 9015.368924175245, 7855.489393189425, 8834.690785822466, 8851.64593416269, 8888.466691998501, 8894.688685895962, 4146.564610715892, 4338.652907767371, 4578.839740609063, 4681.95318046822, 4778.897285194573, 1723.732821412683, 1962.3524237001754, 2010.7788143304224, 2018.656828339186, 2027.432318950696, 815.7960509872532, 861.9569021548898, 933.7198840347869, 940.7271891151627, 1001.8697569315942, 20426.38720838377, 20446.284380046625, 20486.18055277802, 20536.486587835425, 20808.85551294663, 954.9379290346105, 973.4889183178888, 982.3761911186448, 988.5798535622332, 1005.5927349423495, 10893.074088702391, 11007.559697612165, 11086.611968581223, 11102.167337449724, 11116.388598627153, 589043.0, 591845.0, 593965.0, 603779.0, 635342.0, 136030.31984840013, 136920.0, 137962.0, 140158.0, 141250.0, 997.3915911294105, 1062.7661914378825, 1078.379931539368, 1081.5295346524445, 1092.3996345353935, 18207.635847283243, 18281.908590456962, 18486.0, 18695.719564206818, 19045.714314285575, 52782.94434111373, 53410.46589534055, 53553.66115847135, 53762.46237537731, 54202.0, 79961.60019199867, 80147.59926200565, 80762.12724749565, 80909.0, 81913.59043204747, 5075.77159027852, 5294.338207724035, 7081.929180708127, 7721.884171737541, 8531.061583225965, 10392.792144157225, 12125.757484850077, 12492.0, 12619.810702839648, 12710.936445317715, 10921.617743378943, 11002.614908478165, 11084.057855082408, 11106.278091924, 11384.544618215179, 10798.946005269923, 10811.945940270249, 10906.618268360886, 11220.046296064926, 11266.0, 9860.802783944424, 11146.219764616399, 11474.541018359507, 11474.77050459003, 11509.654710358702, 8019.799505012421, 8159.061707903667, 8240.13478584764, 8252.669893204446, 8258.710945117133, 10151.187904967732, 11127.72180695489, 11144.275622084539, 11179.496922638338, 11422.086233101165], "value": 9634.7667453014, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1606.0684802814365, 1637.5824164837968, 1902.885826850389, 1974.9802501974984, 2002.439316991243, 7245.3841423479, 8826.0, 8986.41588296761, 8991.0, 8996.505192214425, 7838.92161078389, 8567.228949394554, 8781.209691127797, 8801.119888011195, 8818.4708917465, 2446.425090103824, 2474.7030356357172, 2477.8017758579363, 2477.925662230127, 2485.5526005319034, 2427.2232885476656, 2493.5137648158616, 2495.226479791261, 2495.25142457263, 2496.8252222344445, 2441.121196369306, 2450.0689737899575, 2475.9752402476015, 2490.5018996200743, 2499.1003238834005, 2447.8898449569724, 2454.1165180534995, 2461.5569197544523, 2470.530599186167, 2478.6529885816, 2411.44536756547, 2429.259075981825, 2464.0759715106833, 2473.4558397152596, 2488.1913378151994, 7718.421118416141, 8850.380473366868, 8899.510526921016, 8954.417962832395, 8973.461592304482, 4773.904521909577, 5306.973465132688, 5499.340079190482, 5522.144067669477, 5525.585581081435, 3568.678818906311, 3623.438367053111, 3628.1836586767768, 3690.132818787583, 3712.443133529965, 985.5170966226569, 999.5202302894579, 1006.2754816532085, 1022.7903279827692, 1037.3257382701304, 10260.768707755116, 11535.538578456852, 11731.589394371242, 11759.764804703858, 11762.882371176263, 4088.9386659200136, 4235.364695295731, 4368.148211098869, 4528.139653465831, 4949.406071271398, 9634.373765705346, 10029.899701002896, 10057.245706572035, 10075.2368335541, 10089.09198172168, 5345.4654534546235, 5366.758495867695, 5398.703071331114, 5431.1853222016225, 5440.7551660174595, 4517.2772356423475, 4828.275758636232, 4934.605231581465, 5023.974880125576, 5029.622778291569, 4042.2510553037546, 4058.0, 4109.404136400205, 4122.2786012448305, 4144.274751918402, 1361.360160724458, 1370.2532119994628, 1375.3192169875977, 1382.315753701924, 1394.219237227156, 755.2598453515585, 854.918782715641, 889.7241855024963, 892.906244844295, 944.1832814615308, 5823.30120385548, 5976.671283079472, 6030.065339872327, 6033.0, 6059.030555111161, 950.1353768071023, 969.6315400147898, 980.5097451274363, 995.2933417273672, 1017.0897047142765, 3994.7403418777685, 4117.21772863155, 4143.3370660694145, 4158.106007208465, 4160.084781348099, 10651.041406273473, 10887.183461240438, 10956.068734157527, 11011.229213955106, 11014.834777478345, 10723.731906702395, 10802.837957430487, 10851.348919064882, 10978.615748448767, 11040.171987101, 7947.9205207948335, 8225.218604232588, 8247.587620618946, 8268.462549934235, 8289.544075075928, 4905.386826646669, 5779.017567013534, 5828.883422331614, 5916.526677865846, 5953.196318496947, 9701.951490242503, 9988.0, 9991.300608957303, 10033.648822291476, 10131.290809643255, 8330.875036874573, 10065.597376104874, 10225.74435639115, 10340.638077667547, 10356.948215258875, 7524.247575242432, 7596.96201519011, 7603.315701586884, 7604.087509498674, 7687.192844751221, 8275.0, 8383.706570270011, 8395.664173432995, 8396.496210227406, 8406.243438090602, 7341.596212208166, 7508.361789247975, 7578.772636820904, 7614.771556853303, 7615.847683046419, 7349.595772232578, 7373.483856130019, 7393.408527317909, 7519.924800752141, 7524.661390237562, 7086.964565177141, 7170.713171473083, 7182.245864184186, 7189.892151617834, 7191.3887319578425, 4857.0, 4970.801167953386, 5068.645194836474, 5072.898542029213, 5077.619178561697, 3975.8072578226993, 4749.643776716829, 4986.177280748636, 5001.699898006132, 5012.598992080552], "value": 4652.251456936628, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.36636479305434, 319.9696028877257, 321.45513354863505, 328.0584721848295, 332.9550510681057, 6249.281332646747, 6311.905321420182, 6316.115743795872, 6335.5565110442285, 6338.524610654196, 6190.669006163674, 6196.628202307865, 6198.597091189081, 6200.813975580729, 6281.309056003847, 3749.531308586427, 4179.72831765935, 4564.931526027096, 4615.238485649864, 4649.093426781779, 3656.305301992613, 4609.608183304406, 4637.559431853985, 4638.768061596924, 4643.628509719231, 4132.982922466601, 4637.768111594423, 4654.3251228571835, 4658.138244424776, 4681.9297710534365, 4463.73217606943, 4611.30830375443, 4618.838340658078, 4640.535946405333, 4653.650976176767, 3959.0102474381406, 3959.762414255154, 3978.661813745835, 3984.980075099635, 4013.5986401359633, 5953.315368732565, 5979.491743201833, 5990.9515834728745, 6034.728437220336, 6052.727627256784, 4988.501149884983, 5145.588352931756, 5154.252633368178, 5450.618456708032, 5450.8909821803345, 5479.287692599976, 5821.359650438449, 6447.194100737408, 6468.0, 6502.154719886432, 4200.936985945214, 4399.900024993752, 4406.4271644686305, 4409.338599210144, 4415.602595766396, 5573.909783831064, 6804.761833335859, 6908.1364829396325, 6911.755883940888, 6988.825279368006, 4001.3997900314603, 4482.529334419904, 4497.595216430537, 4515.14212299662, 4518.2319005769095, 4473.776311184428, 4603.930941035887, 4609.953900460952, 4617.284320930261, 4623.491415944243, 4265.360195970629, 5346.300118440163, 5396.3524377075, 5402.91895621566, 5412.323459567554, 5233.084210263265, 5823.88352232953, 6561.967190164114, 6575.934240657532, 6596.769113081019, 1403.1370707015112, 1522.3301747231403, 1557.0501993783782, 1581.6045988502874, 1582.3385445282408, 916.9495677737655, 973.3138137612966, 1028.3572767020612, 1037.7146284771597, 1043.8277684182026, 5904.339309628058, 6057.394260573908, 6060.272767267956, 6090.756369745249, 6095.0, 5698.344690360662, 5795.246617939725, 6752.5273230874345, 6773.593584384953, 6839.110915581042, 5785.537157027427, 6065.878682426415, 6108.3280839107665, 6110.541709371815, 6163.96918015407, 3180.45932191528, 3321.9003429897143, 3547.077759782475, 3571.0716213245078, 3576.3741345264475, 6254.312025677172, 6742.898856517156, 6752.797416077427, 7077.539959902693, 7082.4503178855575, 5914.319853216849, 6559.442447392025, 6847.109875716224, 6897.172339319213, 6945.687444064928, 5889.204957330706, 6116.847078822976, 6726.630035348005, 7010.334018268256, 7046.401055910203, 5491.533219676372, 6145.231846019247, 6647.235567909559, 6692.196936367667, 6744.831379215559, 6213.65824879636, 6292.182016337847, 6493.928501797151, 6629.502787291069, 6641.833954151185, 6534.856400129863, 6873.828154296182, 7199.460040497089, 7207.71169153249, 7224.277572242734, 4219.518896910123, 4340.761258130833, 4400.471943366689, 4404.427424434803, 4432.689711720149, 5776.747068643316, 6019.157317975574, 6510.804675859732, 6886.793396198122, 6892.965535172492, 5889.263842019747, 6530.967345163243, 6608.7026083825385, 6659.2008958925235, 6668.733250669919, 5342.98483288174, 5560.0, 6067.695445479243, 6146.846328841814, 6486.254080780771, 5596.664200148004, 5987.520998320211, 6141.508679305555, 6472.093906852951, 6513.576617519846, 6107.0, 6414.005829096497, 6618.338166183343, 6637.303083176197, 6646.268910419753, 5509.834704958857, 6488.416042556192, 6490.383413575702, 6497.415232629086, 6509.674516274262], "value": 4734.33857871498, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [649.409037775624, 671.9496037797165, 675.5743881354746, 752.8720117580009, 764.8623247815391, 12056.81914771278, 14993.47522836701, 15236.1620110894, 15268.389264429423, 15559.844401556009, 14227.146371217734, 14328.140311581312, 14354.354054067566, 14379.137251764902, 14401.63995900103, 750.6209364271062, 920.4569304110573, 931.8415869302218, 951.4766878216988, 957.530809903146, 956.6651671914843, 956.9186619137382, 959.151151231162, 962.4081190068127, 967.0184762466102, 1004.136442659316, 1004.8040632076747, 1006.8640733500957, 1009.6516701737926, 1011.8077565262577, 998.4159266828914, 999.6151481679606, 1000.6247657128577, 1000.9949950250275, 1001.7595777013464, 705.9258777828356, 723.8298999735058, 725.8149171961169, 728.8250819803209, 735.246372468219, 14855.851441485664, 14927.776083358649, 14947.327370268364, 15168.0, 15222.46721364747, 12662.240265584001, 12697.619071427873, 12713.0, 12789.1687040343, 13009.154404963647, 9820.098886042832, 9913.90086099137, 10143.746406339827, 10391.272610917238, 10392.220583456272, 3496.997879098664, 3507.386207413718, 3511.4587321555464, 3613.963860361389, 3647.361711700442, 83815.58092209561, 84016.0, 84804.0, 87885.68171477433, 88234.0, 9501.809963800824, 9517.5717092731, 9618.134367906921, 9662.75843103914, 9971.351862128939, 21977.67033494499, 22108.115675372806, 22133.33599992003, 22171.113155473602, 22229.11083556672, 6484.902726459107, 7134.785956421316, 7243.0, 7456.664450099758, 7578.772636820904, 4178.791060446965, 4191.455110835572, 4204.453421055243, 4289.871303860889, 4308.849190278388, 3578.1949061461482, 3682.963170368316, 3684.6499582539614, 3686.2996030754607, 3689.612590677994, 566.8271177290966, 641.8170821315903, 664.2560332427712, 672.4082807129695, 677.5257319876107, 545.0347335771122, 598.9041753319448, 603.1435361786274, 615.5260449453896, 622.4522420270224, 6586.560301921412, 8167.183281671904, 8174.7956301092945, 8293.502389856629, 8392.370572206986, 487.78293659321264, 572.8567858035491, 598.8892054969845, 613.1140501974604, 616.9198004259417, 3852.6725228355344, 3866.5940076292145, 3938.350172221609, 3954.18939117486, 3972.245273398045, 68304.65847670729, 87949.0, 88212.55893720618, 88461.67307490393, 89929.0, 76231.0, 77166.0, 77384.61307693426, 77809.0, 79088.604556978, 68415.65792171107, 68929.65535172392, 69516.0, 70038.2996170042, 70190.64904675545, 7650.579218143055, 7728.227177282227, 7820.335271501986, 7947.245011723877, 7978.162292959156, 39517.40723889202, 40550.1889962205, 45015.32477012913, 45343.31985020162, 45946.77026614846, 45758.771206143756, 59250.70374648099, 59778.70110649419, 63940.0, 64223.0, 9646.951765241129, 9845.113939745457, 9875.358101723365, 10121.89878101239, 10193.592256309961, 10838.295510791773, 10985.61550345734, 11126.165537584875, 11351.432428378714, 11421.714457138638, 10324.22568307365, 10494.160467162455, 10526.473676316307, 10781.083607893102, 10843.132549395872, 8572.894510059865, 10060.899391006289, 10451.581936722447, 10639.521221544894, 10704.89295107039, 10140.342661279568, 10216.744581385525, 10296.794064118825, 10571.788564228826, 10597.0, 8610.225079742853, 8634.136586341567, 8657.0, 8732.91267087321, 8801.339899507691, 8909.242714369351, 8914.687985920462, 9003.54982250898, 9065.184133428023, 9237.0], "value": 6769.710578772502, "unit": "score"}], "name": "dromaeo_css", "value": 7260.866787809162, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 109.0, 117.0, 117.0, 118.0, 129.0, 116.0, 118.0, 151.0, 117.0], "value": 121.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 121.0, 149.0, 221.0, 119.0, 141.0, 147.0, 128.0, 172.0, 121.0], "value": 147.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 201.0, 207.0, 227.0, 250.0, 278.0, 197.0, 247.0, 201.0, 195.0], "value": 219.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 72.0, 77.0, 162.0, 80.0, 81.0, 75.0, 61.0, 128.0, 62.0], "value": 87.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 93.0, 125.0, 77.0, 81.0, 83.0, 120.0, 81.0, 81.0, 124.0], "value": 94.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 88.0, 86.0, 89.0, 86.0, 90.0, 86.0, 89.0, 102.0], "value": 89.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 131.0, 149.0, 108.0, 94.0, 94.0, 107.0, 148.0, 93.0, 94.0], "value": 113.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 90.0, 98.0, 92.0, 90.0, 109.0, 147.0, 110.0, 92.0, 92.0], "value": 101.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 59.0, 61.0, 61.0, 60.0, 60.0, 62.0, 75.0, 61.0, 57.0], "value": 61.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 69.0, 74.0, 71.0, 74.0, 72.0, 66.0, 67.0, 67.0], "value": 68.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 104.0, 83.0, 83.0, 109.0, 84.0, 83.0, 83.0, 83.0, 85.0], "value": 89.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 140.0, 136.0, 138.0, 141.0, 137.0, 139.0, 170.0, 177.0, 168.0], "value": 148.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [216.0, 167.0, 222.0, 204.0, 174.0, 174.0, 170.0, 168.0, 170.0, 173.0], "value": 183.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 69.0, 68.0, 72.0, 92.0, 67.0, 62.0, 95.0, 99.0], "value": 76.3, "unit": "score"}], "name": "kraken", "value": 1602.1, "alertThreshold": 2.0}]} 09:33:47 INFO - Return code: 0 09:33:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:33:47 ERROR - # TBPL SUCCESS # 09:33:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:33:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:33:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:33:47 INFO - 2016-04-21 09:33:47.991 screenresolution[1971:21380] starting screenresolution argv=screenresolution get 09:33:47 INFO - 2016-04-21 09:33:47.994 screenresolution[1971:21380] Display 0: 1600x1200x32@60 09:33:48 INFO - 2016-04-21 09:33:48.000 screenresolution[1972:21383] starting screenresolution argv=screenresolution list 09:33:48 INFO - Available Modes on Display 0 09:33:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:33:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:33:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:33:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:33:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:33:48 INFO - Intel Iris: 09:33:48 INFO - Chipset Model: Intel Iris 09:33:48 INFO - Type: GPU 09:33:48 INFO - Bus: Built-In 09:33:48 INFO - VRAM (Dynamic, Max): 1536 MB 09:33:48 INFO - Vendor: Intel (0x8086) 09:33:48 INFO - Device ID: 0x0a2e 09:33:48 INFO - Revision ID: 0x0009 09:33:48 INFO - Displays: 09:33:48 INFO - Display: 09:33:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:33:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:33:48 INFO - Display Serial Number: 1600x1200 60 09:33:48 INFO - Main Display: Yes 09:33:48 INFO - Mirror: Off 09:33:48 INFO - Online: Yes 09:33:48 INFO - Rotation: Supported 09:33:48 INFO - Return code: 0 09:33:48 INFO - Running post-action listener: _resource_record_post_action 09:33:48 INFO - Running post-run listener: _resource_record_post_run 09:33:49 INFO - Total resource usage - Wall time: 1206s; CPU: 54.0%; Read bytes: 184320; Write bytes: 695223808; Read time: 5; Write time: 1864 09:33:49 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 383857152; Write bytes: 378759168; Read time: 28406; Write time: 705 09:33:49 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 184320; Write bytes: 296685056; Read time: 5; Write time: 1115 09:33:49 INFO - Running post-run listener: _upload_blobber_files 09:33:49 INFO - Blob upload gear active. 09:33:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:33:49 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 09:33:49 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'] 09:33:49 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 09:33:49 INFO - (blobuploader) - INFO - Open directory for files ... 09:33:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:33:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:33:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:33:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:33:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:33:50 INFO - (blobuploader) - INFO - Done attempting. 09:33:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:33:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:33:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:33:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:33:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:33:51 INFO - (blobuploader) - INFO - Done attempting. 09:33:51 INFO - (blobuploader) - INFO - Iteration through files over. 09:33:51 INFO - Return code: 0 09:33:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:33:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:33:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2f03211f9fa744aa7c901c7b0381412888760bada94f63e5ba602f129a51f759bf231ff618db07578e49dd0ad5b3ae07d8b230dc796a4e2bb986dcd8aa5e4a72", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/85307480eeeb7807d3cf501b706a389e6180e09b811e9d6aebae57cc0cdbdd4370686a64cd28674f3dbb92a52a77a36a6b2d073cb016772adcff81acccce1c5a"} 09:33:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:33:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:33:51 INFO - Contents: 09:33:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2f03211f9fa744aa7c901c7b0381412888760bada94f63e5ba602f129a51f759bf231ff618db07578e49dd0ad5b3ae07d8b230dc796a4e2bb986dcd8aa5e4a72", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/85307480eeeb7807d3cf501b706a389e6180e09b811e9d6aebae57cc0cdbdd4370686a64cd28674f3dbb92a52a77a36a6b2d073cb016772adcff81acccce1c5a"} 09:33:51 INFO - Running post-run listener: copy_logs_to_upload_dir 09:33:51 INFO - Copying logs to upload dir... 09:33:51 INFO - mkdir: /builds/slave/test/build/upload/logs 09:33:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.342375 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-04-21 09:33:51.609580) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 09:33:51.613094) ========= 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.ncRsBKQ7nB/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.XVj3NI3NmH/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2f03211f9fa744aa7c901c7b0381412888760bada94f63e5ba602f129a51f759bf231ff618db07578e49dd0ad5b3ae07d8b230dc796a4e2bb986dcd8aa5e4a72", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/85307480eeeb7807d3cf501b706a389e6180e09b811e9d6aebae57cc0cdbdd4370686a64cd28674f3dbb92a52a77a36a6b2d073cb016772adcff81acccce1c5a"} build_url:https://queue.taskcluster.net/v1/task/CZ_pmHCsTuu0lX7fjxuIsw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010987 build_url: 'https://queue.taskcluster.net/v1/task/CZ_pmHCsTuu0lX7fjxuIsw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2f03211f9fa744aa7c901c7b0381412888760bada94f63e5ba602f129a51f759bf231ff618db07578e49dd0ad5b3ae07d8b230dc796a4e2bb986dcd8aa5e4a72", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/85307480eeeb7807d3cf501b706a389e6180e09b811e9d6aebae57cc0cdbdd4370686a64cd28674f3dbb92a52a77a36a6b2d073cb016772adcff81acccce1c5a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 09:33:51.640620) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 09:33:51.640987) ========= 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.ncRsBKQ7nB/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.XVj3NI3NmH/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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.005175 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 09:33:51.689957) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 09:33:51.690396) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 09:33:51.690867) ========= ========= Total master_lag: 0.45 =========