builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0112 starttime: 1460717018.0 results: success (0) buildid: 20160415024941 builduid: 0bffa32634544aafa9c4948ff5e4599c revision: b7772a6288f8b1011e1dfc8629ced4f401e47c9c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 03:43:38.005325) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 03:43:38.005810) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 03:43:38.006095) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 03:43:38.023702) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 03:43:38.024037) ========= 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.hRW2vyMvDd/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.jAOh8sckQl/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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-15 03:43:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 154M=0s 2016-04-15 03:43:38 (154 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.130658 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 03:43:38.171161) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 03:43:38.171474) ========= 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.hRW2vyMvDd/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.jAOh8sckQl/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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.021757 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 03:43:38.220582) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-15 03:43:38.220966) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b7772a6288f8b1011e1dfc8629ced4f401e47c9c --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 b7772a6288f8b1011e1dfc8629ced4f401e47c9c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.hRW2vyMvDd/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.jAOh8sckQl/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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-15 03:43:38,290 truncating revision to first 12 chars 2016-04-15 03:43:38,290 Setting DEBUG logging. 2016-04-15 03:43:38,290 attempt 1/10 2016-04-15 03:43:38,290 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b7772a6288f8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-15 03:43:39,520 unpacking tar archive at: fx-team-b7772a6288f8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.478890 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-15 03:43:39.718987) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 03:43:39.719520) ========= script_repo_revision: b7772a6288f8b1011e1dfc8629ced4f401e47c9c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 03:43:39.720171) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 03:43:39.720685) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 03:43:39.736713) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 30 secs) (at 2016-04-15 03:43:39.737114) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.hRW2vyMvDd/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.jAOh8sckQl/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 03:43:39 INFO - MultiFileLogger online at 20160415 03:43:39 in /builds/slave/test 03:43:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 03:43:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:43:39 INFO - {'append_to_log': False, 03:43:39 INFO - 'base_work_dir': '/builds/slave/test', 03:43:39 INFO - 'blob_upload_branch': 'Fx-Team', 03:43:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:43:39 INFO - 'branch': 'Fx-Team', 03:43:39 INFO - 'buildbot_json_path': 'buildprops.json', 03:43:39 INFO - 'config_files': ('talos/mac_config.py',), 03:43:39 INFO - 'default_actions': ('clobber', 03:43:39 INFO - 'read-buildbot-config', 03:43:39 INFO - 'download-and-extract', 03:43:39 INFO - 'populate-webroot', 03:43:39 INFO - 'create-virtualenv', 03:43:39 INFO - 'install', 03:43:39 INFO - 'run-tests'), 03:43:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:43:39 INFO - 'download_minidump_stackwalk': True, 03:43:39 INFO - 'download_symbols': 'ondemand', 03:43:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:43:39 INFO - 'tooltool.py': '/tools/tooltool.py', 03:43:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:43:39 INFO - '/tools/misc-python/virtualenv.py')}, 03:43:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:43:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:43:39 INFO - 'installer_path': 'installer.exe', 03:43:39 INFO - 'log_level': 'info', 03:43:39 INFO - 'log_name': 'talos', 03:43:39 INFO - 'log_to_console': True, 03:43:39 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:43:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:43:39 INFO - 'opt_config_files': (), 03:43:39 INFO - 'pip_index': False, 03:43:39 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:43:39 INFO - 'cmd': ('bash', 03:43:39 INFO - '-c', 03:43:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:43:39 INFO - 'enabled': True, 03:43:39 INFO - 'halt_on_failure': False, 03:43:39 INFO - 'name': 'check_screen_resolution'},), 03:43:39 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:43:39 INFO - 'cmd': ('bash', 03:43:39 INFO - '-c', 03:43:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:43:39 INFO - 'enabled': True, 03:43:39 INFO - 'halt_on_failure': False, 03:43:39 INFO - 'name': 'check_screen_resolution'},), 03:43:39 INFO - 'run_cmd_checks_enabled': True, 03:43:39 INFO - 'sps_profile': False, 03:43:39 INFO - 'sps_profile_interval': 0, 03:43:39 INFO - 'suite': 'dromaeojs', 03:43:39 INFO - 'system_bits': '32', 03:43:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:43:39 INFO - 'title': 't-yosemite-r7-0112', 03:43:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:43:39 INFO - 'use_talos_json': True, 03:43:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:43:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:43:39 INFO - 'work_dir': 'build'} 03:43:39 INFO - ##### 03:43:39 INFO - ##### Running clobber step. 03:43:39 INFO - ##### 03:43:39 INFO - Running pre-action listener: _resource_record_pre_action 03:43:39 INFO - Running main action method: clobber 03:43:39 INFO - rmtree: /builds/slave/test/build 03:43:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:43:41 INFO - Running post-action listener: _resource_record_post_action 03:43:41 INFO - ##### 03:43:41 INFO - ##### Running read-buildbot-config step. 03:43:41 INFO - ##### 03:43:41 INFO - Running pre-action listener: _resource_record_pre_action 03:43:41 INFO - Running main action method: read_buildbot_config 03:43:41 INFO - Using buildbot properties: 03:43:41 INFO - { 03:43:41 INFO - "project": "", 03:43:41 INFO - "product": "firefox", 03:43:41 INFO - "script_repo_revision": "production", 03:43:41 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 03:43:41 INFO - "repository": "", 03:43:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 03:43:41 INFO - "buildid": "20160415024941", 03:43:41 INFO - "pgo_build": "False", 03:43:41 INFO - "basedir": "/builds/slave/test", 03:43:41 INFO - "buildnumber": 663, 03:43:41 INFO - "slavename": "t-yosemite-r7-0112", 03:43:41 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 03:43:41 INFO - "platform": "yosemite_r7", 03:43:41 INFO - "scheduler": "tests-fx-team-macosx64-talos", 03:43:41 INFO - "branch": "fx-team", 03:43:41 INFO - "repo_path": "integration/fx-team", 03:43:41 INFO - "revision": "b7772a6288f8b1011e1dfc8629ced4f401e47c9c", 03:43:41 INFO - "stage_platform": "macosx64", 03:43:41 INFO - "builduid": "0bffa32634544aafa9c4948ff5e4599c", 03:43:41 INFO - "slavebuilddir": "test" 03:43:41 INFO - } 03:43:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/PlPF6wH1SqurAMmEVhKS_g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 03:43:41 INFO - Running post-action listener: _resource_record_post_action 03:43:41 INFO - ##### 03:43:41 INFO - ##### Running download-and-extract step. 03:43:41 INFO - ##### 03:43:41 INFO - Running pre-action listener: _resource_record_pre_action 03:43:41 INFO - Running main action method: download_and_extract 03:43:41 INFO - mkdir: /builds/slave/test/build/tests 03:43:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:43:41 INFO - https://queue.taskcluster.net/v1/task/PlPF6wH1SqurAMmEVhKS_g/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 03:43:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PlPF6wH1SqurAMmEVhKS_g/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 03:43:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PlPF6wH1SqurAMmEVhKS_g/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 03:43:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PlPF6wH1SqurAMmEVhKS_g/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 03:43:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PlPF6wH1SqurAMmEVhKS_g/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 03:43:42 INFO - Downloaded 1199 bytes. 03:43:42 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 03:43:42 INFO - Using the following test package requirements: 03:43:42 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 03:43:42 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:43:42 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 03:43:42 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:43:42 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 03:43:42 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:43:42 INFO - u'jsshell-mac.zip'], 03:43:42 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:43:42 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 03:43:42 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 03:43:42 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:43:42 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 03:43:42 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:43:42 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 03:43:42 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:43:42 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 03:43:42 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:43:42 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 03:43:42 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:43:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:43:42 INFO - https://queue.taskcluster.net/v1/task/PlPF6wH1SqurAMmEVhKS_g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:43:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PlPF6wH1SqurAMmEVhKS_g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 03:43:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PlPF6wH1SqurAMmEVhKS_g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 03:43:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PlPF6wH1SqurAMmEVhKS_g/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 03:43:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PlPF6wH1SqurAMmEVhKS_g/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 03:43:43 INFO - Downloaded 18031158 bytes. 03:43:43 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'] 03:43:43 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 03:43:47 INFO - Return code: 0 03:43:47 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 03:43:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:43:47 INFO - https://queue.taskcluster.net/v1/task/PlPF6wH1SqurAMmEVhKS_g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:43:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PlPF6wH1SqurAMmEVhKS_g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 03:43:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PlPF6wH1SqurAMmEVhKS_g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 03:43:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PlPF6wH1SqurAMmEVhKS_g/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 03:43:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PlPF6wH1SqurAMmEVhKS_g/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 03:43:48 INFO - Downloaded 18031158 bytes. 03:43:48 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'] 03:43:48 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 03:43:51 INFO - Return code: 0 03:43:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:43:51 INFO - https://queue.taskcluster.net/v1/task/PlPF6wH1SqurAMmEVhKS_g/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 03:43:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PlPF6wH1SqurAMmEVhKS_g/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 03:43:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PlPF6wH1SqurAMmEVhKS_g/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 03:43:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PlPF6wH1SqurAMmEVhKS_g/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 03:43:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PlPF6wH1SqurAMmEVhKS_g/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 03:43:52 INFO - Downloaded 10841076 bytes. 03:43:52 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'] 03:43:52 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 03:43:53 INFO - Return code: 0 03:43:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:43:53 INFO - https://queue.taskcluster.net/v1/task/PlPF6wH1SqurAMmEVhKS_g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 03:43:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PlPF6wH1SqurAMmEVhKS_g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 03:43:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PlPF6wH1SqurAMmEVhKS_g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 03:43:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PlPF6wH1SqurAMmEVhKS_g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 03:43:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PlPF6wH1SqurAMmEVhKS_g/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 03:43:58 INFO - Downloaded 109834665 bytes. 03:43:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PlPF6wH1SqurAMmEVhKS_g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 03:43:58 INFO - mkdir: /builds/slave/test/properties 03:43:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:43:58 INFO - Writing to file /builds/slave/test/properties/build_url 03:43:58 INFO - Contents: 03:43:58 INFO - build_url:https://queue.taskcluster.net/v1/task/PlPF6wH1SqurAMmEVhKS_g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 03:43:59 INFO - Running post-action listener: _resource_record_post_action 03:43:59 INFO - Running post-action listener: set_extra_try_arguments 03:43:59 INFO - ##### 03:43:59 INFO - ##### Running populate-webroot step. 03:43:59 INFO - ##### 03:43:59 INFO - Running pre-action listener: _resource_record_pre_action 03:43:59 INFO - Running main action method: populate_webroot 03:43:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:43:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:43:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:43:59 INFO - '--tppagecycles', 03:43:59 INFO - '7'], 03:43:59 INFO - 'tests': ['tsvgm']}}, 03:43:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:43:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:43:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:43:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:43:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:43:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:43:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:43:59 INFO - 'talos_options': ['--disable-e10s'], 03:43:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:43:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:43:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:43:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:43:59 INFO - 'talos_options': ['--disable-e10s'], 03:43:59 INFO - 'tests': ['damp', 'tps']}, 03:43:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:43:59 INFO - 'tests': ['damp', 'tps']}, 03:43:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:43:59 INFO - 'tests': ['dromaeo_dom']}, 03:43:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:43:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:43:59 INFO - 'tests': ['a11yr', 03:43:59 INFO - 'ts_paint', 03:43:59 INFO - 'tpaint', 03:43:59 INFO - 'sessionrestore', 03:43:59 INFO - 'sessionrestore_no_auto_restore', 03:43:59 INFO - 'tabpaint']}, 03:43:59 INFO - 'other-e10s': {'tests': ['a11yr', 03:43:59 INFO - 'ts_paint', 03:43:59 INFO - 'tpaint', 03:43:59 INFO - 'sessionrestore', 03:43:59 INFO - 'sessionrestore_no_auto_restore', 03:43:59 INFO - 'tabpaint']}, 03:43:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:43:59 INFO - 'ts_paint', 03:43:59 INFO - 'tpaint', 03:43:59 INFO - 'sessionrestore', 03:43:59 INFO - 'sessionrestore_no_auto_restore', 03:43:59 INFO - 'tabpaint']}, 03:43:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:43:59 INFO - 'ts_paint', 03:43:59 INFO - 'tpaint', 03:43:59 INFO - 'sessionrestore', 03:43:59 INFO - 'sessionrestore_no_auto_restore', 03:43:59 INFO - 'tabpaint']}, 03:43:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:43:59 INFO - 'tests': ['a11yr', 03:43:59 INFO - 'ts_paint', 03:43:59 INFO - 'tpaint', 03:43:59 INFO - 'sessionrestore', 03:43:59 INFO - 'sessionrestore_no_auto_restore', 03:43:59 INFO - 'tabpaint']}, 03:43:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:43:59 INFO - 'tests': ['a11yr', 03:43:59 INFO - 'ts_paint', 03:43:59 INFO - 'tpaint', 03:43:59 INFO - 'sessionrestore', 03:43:59 INFO - 'sessionrestore_no_auto_restore', 03:43:59 INFO - 'tabpaint']}, 03:43:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:43:59 INFO - 'tests': ['tsvgx', 03:43:59 INFO - 'tsvgr_opacity', 03:43:59 INFO - 'tart', 03:43:59 INFO - 'tscrollx', 03:43:59 INFO - 'cart']}, 03:43:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:43:59 INFO - 'tsvgr_opacity', 03:43:59 INFO - 'tart', 03:43:59 INFO - 'tscrollx', 03:43:59 INFO - 'cart']}, 03:43:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:43:59 INFO - 'talos_options': ['--disable-e10s'], 03:43:59 INFO - 'tests': ['tp5o']}, 03:43:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:43:59 INFO - 'tests': ['tp5o']}, 03:43:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:43:59 INFO - 'talos_options': ['--disable-e10s', 03:43:59 INFO - '--xperf_path', 03:43:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:43:59 INFO - 'tests': ['tp5n']}, 03:43:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:43:59 INFO - 'talos_options': ['--xperf_path', 03:43:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:43:59 INFO - 'tests': ['tp5n']}}, 03:43:59 INFO - 'talos.zip': {'path': '', 03:43:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:43:59 INFO - Running post-action listener: _resource_record_post_action 03:43:59 INFO - ##### 03:43:59 INFO - ##### Running create-virtualenv step. 03:43:59 INFO - ##### 03:43:59 INFO - Running pre-action listener: _resource_record_pre_action 03:43:59 INFO - Running main action method: create_virtualenv 03:43:59 INFO - Creating virtualenv /builds/slave/test/build/venv 03:43:59 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:43:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:44:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:44:00 INFO - Using real prefix '/tools/python27' 03:44:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:44:00 INFO - Installing distribute.............................................................................................................................................................................................done. 03:44:03 INFO - Installing pip.................done. 03:44:03 INFO - Return code: 0 03:44:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:44:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:03 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 0x10c758a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c768420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9d14b85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5f7e00>, '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 0x10c420db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c5f2b20>, '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.hRW2vyMvDd/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.jAOh8sckQl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:44:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:44:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:44:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hRW2vyMvDd/Render', 03:44:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:44:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:44:03 INFO - 'HOME': '/Users/cltbld', 03:44:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:44:03 INFO - 'LOGNAME': 'cltbld', 03:44:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:03 INFO - 'MOZ_NO_REMOTE': '1', 03:44:03 INFO - 'NO_EM_RESTART': '1', 03:44:03 INFO - 'PAGER': '/bin/cat', 03:44:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:44:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:03 INFO - 'PWD': '/builds/slave/test', 03:44:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:44:03 INFO - 'SHELL': '/bin/bash', 03:44:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jAOh8sckQl/Listeners', 03:44:03 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 03:44:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:44:03 INFO - 'USER': 'cltbld', 03:44:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:44:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:44:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:03 INFO - 'XPC_FLAGS': '0x0', 03:44:03 INFO - 'XPC_SERVICE_NAME': '0', 03:44:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:44:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:03 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:44:03 INFO - Cleaning up... 03:44:03 INFO - Return code: 0 03:44:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:44:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:03 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 0x10c758a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c768420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9d14b85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5f7e00>, '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 0x10c420db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c5f2b20>, '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.hRW2vyMvDd/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.jAOh8sckQl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:44:03 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 03:44:03 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 03:44:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hRW2vyMvDd/Render', 03:44:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:44:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:44:03 INFO - 'HOME': '/Users/cltbld', 03:44:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:44:03 INFO - 'LOGNAME': 'cltbld', 03:44:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:03 INFO - 'MOZ_NO_REMOTE': '1', 03:44:03 INFO - 'NO_EM_RESTART': '1', 03:44:03 INFO - 'PAGER': '/bin/cat', 03:44:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:44:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:03 INFO - 'PWD': '/builds/slave/test', 03:44:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:44:03 INFO - 'SHELL': '/bin/bash', 03:44:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jAOh8sckQl/Listeners', 03:44:03 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 03:44:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:44:03 INFO - 'USER': 'cltbld', 03:44:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:44:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:44:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:03 INFO - 'XPC_FLAGS': '0x0', 03:44:03 INFO - 'XPC_SERVICE_NAME': '0', 03:44:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:44:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:04 INFO - Downloading/unpacking psutil>=0.7.1 03:44:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:44:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:44:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:44:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:44:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:44:06 INFO - Installing collected packages: psutil 03:44:06 INFO - Running setup.py install for psutil 03:44:06 INFO - building 'psutil._psutil_osx' extension 03:44:06 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 03:44:07 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 03:44:07 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 03:44:07 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 03:44:07 INFO - building 'psutil._psutil_posix' extension 03:44:07 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 03:44:07 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:44:07 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:44:07 INFO - ^ 03:44:07 INFO - 1 warning generated. 03:44:07 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 03:44:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:44:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:44:07 INFO - Successfully installed psutil 03:44:07 INFO - Cleaning up... 03:44:07 INFO - Return code: 0 03:44:07 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:44:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c758a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c768420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9d14b85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5f7e00>, '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 0x10c420db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c5f2b20>, '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.hRW2vyMvDd/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.jAOh8sckQl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:44:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:44:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:44:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hRW2vyMvDd/Render', 03:44:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:44:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:44:07 INFO - 'HOME': '/Users/cltbld', 03:44:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:44:07 INFO - 'LOGNAME': 'cltbld', 03:44:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:07 INFO - 'MOZ_NO_REMOTE': '1', 03:44:07 INFO - 'NO_EM_RESTART': '1', 03:44:07 INFO - 'PAGER': '/bin/cat', 03:44:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:44:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:07 INFO - 'PWD': '/builds/slave/test', 03:44:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:44:07 INFO - 'SHELL': '/bin/bash', 03:44:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jAOh8sckQl/Listeners', 03:44:07 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 03:44:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:44:07 INFO - 'USER': 'cltbld', 03:44:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:44:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:44:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:07 INFO - 'XPC_FLAGS': '0x0', 03:44:07 INFO - 'XPC_SERVICE_NAME': '0', 03:44:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:44:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:44:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:10 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:44:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:44:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:44:10 INFO - Installing collected packages: mozsystemmonitor 03:44:10 INFO - Running setup.py install for mozsystemmonitor 03:44:10 INFO - Successfully installed mozsystemmonitor 03:44:10 INFO - Cleaning up... 03:44:10 INFO - Return code: 0 03:44:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:44:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c758a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c768420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9d14b85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5f7e00>, '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 0x10c420db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c5f2b20>, '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.hRW2vyMvDd/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.jAOh8sckQl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:44:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:44:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:44:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hRW2vyMvDd/Render', 03:44:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:44:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:44:10 INFO - 'HOME': '/Users/cltbld', 03:44:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:44:10 INFO - 'LOGNAME': 'cltbld', 03:44:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:10 INFO - 'MOZ_NO_REMOTE': '1', 03:44:10 INFO - 'NO_EM_RESTART': '1', 03:44:10 INFO - 'PAGER': '/bin/cat', 03:44:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:44:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:10 INFO - 'PWD': '/builds/slave/test', 03:44:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:44:10 INFO - 'SHELL': '/bin/bash', 03:44:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jAOh8sckQl/Listeners', 03:44:10 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 03:44:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:44:10 INFO - 'USER': 'cltbld', 03:44:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:44:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:44:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:10 INFO - 'XPC_FLAGS': '0x0', 03:44:10 INFO - 'XPC_SERVICE_NAME': '0', 03:44:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:44:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:10 INFO - Downloading/unpacking blobuploader==1.2.4 03:44:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:44:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:44:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:13 INFO - Downloading blobuploader-1.2.4.tar.gz 03:44:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:44:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:44:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:44:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:44:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:44:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:44:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:44:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:44:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:14 INFO - Downloading docopt-0.6.1.tar.gz 03:44:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:44:14 INFO - Installing collected packages: blobuploader, requests, docopt 03:44:14 INFO - Running setup.py install for blobuploader 03:44:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:44:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:44:14 INFO - Running setup.py install for requests 03:44:15 INFO - Running setup.py install for docopt 03:44:15 INFO - Successfully installed blobuploader requests docopt 03:44:15 INFO - Cleaning up... 03:44:15 INFO - Return code: 0 03:44:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:44: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')]} 03:44:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44: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')]} 03:44:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:15 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 0x10c758a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c768420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9d14b85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5f7e00>, '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 0x10c420db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c5f2b20>, '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.hRW2vyMvDd/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.jAOh8sckQl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:44:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:44:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:44:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hRW2vyMvDd/Render', 03:44:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:44:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:44:15 INFO - 'HOME': '/Users/cltbld', 03:44:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:44:15 INFO - 'LOGNAME': 'cltbld', 03:44:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:15 INFO - 'MOZ_NO_REMOTE': '1', 03:44:15 INFO - 'NO_EM_RESTART': '1', 03:44:15 INFO - 'PAGER': '/bin/cat', 03:44:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:44:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:15 INFO - 'PWD': '/builds/slave/test', 03:44:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:44:15 INFO - 'SHELL': '/bin/bash', 03:44:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jAOh8sckQl/Listeners', 03:44:15 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 03:44:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:44:15 INFO - 'USER': 'cltbld', 03:44:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:44:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:44:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:15 INFO - 'XPC_FLAGS': '0x0', 03:44:15 INFO - 'XPC_SERVICE_NAME': '0', 03:44:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:44:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:44:15 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-K76UIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:44:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:44:15 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-sTVRbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:44:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:44:15 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-Va3UTw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:44:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:44:16 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-5EwhFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:44:16 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-sAdux2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:44:16 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-NMf_7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:44:16 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-Wp272g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:44:16 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-QtArrQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:44:16 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-560wn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:44:16 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-VP0A8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:44:16 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-qvO_qM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:44:16 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-5NjGb6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:44:16 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-_YRuP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:44:17 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-f_gn3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:44:17 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-wgQYcO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:44:17 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-mIZlcE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:44:17 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-5GzQpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:44:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:44:17 INFO - Running setup.py install for manifestparser 03:44:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:44:17 INFO - Running setup.py install for mozcrash 03:44:17 INFO - Running setup.py install for mozdebug 03:44:17 INFO - Running setup.py install for mozdevice 03:44:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:44:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:44:18 INFO - Running setup.py install for mozfile 03:44:18 INFO - Running setup.py install for mozhttpd 03:44:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:44:18 INFO - Running setup.py install for mozinfo 03:44:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:44:18 INFO - Running setup.py install for mozInstall 03:44:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:44:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:44:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:44:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:44:18 INFO - Running setup.py install for mozleak 03:44:18 INFO - Running setup.py install for mozlog 03:44:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:44:18 INFO - Running setup.py install for moznetwork 03:44:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:44:19 INFO - Running setup.py install for mozprocess 03:44:19 INFO - Running setup.py install for mozprofile 03:44:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:44:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:44:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:44:19 INFO - Running setup.py install for mozrunner 03:44:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:44:19 INFO - Running setup.py install for mozscreenshot 03:44:19 INFO - Running setup.py install for moztest 03:44:19 INFO - Running setup.py install for mozversion 03:44:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:44:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:44:20 INFO - Cleaning up... 03:44:20 INFO - Return code: 0 03:44:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:44:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:20 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 0x10c758a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c768420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9d14b85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5f7e00>, '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 0x10c420db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c5f2b20>, '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.hRW2vyMvDd/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.jAOh8sckQl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:44:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:44:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:44:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hRW2vyMvDd/Render', 03:44:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:44:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:44:20 INFO - 'HOME': '/Users/cltbld', 03:44:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:44:20 INFO - 'LOGNAME': 'cltbld', 03:44:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:20 INFO - 'MOZ_NO_REMOTE': '1', 03:44:20 INFO - 'NO_EM_RESTART': '1', 03:44:20 INFO - 'PAGER': '/bin/cat', 03:44:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:44:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:20 INFO - 'PWD': '/builds/slave/test', 03:44:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:44:20 INFO - 'SHELL': '/bin/bash', 03:44:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jAOh8sckQl/Listeners', 03:44:20 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 03:44:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:44:20 INFO - 'USER': 'cltbld', 03:44:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:44:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:44:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:20 INFO - 'XPC_FLAGS': '0x0', 03:44:20 INFO - 'XPC_SERVICE_NAME': '0', 03:44:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:44:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:44:20 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-RWDegi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:44:20 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:44:20 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-rEG2g_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:44:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:44:20 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-M6eDpF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:44:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:44:20 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-kXxs1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:44:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:44:20 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-A5WHo9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:44:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:44:20 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-QPsHNg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:44:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:44:20 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-RmUrXe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:44:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:44:21 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-uPS9Xf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:44:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:44:21 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-QuliCj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:44:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:44:21 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-S7kfR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:44:21 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)) 03:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:44:21 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-KvE5my-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:44:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:44:21 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-kO_bLS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:44:21 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)) 03:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:44:21 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-Qw4jYq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:44:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:44:21 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-h0L3u9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:44:21 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)) 03:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:44:21 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-KJ0g1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:44:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:44:21 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-cz4Dwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:44:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:44:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:44:22 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-NLZW9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:44:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:44:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:44:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:44:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:44:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:44:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:44:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:44: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 03:44: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 03:44: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 03:44: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 03:44: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 03:44: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 03:44:24 INFO - Downloading blessings-1.6.tar.gz 03:44:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:44:24 INFO - Installing collected packages: blessings 03:44:24 INFO - Running setup.py install for blessings 03:44:24 INFO - Successfully installed blessings 03:44:24 INFO - Cleaning up... 03:44:24 INFO - Return code: 0 03:44:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:44:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:44:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:44:25 INFO - Reading from file tmpfile_stdout 03:44:25 INFO - Current package versions: 03:44:25 INFO - blessings == 1.6 03:44:25 INFO - blobuploader == 1.2.4 03:44:25 INFO - docopt == 0.6.1 03:44:25 INFO - manifestparser == 1.1 03:44:25 INFO - mozInstall == 1.12 03:44:25 INFO - mozcrash == 0.17 03:44:25 INFO - mozdebug == 0.1 03:44:25 INFO - mozdevice == 0.48 03:44:25 INFO - mozfile == 1.2 03:44:25 INFO - mozhttpd == 0.7 03:44:25 INFO - mozinfo == 0.9 03:44:25 INFO - mozleak == 0.1 03:44:25 INFO - mozlog == 3.1 03:44:25 INFO - moznetwork == 0.27 03:44:25 INFO - mozprocess == 0.22 03:44:25 INFO - mozprofile == 0.28 03:44:25 INFO - mozrunner == 6.11 03:44:25 INFO - mozscreenshot == 0.1 03:44:25 INFO - mozsystemmonitor == 0.0 03:44:25 INFO - moztest == 0.7 03:44:25 INFO - mozversion == 1.4 03:44:25 INFO - psutil == 3.1.1 03:44:25 INFO - requests == 1.2.3 03:44:25 INFO - wsgiref == 0.1.2 03:44:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:44:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:25 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 0x10c758a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c768420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9d14b85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5f7e00>, '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 0x10c420db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c5f2b20>, '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.hRW2vyMvDd/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.jAOh8sckQl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:44:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:44:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:44:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hRW2vyMvDd/Render', 03:44:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:44:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:44:25 INFO - 'HOME': '/Users/cltbld', 03:44:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:44:25 INFO - 'LOGNAME': 'cltbld', 03:44:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:25 INFO - 'MOZ_NO_REMOTE': '1', 03:44:25 INFO - 'NO_EM_RESTART': '1', 03:44:25 INFO - 'PAGER': '/bin/cat', 03:44:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:44:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:25 INFO - 'PWD': '/builds/slave/test', 03:44:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:44:25 INFO - 'SHELL': '/bin/bash', 03:44:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jAOh8sckQl/Listeners', 03:44:25 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 03:44:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:44:25 INFO - 'USER': 'cltbld', 03:44:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:44:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:44:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:25 INFO - 'XPC_FLAGS': '0x0', 03:44:25 INFO - 'XPC_SERVICE_NAME': '0', 03:44:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:44:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:44:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:44:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:44:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:44:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:44:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:44:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:44:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:44:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:44:25 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:44:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:44:25 INFO - Cleaning up... 03:44:25 INFO - Return code: 0 03:44:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:44:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:25 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 0x10c758a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c768420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9d14b85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5f7e00>, '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 0x10c420db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c5f2b20>, '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.hRW2vyMvDd/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.jAOh8sckQl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:44:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:44:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:44:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hRW2vyMvDd/Render', 03:44:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:44:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:44:25 INFO - 'HOME': '/Users/cltbld', 03:44:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:44:25 INFO - 'LOGNAME': 'cltbld', 03:44:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:25 INFO - 'MOZ_NO_REMOTE': '1', 03:44:25 INFO - 'NO_EM_RESTART': '1', 03:44:25 INFO - 'PAGER': '/bin/cat', 03:44:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:44:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:25 INFO - 'PWD': '/builds/slave/test', 03:44:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:44:25 INFO - 'SHELL': '/bin/bash', 03:44:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jAOh8sckQl/Listeners', 03:44:25 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 03:44:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:44:25 INFO - 'USER': 'cltbld', 03:44:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:44:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:44:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:25 INFO - 'XPC_FLAGS': '0x0', 03:44:25 INFO - 'XPC_SERVICE_NAME': '0', 03:44:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:44:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:25 INFO - Downloading/unpacking jsonschema 03:44:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:44:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:44:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:44:28 INFO - Downloading/unpacking functools32 (from jsonschema) 03:44:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:44:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:44:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:28 INFO - Downloading functools32-3.2.3-2.tar.gz 03:44:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:44:28 INFO - warning: no files found matching '*.txt' 03:44:28 INFO - no previously-included directories found matching 'build' 03:44:28 INFO - no previously-included directories found matching 'dist' 03:44:28 INFO - no previously-included directories found matching '.git*' 03:44:28 INFO - Installing collected packages: jsonschema, functools32 03:44:28 INFO - Running setup.py install for functools32 03:44:28 INFO - warning: no files found matching '*.txt' 03:44:28 INFO - no previously-included directories found matching 'build' 03:44:28 INFO - no previously-included directories found matching 'dist' 03:44:28 INFO - no previously-included directories found matching '.git*' 03:44:28 INFO - Successfully installed jsonschema functools32 03:44:28 INFO - Cleaning up... 03:44:28 INFO - Return code: 0 03:44:28 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:44: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')]} 03:44:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44: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')]} 03:44:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c758a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c768420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9d14b85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5f7e00>, '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 0x10c420db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c5f2b20>, '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.hRW2vyMvDd/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.jAOh8sckQl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:44:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:44:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:44:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hRW2vyMvDd/Render', 03:44:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:44:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:44:28 INFO - 'HOME': '/Users/cltbld', 03:44:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:44:28 INFO - 'LOGNAME': 'cltbld', 03:44:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:28 INFO - 'MOZ_NO_REMOTE': '1', 03:44:28 INFO - 'NO_EM_RESTART': '1', 03:44:28 INFO - 'PAGER': '/bin/cat', 03:44:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:44:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:28 INFO - 'PWD': '/builds/slave/test', 03:44:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:44:28 INFO - 'SHELL': '/bin/bash', 03:44:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jAOh8sckQl/Listeners', 03:44:28 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 03:44:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:44:28 INFO - 'USER': 'cltbld', 03:44:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:44:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:44:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:28 INFO - 'XPC_FLAGS': '0x0', 03:44:28 INFO - 'XPC_SERVICE_NAME': '0', 03:44:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:44:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:29 INFO - Downloading/unpacking flake8 03:44:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:44:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:44:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:31 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:44:31 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:44:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:44:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:44:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:31 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:44:31 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:44:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:44:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:44:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:32 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:44:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:44:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:44:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:44:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:44:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:44:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:44:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:44:32 INFO - no previously-included directories found matching 'docs/_build' 03:44:32 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:44:32 INFO - Running setup.py install for pep8 03:44:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:44:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:44:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:44:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:44:33 INFO - no previously-included directories found matching 'docs/_build' 03:44:33 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:44:33 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:44:33 INFO - Cleaning up... 03:44:33 INFO - Return code: 0 03:44:33 INFO - Running post-action listener: _resource_record_post_action 03:44:33 INFO - Running post-action listener: _start_resource_monitoring 03:44:33 INFO - Starting resource monitoring. 03:44:33 INFO - ##### 03:44:33 INFO - ##### Running install step. 03:44:33 INFO - ##### 03:44:33 INFO - Running pre-action listener: _resource_record_pre_action 03:44:33 INFO - Running main action method: install 03:44:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:44:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:44:33 INFO - Reading from file tmpfile_stdout 03:44:33 INFO - Detecting whether we're running mozinstall >=1.0... 03:44:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:44:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:44:33 INFO - Reading from file tmpfile_stdout 03:44:33 INFO - Output received: 03:44:33 INFO - Usage: mozinstall [options] installer 03:44:33 INFO - Options: 03:44:33 INFO - -h, --help show this help message and exit 03:44:33 INFO - -d DEST, --destination=DEST 03:44:33 INFO - Directory to install application into. [default: 03:44:33 INFO - "/builds/slave/test"] 03:44:33 INFO - --app=APP Application being installed. [default: firefox] 03:44:33 INFO - mkdir: /builds/slave/test/build/application 03:44:33 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'] 03:44:33 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 03:45:07 INFO - Reading from file tmpfile_stdout 03:45:07 INFO - Output received: 03:45:07 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:45:07 INFO - Running post-action listener: _resource_record_post_action 03:45:07 INFO - ##### 03:45:07 INFO - ##### Running run-tests step. 03:45:07 INFO - ##### 03:45:07 INFO - Running pre-action listener: _resource_record_pre_action 03:45:07 INFO - Running main action method: run_tests 03:45:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:45:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:45:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:45:07 INFO - 2016-04-15 03:45:07.254 screenresolution[7122:130954] starting screenresolution argv=screenresolution get 03:45:07 INFO - 2016-04-15 03:45:07.257 screenresolution[7122:130954] Display 0: 1600x1200x32@60 03:45:07 INFO - 2016-04-15 03:45:07.262 screenresolution[7123:130957] starting screenresolution argv=screenresolution list 03:45:07 INFO - Available Modes on Display 0 03:45:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:45:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:45:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:45:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:45:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:45:07 INFO - Intel Iris: 03:45:07 INFO - Chipset Model: Intel Iris 03:45:07 INFO - Type: GPU 03:45:07 INFO - Bus: Built-In 03:45:07 INFO - VRAM (Dynamic, Max): 1536 MB 03:45:07 INFO - Vendor: Intel (0x8086) 03:45:07 INFO - Device ID: 0x0a2e 03:45:07 INFO - Revision ID: 0x0009 03:45:07 INFO - Displays: 03:45:07 INFO - Display: 03:45:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:45:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:45:07 INFO - Display Serial Number: 1600x1200 60 03:45:07 INFO - Main Display: Yes 03:45:07 INFO - Mirror: Off 03:45:07 INFO - Online: Yes 03:45:07 INFO - Rotation: Supported 03:45:07 INFO - Return code: 0 03:45:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:45:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:45:07 INFO - Python 2.7.3 03:45:07 INFO - Return code: 0 03:45:07 INFO - grabbing minidump binary from tooltool 03:45:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:07 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 0x10c5f7e00>, '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 0x10c420db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c5f2b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:45:07 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:45:07 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 03:45:07 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:45:07 INFO - Return code: 0 03:45:07 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:45:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:45:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:45:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:45:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:45:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:45:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:45:08 INFO - Return code: 0 03:45:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PlPF6wH1SqurAMmEVhKS_g/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0112', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:45:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PlPF6wH1SqurAMmEVhKS_g/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0112 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:45:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hRW2vyMvDd/Render', 03:45:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:45:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:45:08 INFO - 'HOME': '/Users/cltbld', 03:45:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:45:08 INFO - 'LOGNAME': 'cltbld', 03:45:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:45:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:45:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:08 INFO - 'MOZ_NO_REMOTE': '1', 03:45:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:45:08 INFO - 'NO_EM_RESTART': '1', 03:45:08 INFO - 'PAGER': '/bin/cat', 03:45:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:45:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:08 INFO - 'PWD': '/builds/slave/test', 03:45:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:45:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:45:08 INFO - 'SHELL': '/bin/bash', 03:45:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jAOh8sckQl/Listeners', 03:45:08 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 03:45:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:45:08 INFO - 'USER': 'cltbld', 03:45:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:45:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:45:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:08 INFO - 'XPC_FLAGS': '0x0', 03:45:08 INFO - 'XPC_SERVICE_NAME': '0', 03:45:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:45:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PlPF6wH1SqurAMmEVhKS_g/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0112', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:45:09 INFO - mozversion application_buildid: 20160415024941 03:45:09 INFO - mozversion application_changeset: b7772a6288f8b1011e1dfc8629ced4f401e47c9c 03:45:09 INFO - mozversion application_display_name: Nightly 03:45:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:45:09 INFO - mozversion application_name: Firefox 03:45:09 INFO - mozversion application_remotingname: firefox 03:45:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:45:09 INFO - mozversion application_vendor: Mozilla 03:45:09 INFO - mozversion application_version: 48.0a1 03:45:09 INFO - mozversion platform_buildid: 20160415024941 03:45:09 INFO - mozversion platform_changeset: b7772a6288f8b1011e1dfc8629ced4f401e47c9c 03:45:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:45:09 INFO - mozversion platform_version: 48.0a1 03:45:09 INFO - using testdate: 1460717109 03:45:09 INFO - actual date: 1460717109 03:45:09 INFO - starting webserver on 'localhost:64246' 03:45:09 INFO - SUITE-START | Running 2 tests 03:45:09 INFO - TEST-START | dromaeo_css 03:45:09 INFO - operating with platform_type : mac_ 03:45:09 INFO - Initialising browser for dromaeo_css test... 03:45:09 INFO - TEST-INFO | started process 7141 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmpHtpzkJ/profile http://localhost:64246/getInfo.html) 03:45:11 INFO - PROCESS | 7141 | __metrics Screen width/height:1600/1200 03:45:11 INFO - PROCESS | 7141 | colorDepth:24 03:45:11 INFO - PROCESS | 7141 | Browser inner width/height: 1024/689 03:45:11 INFO - PROCESS | 7141 | __metrics 03:45:11 INFO - PROCESS | 7141 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:45:11 ERROR - PROCESS | 7141 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:45:11 INFO - TEST-INFO | 7141: exit 0 03:45:11 INFO - Browser initialized. 03:45:11 INFO - Running cycle 1/1 for dromaeo_css test... 03:45:11 INFO - TEST-INFO | started process 7143 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmpHtpzkJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:45:23 INFO - PROCESS | 7143 | RSS: Main: 237682688 03:45:23 INFO - PROCESS | 7143 | 03:46:15 INFO - PROCESS | 7143 | 1460717175266 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:48:25 INFO - PROCESS | 7143 | Cycle 1(1): loaded http://localhost:64246/tests/dromaeo/cssquery-dojo.html (next: http://localhost:64246/tests/dromaeo/cssquery-ext.html) 03:48:26 INFO - PROCESS | 7143 | RSS: Main: 371859456 03:48:26 INFO - PROCESS | 7143 | 03:51:29 INFO - PROCESS | 7143 | Cycle 1(1): loaded http://localhost:64246/tests/dromaeo/cssquery-ext.html (next: http://localhost:64246/tests/dromaeo/cssquery-jquery.html) 03:51:30 INFO - PROCESS | 7143 | RSS: Main: 378605568 03:51:30 INFO - PROCESS | 7143 | 03:54:32 INFO - PROCESS | 7143 | Cycle 1(1): loaded http://localhost:64246/tests/dromaeo/cssquery-jquery.html (next: http://localhost:64246/tests/dromaeo/cssquery-mootools.html) 03:54:32 INFO - PROCESS | 7143 | RSS: Main: 378167296 03:54:32 INFO - PROCESS | 7143 | 03:57:34 INFO - PROCESS | 7143 | Cycle 1(1): loaded http://localhost:64246/tests/dromaeo/cssquery-mootools.html (next: http://localhost:64246/tests/dromaeo/cssquery-prototype.html) 03:57:35 INFO - PROCESS | 7143 | RSS: Main: 378982400 03:57:35 INFO - PROCESS | 7143 | 04:00:38 INFO - PROCESS | 7143 | Cycle 1(1): loaded http://localhost:64246/tests/dromaeo/cssquery-prototype.html (next: http://localhost:64246/tests/dromaeo/cssquery-yui.html) 04:00:39 INFO - PROCESS | 7143 | RSS: Main: 351371264 04:00:39 INFO - PROCESS | 7143 | 04:03:42 INFO - PROCESS | 7143 | Cycle 1(1): loaded http://localhost:64246/tests/dromaeo/cssquery-yui.html (next: http://localhost:64246/tests/dromaeo/cssquery-dojo.html) 04:03:42 INFO - PROCESS | 7143 | RSS: Main: 386195456 04:03:42 INFO - PROCESS | 7143 | 04:03:42 INFO - PROCESS | 7143 | __start_tp_report 04:03:42 INFO - PROCESS | 7143 | _x_x_mozilla_page_load 04:03:42 INFO - PROCESS | 7143 | _x_x_mozilla_page_load_details 04:03:42 INFO - PROCESS | 7143 | |i|pagename|runs| 04:03:42 INFO - PROCESS | 7143 | |0;dojo.html;3348.4140275451796;3375.4599264117746;3407.182276253699;3413.8463769130385;3425.725941924646;5563;5684.090545512714;5685.800996965107;5719.828405147852;5735.225744524493;5691.601587888849;5694.5159661428725;5734.913976290359;5783.82648520544;5800.82597522074;5070.797168113271;5084.669496482717;5107.387113546361;5112.437631860493;5223.817166399177;5217.86955326118;5245.659032162897;5255.185446255837;5255.921161182585;5298.337707786527;5082.974585127087;5127.717975511346;5158.664686795346;5175.585953123741;5191.117510023286;5023.196288593807;5100.846974590768;5135.897282054375;5155.149400348938;5167.0957582422925;5069.695818250917;5081.974590127025;5109.693418394908;5182.714950677711;5205;5450.645708028966;5578.41426650204;5603.551715862762;5609.76585151266;5620.803271885506;6072.735419311495;6093;6123.418275263843;6151.292601350812;6172.043333283348;6050;6110.7861224856915;6129.417705317987;6135.171751813493;6138.8643101026455;5667.829965101054;5763.077907534775;5765.221695071154;5766.855828604276;5770.855728606818;6163.568550201443;6211.0372892201785;6234.750609975641;6246.531510136758;6253.749850005949;6040.395960403925;6049.092636104531;6085;6089.543284253698;6096;5433.945660543344;6028.879422411527;6165.136880836686;6180.598261113103;6190.50475961922;6080.2399700037495;6123.557162997564;6127.097902969389;6157.907631385533;6166.260048794174;6102.655998083295;6175.197224360804;6178.62928224308;6182.814515564541;6191.4118158774845;4790.089882922303;4889.315495830587;4899.779509922062;4903.901921961612;4933.87665308363;4405.449318835145;4424.778761061934;4436.223660859337;4456.732596044248;4474.6867719259335;5593.608447408642;5595.328560572757;5602.159676048544;5608.383077861432;5610.97194514033;6109.708332504907;6174.783882564178;6177.351378105234;6178.598391104564;6179.474744646665;5584.106542953108;5631.127175287755;5631.211630371751;5631.465010823965;5647.887042259132;5312.76092575835;5318.680879147263;5329.626926115135;5332.226827110047;5347.4712409296835;5120.411152717411;6257.7184026719815;6279.215098112736;6293.622382657055;6293.905591416133;6179.3202747698615;6196.132541444112;6196.504279657526;6204.348543402878;6224.751009959732;6286.905696414466;6289.339619340087;6291.905621415591;6295.213098362705;6303.243610766737;6012.8797424052145;6032.6983650818165;6081.422264884829;6131.019036954066;6142.161149281699;6141.7543298267565;6150.50795936333;6155.630662160284;6159.29168145669;6176.135341052346;4765.523447655207;6008.969955150196;6016.2479690038745;6028;6086.6652334122045;5897.997340452048;5978.402159784161;6029.909551356821;6047.727852246748;6101.633901965896;5861.824145275648;5863.120531920246;5895.764169433346;5921.733521991435;5927.940720592739;5900.7049647518315;6044.848878778066;6062.090686397076;6066.211392519121;6127.387261273837;5738.885222295447;5854.882902342015;5855.443732845373;5858.47273745348;5859.5019423349495 04:03:42 INFO - PROCESS | 7143 | |1;ext.html;490.04930434956185;491.46921324969037;496.27543786072357;498.0984418203055;507.9441261461237;28622.855085796567;31047;39450.8027459863;40139.982502187224;40218.39672404916;42407.36388954168;43006.56993430065;43115.35326970098;43154;43167;9558.999999999982;9763.121319081281;9768.511574421285;9768.706938791813;9782.657606983757;9591.808163836718;9687.951560242189;9733.902660973406;9756.024397560259;9759.072888075658;9802.754931126708;9866.605335786597;9874.555644995957;9884.159846413027;9887.011298870128;9796.706098817047;9853.655122070693;9863.852042219336;9865;9866.703998880044;9614.71155865325;9741.561629726679;9745.12293893553;9748.805023899553;9773.755656108584;39190;39453.21093578112;39481.60518394808;39518.60481395178;39539.60460395388;3199.3441344524317;3224.3712476067176;3405.7786243894066;3476.2526056897887;3740.401535754266;29115.854420727974;29243.85378073096;29591.408171836658;29810.956616518317;30169.396612067856;2664.2406914029407;2743.6021776842244;2746.5468197747346;2747.4779791839687;2837.815541989764;447010;449754;449864;450291;450538;63707.681461592394;64001.35998639954;64053;64087;64228.678856606355;67367;69731;71680.2831971684;71792;71831;17077.316907323817;17094.487165385057;17327.740083898752;17331;17394.47816565505;12802.743945121045;12849.10056296069;12890.677733056562;12891.16207446513;12933.417996190194;20105.79894201039;20126.89936550308;20127.39617811468;20166.899165504372;20182;6418.839529011812;6754.729810807513;7989.961305030425;8154.347652187811;8185.263326300662;947.1428357336621;1001.639409812467;1042.8957104289511;1131.728385187549;1141.5490881101919;29840.850795745882;29949.700502995125;30185.849070754946;30527.08418747441;30689.38621227563;1048.6539441984128;1062.39443517196;1085.3216739537788;1115.726646971481;1126.2510430563748;15573.299201535958;15584.688306233811;15666.295016724274;15877.841221587636;15885.602859928595;605238;613756;615610;616621;617652;59858;62561;62599.37400626027;62625.74748505095;62711.37288627146;1223.2660403757852;1320.544412177797;1454.2365258239508;1455.2796365798786;1499.317810396289;29757.404851902407;30309.39381212319;30516;30588.66916513838;30876;51988.480115199876;52769.20846187234;53310.93378132338;53318;53454.46545534495;452711;462834;466522.68034536665;466740;466845.66577166895;42654.36018459663;42870.78564607157;43005.56994430016;43798.56201437945;43870.12259754851;46651.766741167434;47065.2940205904;47310;47811.76094119507;48861.51138488569;38175;38177.61822381741;38255.61744382632;39479.80260098681;39592.208155837296;30944.69055309418;33162.010279383314;37672.43491347577;38173.61826381701;39306.803465982484;37715.245695086494;37776.244475109794;38241.2351752969;38382.42426363551;38652.6134738649;31012.22469438282;32583.348333033682;33269.50095748517;33977.66022339745;34009.48985765265;24575;25144.11995580146;25669.358266042753;25687.743122568536;25787.613185801853 04:03:42 INFO - PROCESS | 7143 | |2;jquery.html;331.7114110723669;370.4073482428115;389.91032062625595;399.8980260033691;410.5524977774229;12973.805392919114;16030.7595386069;19067.618647627056;20604.587908241843;20610.99999999998;17748.378806741766;19945;19987.100580473878;20326.882021488847;20340.694889576633;5288.312519372485;5916.497097746696;5948.048312270038;5951.702414879261;5954.642721436728;3712.1462063725226;5405.648632838873;6197.349278325756;6546.607203567777;6585.769498067569;6364.268109167436;6488.935110648904;6528.673566321689;6543.770968016121;6544.2801291858095;6284.87430251397;6472.6763661817195;6499.350064993463;6500.407400186938;6512.023196520512;5447.809326673548;5707.400722924116;5711.971440142815;5744.224529688522;5747.252857128547;24936;25197.748022519907;25431.61852572213;25920;26049.479010419687;2194.1004188282886;2461.052494789501;2651.2178907222224;2709.498742732581;3090.211995941043;14194;14563.70872582553;14746.115233085942;14841.183734894577;15408.3836646534;1689.9746503802453;1754.1054062428254;1757.6295297622373;1811.1306572845108;1813.718873574598;102510;107583;108469.45765271202;114638;118727.99999999914;9830.672859164064;11265.26775759573;11381.203315767816;11395.943020284845;11485.885141148648;14963.102213866985;15106.169160696047;15252.466163684217;15260.542183734506;15266.542003739905;6933.4106600939485;8672.523011234316;8679.913200868037;8799.736007919773;8802.779930501789;6141.662208578482;8508.957455212685;8536.658533658709;8626.223639872316;8635.6977505787;4559.156556037144;4588.908221835544;4613.423322084739;4619.076184762994;4636.466806317249;1643.6712657468315;1900.5818719881604;1952.384998725397;1953.8729982551088;1959.892205928659;884.5002573545926;918.669279059538;941.2658126661215;948.0803620488116;1046.4035499765062;16475.258613362428;19151.52121196981;20163.043749906257;20328.390148295573;20714;967.5210770668424;980.9705708828747;987.8073775613686;1001.8948010458797;1024.8052869954686;8963.148500892405;9599.712008639752;11104.333739975627;11118;11152.888471115184;509817;517374;518283;545964;586657;127949;136519;136739;137332;140567;437.9737215767064;458.7064278861531;460.1349463009521;461.12156342168225;461.3172504693006;7714.4599878008;9812.675288835915;9851.901480985385;11081.778364432828;11362.14783891228;36668.81665591655;45868;47358;48088.75955620199;49415;65446.345536544024;66419.33580664324;67456.6627166861;68346;68643.97034044394;8041.155678653658;8047.356211502949;8101.432899696964;8315.376346773895;8344.749657510285;11169.776604468028;12291.32397718134;12469.376531173224;12673.746525069262;12691.428885699981;9873.160781333667;10553.472326383497;10700.304480209074;10846.24076314682;10998.835017474585;9908.058734420218;10271.537780800032;10410.063094321547;10525.842112368167;10903.890961090288;10631.8936810634;10882.727931801768;11221.326720396803;11447.656570302905;11490.195686301879;8144.429889907649;8147.551884646165;8274.544900030556;8323.167683231628;8537.31701463869;9539.76150596213;10970.286931349438;11025.117990560575;11025.944870275598;11071.50178241965 04:03:42 INFO - PROCESS | 7143 | |3;mootools.html;1410.027081313894;1578.7868637733907;1612.4275882061868;1827.132112246683;1959.8922059286742;7025.402840758536;7906.92093079069;8756.343274254425;8768.254698350647;8773.912260877381;8371.91628083719;8618.827623447527;8621.439606425578;8625.26685231756;8641.611127499262;2143.67844823277;2386.737458879522;2434.756524347564;2452.877356132195;2460.4709987352717;2452.2275483222816;2472.171822439485;2478.7893029092547;2479.5536803375385;2479.6404521344393;2004.1983206717284;2355.199232261031;2401.327628264089;2401.7238017628024;2402.3873912152376;2127.957440851182;2344.1326709117734;2419.4677171022345;2421.128393778238;2430.222328854767;2360.2683168217736;2386.737458879522;2388.9522209555885;2393.5452264069945;2394.988025059881;8558.315334773204;8625.913740862574;8637.222649961534;8637.39538232324;8639.39524233304;5108.897822043576;5191.792328306863;5278.736063196825;5287.920681189786;5311.521963023347;2853.857307134656;3401.693847553732;3470.4273794823825;3475.6176820549717;3482.2687235680537;1000.3447741729179;1000.5547531348553;1013.083159740436;1014.7463134216446;1019.1744686803713;11633.6509904703;11657.591984280509;11703.356315402649;11735.295882247092;11737;4387.890302742393;4616.169089563844;4618.95381046192;4815.374001379798;4860.902781944412;9783.36408133469;9845.261605379625;9855.26085543587;9873.358231714916;9896.653617123366;5100.413452453015;5106.131957567148;5114.667546609458;5123.205903085028;5136.768845401966;4366.781660916941;4536.228841097021;4684.203685373494;4860.708357498491;4877.561019508261;3912.6087391260644;3933.7246392752804;4026;4040.252553277653;4057.8435145983253;1301.1607513154152;1326.5025615394227;1333.0735139078442;1334.6463187255385;1338.8393392792927;755.9055118110236;878.8593824987971;917.3761841947539;917.9678711245074;947.488356287597;5777.133429985536;5782.450667186695;5824.767009319579;6096.908546371808;6109.450149486479;887.9689210877589;910.6266430763355;917.8531434970373;937.4328531238502;949.0888746803147;3767.9811600942367;3810.466534685146;3885.941710874339;3895.5325360956867;3961.5840336764227;8715.38992270535;10497.212709046851;10551.261411701107;10560.947195263974;10728.195385346131;10644.574217031231;10653.893461065445;10656.20078494116;10670.199735019905;10670.839937400946;8056.959715201387;8108.310793582494;8189.50862948225;8300.04549476818;8311.044229913516;5618.915716264341;5797.565182611237;5817.738201780845;5839.416058394127;5848.824535263949;9775.804483910424;9805.068518490732;9989.100980911753;10008.299419040597;10015.549300281358;10032.046955539212;10054;10179.796404071729;10317.226208034577;10324.174066074846;6758.121444212221;6959.304069593203;7043.084399028094;7234.74678386254;7339.889901651372;8140.470869393471;8151.062627797879;8220.917790822015;8225.547594882339;8230.135835737161;6993.580385176906;7109.680064397218;7130.108736407949;7240.855182896418;7260.382867456326;7295.2340004298785;7367.846870971026;7369.336759691653;7377.114746230487;7414.888776668462;6864.347886950732;6902.206246281742;6958.443324533924;6962.477814163856;6966.895496567454;3966.9206615868097;4813.687110337817;4891.90216195667;4960.70235785854;5068.949310506995;4813.687110337817;4836.419629644465;4838.637102217418;4896.436909755424;5056.988602279485 04:03:42 INFO - PROCESS | 7143 | |4;prototype.html;310.3467201540756;316.11487834064616;319.39155907995263;324.7629230661617;329.49587131688526;5706.429357064291;5765.7981970631035;5778.133280008001;5779.971100144493;5791.7972870949525;4747.3353730477675;5621.353544342402;5650.316099852568;5667.433256674331;5677.233573467581;3528.9294214115703;4016.49793775778;4062.2078694654406;4151.529839745362;4189.308764053927;4183.477065366829;4233.788310584474;4264.360345948117;4293.29160688486;4295.291276939317;3546.556680414948;4265.552117027699;4278.957210427902;4282.972086699201;4310.245707001278;4027.2750904837117;4070.715049946505;4276.5295817460055;4298.978505107454;4306.590873866978;3418.9658103418897;3687.1888184599347;3702.685271751904;3704.1480459494196;3719.5722491913234;4723.433188017426;4817.5080408334525;5407.621466497347;5455;5462.481064298885;3658.2623253954157;4485.439320084989;4860.878478038042;4873.902521949542;4938.259261110827;5366.302380690524;5413.079776437976;5678.318601767773;5937.495312898409;5971.761129554812;3355.3792548378383;4011.509986311898;4022.7184097113213;4034.3141665916864;4042.3734321180264;6038;6198.845028874314;6232.75068997235;6308.804644911174;6345.143405640226;3710.5176327077847;3797.411401232813;4051.3261247576456;4074.246264441088;4091.2384140704903;4124.443200167999;4149.460570125864;4154.459920210414;4158.563350848178;4169.10364271683;4704.388429504143;4868.902621947612;4878.195097808893;4959.479254678206;4966.379202599675;5428.941356435457;5958.851028724316;5997.551407940452;6110.388961103854;6129.601575897553;1472.9337179826935;1497.7229212595705;1505.510709019573;1507.9246037698072;1508.8566586174295;880.8592872230477;935.8455854784021;953.580424613168;998.5306905754284;1027.409239687183;4172.415861779354;5169.741512924339;5410.78356865721;5560.805371812048;5634.830955071355;6265.216847894013;6369.426751592379;6371.808845734636;6377.457916077093;6382.648954307558;4701.741404222732;5679.460451257124;5680.147977803363;5690.260266165372;5696.829095127153;3160.9683903161135;3299.3896129216173;3303.785253958485;3311.2053107254087;3345.749068819848;5752.827415177551;6234.563580549318;6580.8354791130605;6626.370494802986;6628.8674226515195;6482.708278127496;6496.902546461807;6504.447121994589;6515.543911926215;6537.477001839841;5427.701476418756;5495.642783219078;5739.598228124075;6473.676316184172;6604.207495100619;6022.608530445507;6104.969475152596;6190.41191086846;6227.813165605039;6335.588186767845;4886.389201349832;5154.742262886915;5413.941123265343;5958.136070269873;6116.776644670995;6460;6464.46536182092;6552.921485848506;6597.769078082244;6618.536702430976;3739.1773809761808;4033.153037862082;4059.817308221078;4069.8575549855614;4073.3889916512762;5261.89476210466;6177.2587289525545;6265.906011409741;6308.747650093945;6353.301136875032;4582.266837306015;5584.274044374205;5876.294844618673;6023.187623942916;6122.357152499102;5352.277442545206;5851.377411844765;6085.148079268817;6085.604435711664;6102.267727872683;4630.665920537208;5979.790707325223;5982.46157845796;5992.221011268507;5998.1105951625095;5506.669599824023;5901.793437229677;5938.2280303560265;6045.581767293118;6073.665948372882;4687.695299805502;5310.867228319168;5605.215269862141;5964.9105263420215;5972.104184372379 04:03:42 INFO - PROCESS | 7143 | |5;yui.html;672.7107343842148;717.9856402871945;749.2239114861101;755.8790593505037;807.047683733195;15539.456119035836;15567.143807090606;15587.298571564279;15599.22003899806;15609.843901560995;14534.200618965953;14583;14630.195339256337;14650.120992740443;14667.633309167277;711.1501755402296;731.2869951796982;872.8777971084053;908.7682640926571;921.7004473546091;904.8235594059161;908.3051465628766;909.0273407454027;909.2135302962922;909.5361365703505;953.7424895278306;975.9609615615367;976.5947131940236;979.8138353712808;980.6665733650557;753.3220101908299;929.1359036096428;959.2613687460686;966.5457235099492;967.9661211857587;724.1635910523354;724.4675163754636;726.8982342472058;727.752564128199;728.8505856299446;14883.33025013877;14918.850811491855;14979;14979.850201497955;15001.774973375408;12605.30670813105;12689.365531723377;12897.613071607866;12917.160384574972;13037.348132593332;8143.592820358958;9925.002872974535;10173.440460774655;10291.382517048925;10733.034026937614;3507.018034950218;3552.5559305086863;3558.3417067842274;3660.158163622355;3660.9816950915074;78781.60609196975;79517;81379.5931020347;81775;82063.58968205121;9489.810203796023;9502.524873756285;9674.854877176847;9834.901650983398;10209.846852297222;22123.778762212492;22267.77732222657;22283.442913926956;22297.44256393603;22332.33003009912;7575.886361704579;7625.961870190614;7830;7861.842763144705;7966.243206895336;4054.5134583850127;4132.483439570054;4134.855280065183;4139.027328577782;4144.730592511477;3500.8774692885627;3613.5483064616924;3615.5480564929385;3616.9276614467562;3618.3667858124722;615.3876892491999;628.6039794929256;631.8799428108645;646.2987658390605;654.2051407539861;493.767929073335;533.6797921247221;568.6957477749385;578.4013545979891;581.0702875399412;5800.448957349129;7417.109946806418;7491.3632341251605;7526;7978.84042319162;481.3573878871745;491.2287708297938;503.5266849161776;533.8692020455013;536.4983740202845;3630.419132938717;3671.3391589514144;3731.2910546995986;3762.360398732222;3779;71110;76738.61630691923;77080.22919770842;77329;80219.59890200512;68537.65731171412;71127;71281.2871871285;71734;72233;62107;62122;62545.68727156335;62629.68685156636;62897;7283.817904552428;7333.779986600411;7338.96330518344;7359.77920662381;7430;38428.71987530488;38569.228615428096;38585.614143858205;40419;40987.38518922278;54424.72787636037;54543.454565455424;56170.15744763913;56628.30115096553;58509.70745146247;9414.53924880716;9519.428834269966;9529.714108576754;9546.284028697737;9880.604775808888;10189.643362482277;10276.640317588848;10414.479276036016;10504.579816807547;10796.028357447867;9893.406395616286;9912.454814985245;9946.204303655546;9962.50187490608;10011.699649010541;9622.807543849223;9626.759331016501;9907.554160062671;9927.900720992697;9986.850197246902;9650.372725772802;9742.415455072718;9743;10045.748856278651;10102.242331824995;8219.671213151647;8329.458585191944;8469.195426434479;8660.653573856975;8680.826383472422;7919.574476594268;8230.588470576327;8356.7910802228;8531.53076580794;8652.56737163152 04:03:42 INFO - PROCESS | 7143 | __end_tp_report 04:03:42 INFO - PROCESS | 7143 | __start_cc_report 04:03:42 INFO - PROCESS | 7143 | _x_x_mozilla_cycle_collect,1325 04:03:42 INFO - PROCESS | 7143 | __end_cc_report 04:03:42 INFO - PROCESS | 7143 | __startTimestamp1460718222510__endTimestamp 04:03:42 INFO - PROCESS | 7143 | 04:03:42 INFO - PROCESS | 7143 | ------- Summary: start ------- 04:03:42 INFO - PROCESS | 7143 | Number of tests: 6 04:03:42 INFO - PROCESS | 7143 | 04:03:42 INFO - PROCESS | 7143 | [#0] dojo.html Cycles:165 Average:5669.94 Median:5859.50 stddev:621.02 (10.6%) stddev-sans-first:595.62 04:03:42 INFO - PROCESS | 7143 | Values: 3348.4 3375.5 3407.2 3413.8 3425.7 5563.0 5684.1 5685.8 5719.8 5735.2 5691.6 5694.5 5734.9 5783.8 5800.8 5070.8 5084.7 5107.4 5112.4 5223.8 5217.9 5245.7 5255.2 5255.9 5298.3 5083.0 5127.7 5158.7 5175.6 5191.1 5023.2 5100.8 5135.9 5155.1 5167.1 5069.7 5082.0 5109.7 5182.7 5205.0 5450.6 5578.4 5603.6 5609.8 5620.8 6072.7 6093.0 6123.4 6151.3 6172.0 6050.0 6110.8 6129.4 6135.2 6138.9 5667.8 5763.1 5765.2 5766.9 5770.9 6163.6 6211.0 6234.8 6246.5 6253.7 6040.4 6049.1 6085.0 6089.5 6096.0 5433.9 6028.9 6165.1 6180.6 6190.5 6080.2 6123.6 6127.1 6157.9 6166.3 6102.7 6175.2 6178.6 6182.8 6191.4 4790.1 4889.3 4899.8 4903.9 4933.9 4405.4 4424.8 4436.2 4456.7 4474.7 5593.6 5595.3 5602.2 5608.4 5611.0 6109.7 6174.8 6177.4 6178.6 6179.5 5584.1 5631.1 5631.2 5631.5 5647.9 5312.8 5318.7 5329.6 5332.2 5347.5 5120.4 6257.7 6279.2 6293.6 6293.9 6179.3 6196.1 6196.5 6204.3 6224.8 6286.9 6289.3 6291.9 6295.2 6303.2 6012.9 6032.7 6081.4 6131.0 6142.2 6141.8 6150.5 6155.6 6159.3 6176.1 4765.5 6009.0 6016.2 6028.0 6086.7 5898.0 5978.4 6029.9 6047.7 6101.6 5861.8 5863.1 5895.8 5921.7 5927.9 5900.7 6044.8 6062.1 6066.2 6127.4 5738.9 5854.9 5855.4 5858.5 5859.5 04:03:42 INFO - PROCESS | 7143 | 04:03:42 INFO - PROCESS | 7143 | [#1] ext.html Cycles:180 Average:66079.69 Median:39565.91 stddev:136910.95 (346.0%) stddev-sans-first:137206.46 04:03:42 INFO - PROCESS | 7143 | Values: 490.0 491.5 496.3 498.1 507.9 28622.9 31047.0 39450.8 40140.0 40218.4 42407.4 43006.6 43115.4 43154.0 43167.0 9559.0 9763.1 9768.5 9768.7 9782.7 9591.8 9688.0 9733.9 9756.0 9759.1 9802.8 9866.6 9874.6 9884.2 9887.0 9796.7 9853.7 9863.9 9865.0 9866.7 9614.7 9741.6 9745.1 9748.8 9773.8 39190.0 39453.2 39481.6 39518.6 39539.6 3199.3 3224.4 3405.8 3476.3 3740.4 29115.9 29243.9 29591.4 29811.0 30169.4 2664.2 2743.6 2746.5 2747.5 2837.8 447010.0 449754.0 449864.0 450291.0 450538.0 63707.7 64001.4 64053.0 64087.0 64228.7 67367.0 69731.0 71680.3 71792.0 71831.0 17077.3 17094.5 17327.7 17331.0 17394.5 12802.7 12849.1 12890.7 12891.2 12933.4 20105.8 20126.9 20127.4 20166.9 20182.0 6418.8 6754.7 7990.0 8154.3 8185.3 947.1 1001.6 1042.9 1131.7 1141.5 29840.9 29949.7 30185.8 30527.1 30689.4 1048.7 1062.4 1085.3 1115.7 1126.3 15573.3 15584.7 15666.3 15877.8 15885.6 605238.0 613756.0 615610.0 616621.0 617652.0 59858.0 62561.0 62599.4 62625.7 62711.4 1223.3 1320.5 1454.2 1455.3 1499.3 29757.4 30309.4 30516.0 30588.7 30876.0 51988.5 52769.2 53310.9 53318.0 53454.5 452711.0 462834.0 466522.7 466740.0 466845.7 42654.4 42870.8 43005.6 43798.6 43870.1 46651.8 47065.3 47310.0 47811.8 48861.5 38175.0 38177.6 38255.6 39479.8 39592.2 30944.7 33162.0 37672.4 38173.6 39306.8 37715.2 37776.2 38241.2 38382.4 38652.6 31012.2 32583.3 33269.5 33977.7 34009.5 24575.0 25144.1 25669.4 25687.7 25787.6 04:03:42 INFO - PROCESS | 7143 | 04:03:42 INFO - PROCESS | 7143 | [#2] jquery.html Cycles:180 Average:32503.46 Median:18519.61 stddev:90093.37 (486.5%) stddev-sans-first:90313.72 04:03:42 INFO - PROCESS | 7143 | Values: 331.7 370.4 389.9 399.9 410.6 12973.8 16030.8 19067.6 20604.6 20611.0 17748.4 19945.0 19987.1 20326.9 20340.7 5288.3 5916.5 5948.0 5951.7 5954.6 3712.1 5405.6 6197.3 6546.6 6585.8 6364.3 6488.9 6528.7 6543.8 6544.3 6284.9 6472.7 6499.4 6500.4 6512.0 5447.8 5707.4 5712.0 5744.2 5747.3 24936.0 25197.7 25431.6 25920.0 26049.5 2194.1 2461.1 2651.2 2709.5 3090.2 14194.0 14563.7 14746.1 14841.2 15408.4 1690.0 1754.1 1757.6 1811.1 1813.7 102510.0 107583.0 108469.5 114638.0 118728.0 9830.7 11265.3 11381.2 11395.9 11485.9 14963.1 15106.2 15252.5 15260.5 15266.5 6933.4 8672.5 8679.9 8799.7 8802.8 6141.7 8509.0 8536.7 8626.2 8635.7 4559.2 4588.9 4613.4 4619.1 4636.5 1643.7 1900.6 1952.4 1953.9 1959.9 884.5 918.7 941.3 948.1 1046.4 16475.3 19151.5 20163.0 20328.4 20714.0 967.5 981.0 987.8 1001.9 1024.8 8963.1 9599.7 11104.3 11118.0 11152.9 509817.0 517374.0 518283.0 545964.0 586657.0 127949.0 136519.0 136739.0 137332.0 140567.0 438.0 458.7 460.1 461.1 461.3 7714.5 9812.7 9851.9 11081.8 11362.1 36668.8 45868.0 47358.0 48088.8 49415.0 65446.3 66419.3 67456.7 68346.0 68644.0 8041.2 8047.4 8101.4 8315.4 8344.7 11169.8 12291.3 12469.4 12673.7 12691.4 9873.2 10553.5 10700.3 10846.2 10998.8 9908.1 10271.5 10410.1 10525.8 10903.9 10631.9 10882.7 11221.3 11447.7 11490.2 8144.4 8147.6 8274.5 8323.2 8537.3 9539.8 10970.3 11025.1 11025.9 11071.5 04:03:42 INFO - PROCESS | 7143 | 04:03:42 INFO - PROCESS | 7143 | [#3] mootools.html Cycles:180 Average:5632.46 Median:4884.73 stddev:3153.72 (64.6%) stddev-sans-first:3146.60 04:03:42 INFO - PROCESS | 7143 | Values: 1410.0 1578.8 1612.4 1827.1 1959.9 7025.4 7906.9 8756.3 8768.3 8773.9 8371.9 8618.8 8621.4 8625.3 8641.6 2143.7 2386.7 2434.8 2452.9 2460.5 2452.2 2472.2 2478.8 2479.6 2479.6 2004.2 2355.2 2401.3 2401.7 2402.4 2128.0 2344.1 2419.5 2421.1 2430.2 2360.3 2386.7 2389.0 2393.5 2395.0 8558.3 8625.9 8637.2 8637.4 8639.4 5108.9 5191.8 5278.7 5287.9 5311.5 2853.9 3401.7 3470.4 3475.6 3482.3 1000.3 1000.6 1013.1 1014.7 1019.2 11633.7 11657.6 11703.4 11735.3 11737.0 4387.9 4616.2 4619.0 4815.4 4860.9 9783.4 9845.3 9855.3 9873.4 9896.7 5100.4 5106.1 5114.7 5123.2 5136.8 4366.8 4536.2 4684.2 4860.7 4877.6 3912.6 3933.7 4026.0 4040.3 4057.8 1301.2 1326.5 1333.1 1334.6 1338.8 755.9 878.9 917.4 918.0 947.5 5777.1 5782.5 5824.8 6096.9 6109.5 888.0 910.6 917.9 937.4 949.1 3768.0 3810.5 3885.9 3895.5 3961.6 8715.4 10497.2 10551.3 10560.9 10728.2 10644.6 10653.9 10656.2 10670.2 10670.8 8057.0 8108.3 8189.5 8300.0 8311.0 5618.9 5797.6 5817.7 5839.4 5848.8 9775.8 9805.1 9989.1 10008.3 10015.5 10032.0 10054.0 10179.8 10317.2 10324.2 6758.1 6959.3 7043.1 7234.7 7339.9 8140.5 8151.1 8220.9 8225.5 8230.1 6993.6 7109.7 7130.1 7240.9 7260.4 7295.2 7367.8 7369.3 7377.1 7414.9 6864.3 6902.2 6958.4 6962.5 6966.9 3966.9 4813.7 4891.9 4960.7 5068.9 4813.7 4836.4 4838.6 4896.4 5057.0 04:03:42 INFO - PROCESS | 7143 | 04:03:42 INFO - PROCESS | 7143 | [#4] prototype.html Cycles:180 Average:4853.90 Median:5428.32 stddev:1527.65 (28.1%) stddev-sans-first:1493.38 04:03:42 INFO - PROCESS | 7143 | Values: 310.3 316.1 319.4 324.8 329.5 5706.4 5765.8 5778.1 5780.0 5791.8 4747.3 5621.4 5650.3 5667.4 5677.2 3528.9 4016.5 4062.2 4151.5 4189.3 4183.5 4233.8 4264.4 4293.3 4295.3 3546.6 4265.6 4279.0 4283.0 4310.2 4027.3 4070.7 4276.5 4299.0 4306.6 3419.0 3687.2 3702.7 3704.1 3719.6 4723.4 4817.5 5407.6 5455.0 5462.5 3658.3 4485.4 4860.9 4873.9 4938.3 5366.3 5413.1 5678.3 5937.5 5971.8 3355.4 4011.5 4022.7 4034.3 4042.4 6038.0 6198.8 6232.8 6308.8 6345.1 3710.5 3797.4 4051.3 4074.2 4091.2 4124.4 4149.5 4154.5 4158.6 4169.1 4704.4 4868.9 4878.2 4959.5 4966.4 5428.9 5958.9 5997.6 6110.4 6129.6 1472.9 1497.7 1505.5 1507.9 1508.9 880.9 935.8 953.6 998.5 1027.4 4172.4 5169.7 5410.8 5560.8 5634.8 6265.2 6369.4 6371.8 6377.5 6382.6 4701.7 5679.5 5680.1 5690.3 5696.8 3161.0 3299.4 3303.8 3311.2 3345.7 5752.8 6234.6 6580.8 6626.4 6628.9 6482.7 6496.9 6504.4 6515.5 6537.5 5427.7 5495.6 5739.6 6473.7 6604.2 6022.6 6105.0 6190.4 6227.8 6335.6 4886.4 5154.7 5413.9 5958.1 6116.8 6460.0 6464.5 6552.9 6597.8 6618.5 3739.2 4033.2 4059.8 4069.9 4073.4 5261.9 6177.3 6265.9 6308.7 6353.3 4582.3 5584.3 5876.3 6023.2 6122.4 5352.3 5851.4 6085.1 6085.6 6102.3 4630.7 5979.8 5982.5 5992.2 5998.1 5506.7 5901.8 5938.2 6045.6 6073.7 4687.7 5310.9 5605.2 5964.9 5972.1 04:03:42 INFO - PROCESS | 7143 | 04:03:42 INFO - PROCESS | 7143 | [#5] yui.html Cycles:180 Average:16570.49 Median:35910.58 stddev:22748.59 (63.3%) stddev-sans-first:22781.08 04:03:42 INFO - PROCESS | 7143 | Values: 672.7 718.0 749.2 755.9 807.0 15539.5 15567.1 15587.3 15599.2 15609.8 14534.2 14583.0 14630.2 14650.1 14667.6 711.2 731.3 872.9 908.8 921.7 904.8 908.3 909.0 909.2 909.5 953.7 976.0 976.6 979.8 980.7 753.3 929.1 959.3 966.5 968.0 724.2 724.5 726.9 727.8 728.9 14883.3 14918.9 14979.0 14979.9 15001.8 12605.3 12689.4 12897.6 12917.2 13037.3 8143.6 9925.0 10173.4 10291.4 10733.0 3507.0 3552.6 3558.3 3660.2 3661.0 78781.6 79517.0 81379.6 81775.0 82063.6 9489.8 9502.5 9674.9 9834.9 10209.8 22123.8 22267.8 22283.4 22297.4 22332.3 7575.9 7626.0 7830.0 7861.8 7966.2 4054.5 4132.5 4134.9 4139.0 4144.7 3500.9 3613.5 3615.5 3616.9 3618.4 615.4 628.6 631.9 646.3 654.2 493.8 533.7 568.7 578.4 581.1 5800.4 7417.1 7491.4 7526.0 7978.8 481.4 491.2 503.5 533.9 536.5 3630.4 3671.3 3731.3 3762.4 3779.0 71110.0 76738.6 77080.2 77329.0 80219.6 68537.7 71127.0 71281.3 71734.0 72233.0 62107.0 62122.0 62545.7 62629.7 62897.0 7283.8 7333.8 7339.0 7359.8 7430.0 38428.7 38569.2 38585.6 40419.0 40987.4 54424.7 54543.5 56170.2 56628.3 58509.7 9414.5 9519.4 9529.7 9546.3 9880.6 10189.6 10276.6 10414.5 10504.6 10796.0 9893.4 9912.5 9946.2 9962.5 10011.7 9622.8 9626.8 9907.6 9927.9 9986.9 9650.4 9742.4 9743.0 10045.7 10102.2 8219.7 8329.5 8469.2 8660.7 8680.8 7919.6 8230.6 8356.8 8531.5 8652.6 04:03:42 INFO - PROCESS | 7143 | -------- Summary: end -------- 04:03:42 INFO - PROCESS | 7143 | 04:03:43 INFO - TEST-INFO | 7143: exit 0 04:03:43 INFO - TEST-OK | dromaeo_css | took 1114216ms 04:03:43 INFO - TEST-START | kraken 04:03:43 INFO - operating with platform_type : mac_ 04:03:43 INFO - Initialising browser for kraken test... 04:03:43 INFO - TEST-INFO | started process 7152 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmpGGhwLl/profile http://localhost:64246/getInfo.html) 04:03:45 INFO - PROCESS | 7152 | __metrics Screen width/height:1600/1200 04:03:45 INFO - PROCESS | 7152 | colorDepth:24 04:03:45 INFO - PROCESS | 7152 | Browser inner width/height: 1024/689 04:03:45 INFO - PROCESS | 7152 | __metrics 04:03:45 INFO - PROCESS | 7152 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:03:45 ERROR - PROCESS | 7152 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:03:46 INFO - TEST-INFO | 7152: exit 0 04:03:46 INFO - Browser initialized. 04:03:46 INFO - Running cycle 1/1 for kraken test... 04:03:46 INFO - TEST-INFO | started process 7154 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmpGGhwLl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:03:58 INFO - PROCESS | 7154 | RSS: Main: 237649920 04:03:58 INFO - PROCESS | 7154 | 04:04:00 INFO - PROCESS | 7154 | Cycle 1(1): loaded http://localhost:64246/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:64246/tests/kraken/driver.html?testName=audio-beat-detection) 04:04:01 INFO - PROCESS | 7154 | RSS: Main: 285917184 04:04:01 INFO - PROCESS | 7154 | 04:04:04 INFO - PROCESS | 7154 | Cycle 1(1): loaded http://localhost:64246/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:64246/tests/kraken/driver.html?testName=audio-dft) 04:04:05 INFO - PROCESS | 7154 | RSS: Main: 298926080 04:04:05 INFO - PROCESS | 7154 | 04:04:08 INFO - PROCESS | 7154 | Cycle 1(1): loaded http://localhost:64246/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:64246/tests/kraken/driver.html?testName=audio-fft) 04:04:09 INFO - PROCESS | 7154 | RSS: Main: 385622016 04:04:09 INFO - PROCESS | 7154 | 04:04:11 INFO - PROCESS | 7154 | Cycle 1(1): loaded http://localhost:64246/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:64246/tests/kraken/driver.html?testName=audio-oscillator) 04:04:11 INFO - PROCESS | 7154 | RSS: Main: 286621696 04:04:11 INFO - PROCESS | 7154 | 04:04:13 INFO - PROCESS | 7154 | Cycle 1(1): loaded http://localhost:64246/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:64246/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:04:14 INFO - PROCESS | 7154 | RSS: Main: 290758656 04:04:14 INFO - PROCESS | 7154 | 04:04:17 INFO - PROCESS | 7154 | Cycle 1(1): loaded http://localhost:64246/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:64246/tests/kraken/driver.html?testName=imaging-darkroom) 04:04:17 INFO - PROCESS | 7154 | RSS: Main: 328892416 04:04:17 INFO - PROCESS | 7154 | 04:04:20 INFO - PROCESS | 7154 | Cycle 1(1): loaded http://localhost:64246/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:64246/tests/kraken/driver.html?testName=imaging-desaturate) 04:04:21 INFO - PROCESS | 7154 | RSS: Main: 330244096 04:04:21 INFO - PROCESS | 7154 | 04:04:23 INFO - PROCESS | 7154 | Cycle 1(1): loaded http://localhost:64246/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:64246/tests/kraken/driver.html?testName=json-parse-financial) 04:04:24 INFO - PROCESS | 7154 | RSS: Main: 327204864 04:04:24 INFO - PROCESS | 7154 | 04:04:26 INFO - PROCESS | 7154 | Cycle 1(1): loaded http://localhost:64246/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:64246/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:04:26 INFO - PROCESS | 7154 | RSS: Main: 320188416 04:04:26 INFO - PROCESS | 7154 | 04:04:28 INFO - PROCESS | 7154 | Cycle 1(1): loaded http://localhost:64246/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:64246/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:04:29 INFO - PROCESS | 7154 | RSS: Main: 327704576 04:04:29 INFO - PROCESS | 7154 | 04:04:31 INFO - PROCESS | 7154 | Cycle 1(1): loaded http://localhost:64246/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:64246/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:04:32 INFO - PROCESS | 7154 | RSS: Main: 329576448 04:04:32 INFO - PROCESS | 7154 | 04:04:35 INFO - PROCESS | 7154 | Cycle 1(1): loaded http://localhost:64246/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:64246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:04:36 INFO - PROCESS | 7154 | RSS: Main: 334606336 04:04:36 INFO - PROCESS | 7154 | 04:04:38 INFO - PROCESS | 7154 | Cycle 1(1): loaded http://localhost:64246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:64246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:04:39 INFO - PROCESS | 7154 | RSS: Main: 332054528 04:04:39 INFO - PROCESS | 7154 | 04:04:41 INFO - PROCESS | 7154 | Cycle 1(1): loaded http://localhost:64246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:64246/tests/kraken/driver.html?testName=ai-astar) 04:04:41 INFO - PROCESS | 7154 | RSS: Main: 395984896 04:04:41 INFO - PROCESS | 7154 | 04:04:41 INFO - PROCESS | 7154 | __start_tp_report 04:04:41 INFO - PROCESS | 7154 | _x_x_mozilla_page_load 04:04:41 INFO - PROCESS | 7154 | _x_x_mozilla_page_load_details 04:04:41 INFO - PROCESS | 7154 | |i|pagename|runs| 04:04:41 INFO - PROCESS | 7154 | |0;ai-astar;113;110;112;112;114;114;119;114;115;164 04:04:41 INFO - PROCESS | 7154 | |1;audio-beat-detection;160;120;159;190;120;146;165;146;198;120 04:04:41 INFO - PROCESS | 7154 | |2;audio-dft;188;187;186;186;182;183;178;183;186;185 04:04:41 INFO - PROCESS | 7154 | |3;audio-fft;72;78;87;92;56;57;61;80;86;54 04:04:41 INFO - PROCESS | 7154 | |4;audio-oscillator;88;96;146;78;77;77;127;78;76;115 04:04:41 INFO - PROCESS | 7154 | |5;imaging-gaussian-blur;88;84;88;85;86;84;89;84;86;84 04:04:41 INFO - PROCESS | 7154 | |6;imaging-darkroom;100;93;93;93;92;93;94;94;93;94 04:04:41 INFO - PROCESS | 7154 | |7;imaging-desaturate;85;85;87;85;87;85;84;88;86;88 04:04:41 INFO - PROCESS | 7154 | |8;json-parse-financial;56;60;58;57;79;87;85;95;56;57 04:04:41 INFO - PROCESS | 7154 | |9;json-stringify-tinderbox;66;67;85;111;107;86;69;70;71;71 04:04:41 INFO - PROCESS | 7154 | |10;stanford-crypto-aes;85;86;84;84;84;85;85;86;86;86 04:04:41 INFO - PROCESS | 7154 | |11;stanford-crypto-ccm;144;144;144;144;165;161;144;138;214;147 04:04:41 INFO - PROCESS | 7154 | |12;stanford-crypto-pbkdf2;170;170;169;171;169;171;168;169;172;167 04:04:41 INFO - PROCESS | 7154 | |13;stanford-crypto-sha256-iterative;67;69;71;77;100;94;101;76;69;68 04:04:41 INFO - PROCESS | 7154 | __end_tp_report 04:04:41 INFO - PROCESS | 7154 | __start_cc_report 04:04:41 INFO - PROCESS | 7154 | _x_x_mozilla_cycle_collect,1934 04:04:41 INFO - PROCESS | 7154 | __end_cc_report 04:04:41 INFO - PROCESS | 7154 | __startTimestamp1460718281551__endTimestamp 04:04:41 INFO - PROCESS | 7154 | 04:04:41 INFO - PROCESS | 7154 | ------- Summary: start ------- 04:04:41 INFO - PROCESS | 7154 | Number of tests: 14 04:04:41 INFO - PROCESS | 7154 | 04:04:41 INFO - PROCESS | 7154 | [#0] ai-astar Cycles:10 Average:118.70 Median:114.00 stddev:16.09 (14.1%) stddev-sans-first:16.93 04:04:41 INFO - PROCESS | 7154 | Values: 113.0 110.0 112.0 112.0 114.0 114.0 119.0 114.0 115.0 164.0 04:04:41 INFO - PROCESS | 7154 | 04:04:41 INFO - PROCESS | 7154 | [#1] audio-beat-detection Cycles:10 Average:152.40 Median:159.50 stddev:27.86 (17.5%) stddev-sans-first:29.41 04:04:41 INFO - PROCESS | 7154 | Values: 160.0 120.0 159.0 190.0 120.0 146.0 165.0 146.0 198.0 120.0 04:04:41 INFO - PROCESS | 7154 | 04:04:41 INFO - PROCESS | 7154 | [#2] audio-dft Cycles:10 Average:184.40 Median:186.00 stddev:2.95 (1.6%) stddev-sans-first:2.83 04:04:41 INFO - PROCESS | 7154 | Values: 188.0 187.0 186.0 186.0 182.0 183.0 178.0 183.0 186.0 185.0 04:04:41 INFO - PROCESS | 7154 | 04:04:41 INFO - PROCESS | 7154 | [#3] audio-fft Cycles:10 Average:72.30 Median:79.00 stddev:14.32 (18.1%) stddev-sans-first:15.19 04:04:41 INFO - PROCESS | 7154 | Values: 72.0 78.0 87.0 92.0 56.0 57.0 61.0 80.0 86.0 54.0 04:04:41 INFO - PROCESS | 7154 | 04:04:41 INFO - PROCESS | 7154 | [#4] audio-oscillator Cycles:10 Average:95.80 Median:77.50 stddev:25.07 (32.3%) stddev-sans-first:26.43 04:04:41 INFO - PROCESS | 7154 | Values: 88.0 96.0 146.0 78.0 77.0 77.0 127.0 78.0 76.0 115.0 04:04:41 INFO - PROCESS | 7154 | 04:04:41 INFO - PROCESS | 7154 | [#5] imaging-gaussian-blur Cycles:10 Average:85.80 Median:86.00 stddev:1.93 (2.2%) stddev-sans-first:1.88 04:04:41 INFO - PROCESS | 7154 | Values: 88.0 84.0 88.0 85.0 86.0 84.0 89.0 84.0 86.0 84.0 04:04:41 INFO - PROCESS | 7154 | 04:04:41 INFO - PROCESS | 7154 | [#6] imaging-darkroom Cycles:10 Average:93.90 Median:93.00 stddev:2.23 (2.4%) stddev-sans-first:0.67 04:04:41 INFO - PROCESS | 7154 | Values: 100.0 93.0 93.0 93.0 92.0 93.0 94.0 94.0 93.0 94.0 04:04:41 INFO - PROCESS | 7154 | 04:04:41 INFO - PROCESS | 7154 | [#7] imaging-desaturate Cycles:10 Average:86.00 Median:86.50 stddev:1.41 (1.6%) stddev-sans-first:1.45 04:04:41 INFO - PROCESS | 7154 | Values: 85.0 85.0 87.0 85.0 87.0 85.0 84.0 88.0 86.0 88.0 04:04:41 INFO - PROCESS | 7154 | 04:04:41 INFO - PROCESS | 7154 | [#8] json-parse-financial Cycles:10 Average:69.00 Median:69.50 stddev:15.58 (22.4%) stddev-sans-first:15.80 04:04:41 INFO - PROCESS | 7154 | Values: 56.0 60.0 58.0 57.0 79.0 87.0 85.0 95.0 56.0 57.0 04:04:41 INFO - PROCESS | 7154 | 04:04:41 INFO - PROCESS | 7154 | [#9] json-stringify-tinderbox Cycles:10 Average:80.30 Median:70.50 stddev:16.66 (23.6%) stddev-sans-first:16.85 04:04:41 INFO - PROCESS | 7154 | Values: 66.0 67.0 85.0 111.0 107.0 86.0 69.0 70.0 71.0 71.0 04:04:41 INFO - PROCESS | 7154 | 04:04:41 INFO - PROCESS | 7154 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:85.50 stddev:0.88 (1.0%) stddev-sans-first:0.93 04:04:41 INFO - PROCESS | 7154 | Values: 85.0 86.0 84.0 84.0 84.0 85.0 85.0 86.0 86.0 86.0 04:04:41 INFO - PROCESS | 7154 | 04:04:41 INFO - PROCESS | 7154 | [#11] stanford-crypto-ccm Cycles:10 Average:154.50 Median:145.50 stddev:22.54 (15.5%) stddev-sans-first:23.58 04:04:41 INFO - PROCESS | 7154 | Values: 144.0 144.0 144.0 144.0 165.0 161.0 144.0 138.0 214.0 147.0 04:04:41 INFO - PROCESS | 7154 | 04:04:41 INFO - PROCESS | 7154 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.60 Median:170.00 stddev:1.51 (0.9%) stddev-sans-first:1.59 04:04:41 INFO - PROCESS | 7154 | Values: 170.0 170.0 169.0 171.0 169.0 171.0 168.0 169.0 172.0 167.0 04:04:41 INFO - PROCESS | 7154 | 04:04:41 INFO - PROCESS | 7154 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:79.20 Median:70.00 stddev:13.71 (19.6%) stddev-sans-first:13.81 04:04:41 INFO - PROCESS | 7154 | Values: 67.0 69.0 71.0 77.0 100.0 94.0 101.0 76.0 69.0 68.0 04:04:41 INFO - PROCESS | 7154 | -------- Summary: end -------- 04:04:41 INFO - PROCESS | 7154 | 04:04:42 INFO - TEST-INFO | 7154: exit 0 04:04:42 INFO - TEST-OK | kraken | took 59134ms 04:04:42 INFO - SUITE-END | took 1173s 04:04:42 INFO - Completed test suite (00:19:33) 04:04:42 INFO - javascript benchmark 04:04:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3348.4140275451796, 3375.4599264117746, 3407.182276253699, 3413.8463769130385, 3425.725941924646, 5563.0, 5684.090545512714, 5685.800996965107, 5719.828405147852, 5735.225744524493, 5691.601587888849, 5694.5159661428725, 5734.913976290359, 5783.82648520544, 5800.82597522074, 5070.797168113271, 5084.669496482717, 5107.387113546361, 5112.437631860493, 5223.817166399177, 5217.86955326118, 5245.659032162897, 5255.185446255837, 5255.921161182585, 5298.337707786527, 5082.974585127087, 5127.717975511346, 5158.664686795346, 5175.585953123741, 5191.117510023286, 5023.196288593807, 5100.846974590768, 5135.897282054375, 5155.149400348938, 5167.0957582422925, 5069.695818250917, 5081.974590127025, 5109.693418394908, 5182.714950677711, 5205.0, 5450.645708028966, 5578.41426650204, 5603.551715862762, 5609.76585151266, 5620.803271885506, 6072.735419311495, 6093.0, 6123.418275263843, 6151.292601350812, 6172.043333283348, 6050.0, 6110.7861224856915, 6129.417705317987, 6135.171751813493, 6138.8643101026455, 5667.829965101054, 5763.077907534775, 5765.221695071154, 5766.855828604276, 5770.855728606818, 6163.568550201443, 6211.0372892201785, 6234.750609975641, 6246.531510136758, 6253.749850005949, 6040.395960403925, 6049.092636104531, 6085.0, 6089.543284253698, 6096.0, 5433.945660543344, 6028.879422411527, 6165.136880836686, 6180.598261113103, 6190.50475961922, 6080.2399700037495, 6123.557162997564, 6127.097902969389, 6157.907631385533, 6166.260048794174, 6102.655998083295, 6175.197224360804, 6178.62928224308, 6182.814515564541, 6191.4118158774845, 4790.089882922303, 4889.315495830587, 4899.779509922062, 4903.901921961612, 4933.87665308363, 4405.449318835145, 4424.778761061934, 4436.223660859337, 4456.732596044248, 4474.6867719259335, 5593.608447408642, 5595.328560572757, 5602.159676048544, 5608.383077861432, 5610.97194514033, 6109.708332504907, 6174.783882564178, 6177.351378105234, 6178.598391104564, 6179.474744646665, 5584.106542953108, 5631.127175287755, 5631.211630371751, 5631.465010823965, 5647.887042259132, 5312.76092575835, 5318.680879147263, 5329.626926115135, 5332.226827110047, 5347.4712409296835, 5120.411152717411, 6257.7184026719815, 6279.215098112736, 6293.622382657055, 6293.905591416133, 6179.3202747698615, 6196.132541444112, 6196.504279657526, 6204.348543402878, 6224.751009959732, 6286.905696414466, 6289.339619340087, 6291.905621415591, 6295.213098362705, 6303.243610766737, 6012.8797424052145, 6032.6983650818165, 6081.422264884829, 6131.019036954066, 6142.161149281699, 6141.7543298267565, 6150.50795936333, 6155.630662160284, 6159.29168145669, 6176.135341052346, 4765.523447655207, 6008.969955150196, 6016.2479690038745, 6028.0, 6086.6652334122045, 5897.997340452048, 5978.402159784161, 6029.909551356821, 6047.727852246748, 6101.633901965896, 5861.824145275648, 5863.120531920246, 5895.764169433346, 5921.733521991435, 5927.940720592739, 5900.7049647518315, 6044.848878778066, 6062.090686397076, 6066.211392519121, 6127.387261273837, 5738.885222295447, 5854.882902342015, 5855.443732845373, 5858.47273745348, 5859.5019423349495], "value": 5631.859534303241, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [490.04930434956185, 491.46921324969037, 496.27543786072357, 498.0984418203055, 507.9441261461237, 28622.855085796567, 31047.0, 39450.8027459863, 40139.982502187224, 40218.39672404916, 42407.36388954168, 43006.56993430065, 43115.35326970098, 43154.0, 43167.0, 9558.999999999982, 9763.121319081281, 9768.511574421285, 9768.706938791813, 9782.657606983757, 9591.808163836718, 9687.951560242189, 9733.902660973406, 9756.024397560259, 9759.072888075658, 9802.754931126708, 9866.605335786597, 9874.555644995957, 9884.159846413027, 9887.011298870128, 9796.706098817047, 9853.655122070693, 9863.852042219336, 9865.0, 9866.703998880044, 9614.71155865325, 9741.561629726679, 9745.12293893553, 9748.805023899553, 9773.755656108584, 39190.0, 39453.21093578112, 39481.60518394808, 39518.60481395178, 39539.60460395388, 3199.3441344524317, 3224.3712476067176, 3405.7786243894066, 3476.2526056897887, 3740.401535754266, 29115.854420727974, 29243.85378073096, 29591.408171836658, 29810.956616518317, 30169.396612067856, 2664.2406914029407, 2743.6021776842244, 2746.5468197747346, 2747.4779791839687, 2837.815541989764, 447010.0, 449754.0, 449864.0, 450291.0, 450538.0, 63707.681461592394, 64001.35998639954, 64053.0, 64087.0, 64228.678856606355, 67367.0, 69731.0, 71680.2831971684, 71792.0, 71831.0, 17077.316907323817, 17094.487165385057, 17327.740083898752, 17331.0, 17394.47816565505, 12802.743945121045, 12849.10056296069, 12890.677733056562, 12891.16207446513, 12933.417996190194, 20105.79894201039, 20126.89936550308, 20127.39617811468, 20166.899165504372, 20182.0, 6418.839529011812, 6754.729810807513, 7989.961305030425, 8154.347652187811, 8185.263326300662, 947.1428357336621, 1001.639409812467, 1042.8957104289511, 1131.728385187549, 1141.5490881101919, 29840.850795745882, 29949.700502995125, 30185.849070754946, 30527.08418747441, 30689.38621227563, 1048.6539441984128, 1062.39443517196, 1085.3216739537788, 1115.726646971481, 1126.2510430563748, 15573.299201535958, 15584.688306233811, 15666.295016724274, 15877.841221587636, 15885.602859928595, 605238.0, 613756.0, 615610.0, 616621.0, 617652.0, 59858.0, 62561.0, 62599.37400626027, 62625.74748505095, 62711.37288627146, 1223.2660403757852, 1320.544412177797, 1454.2365258239508, 1455.2796365798786, 1499.317810396289, 29757.404851902407, 30309.39381212319, 30516.0, 30588.66916513838, 30876.0, 51988.480115199876, 52769.20846187234, 53310.93378132338, 53318.0, 53454.46545534495, 452711.0, 462834.0, 466522.68034536665, 466740.0, 466845.66577166895, 42654.36018459663, 42870.78564607157, 43005.56994430016, 43798.56201437945, 43870.12259754851, 46651.766741167434, 47065.2940205904, 47310.0, 47811.76094119507, 48861.51138488569, 38175.0, 38177.61822381741, 38255.61744382632, 39479.80260098681, 39592.208155837296, 30944.69055309418, 33162.010279383314, 37672.43491347577, 38173.61826381701, 39306.803465982484, 37715.245695086494, 37776.244475109794, 38241.2351752969, 38382.42426363551, 38652.6134738649, 31012.22469438282, 32583.348333033682, 33269.50095748517, 33977.66022339745, 34009.48985765265, 24575.0, 25144.11995580146, 25669.358266042753, 25687.743122568536, 25787.613185801853], "value": 20209.97336622314, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.7114110723669, 370.4073482428115, 389.91032062625595, 399.8980260033691, 410.5524977774229, 12973.805392919114, 16030.7595386069, 19067.618647627056, 20604.587908241843, 20610.99999999998, 17748.378806741766, 19945.0, 19987.100580473878, 20326.882021488847, 20340.694889576633, 5288.312519372485, 5916.497097746696, 5948.048312270038, 5951.702414879261, 5954.642721436728, 3712.1462063725226, 5405.648632838873, 6197.349278325756, 6546.607203567777, 6585.769498067569, 6364.268109167436, 6488.935110648904, 6528.673566321689, 6543.770968016121, 6544.2801291858095, 6284.87430251397, 6472.6763661817195, 6499.350064993463, 6500.407400186938, 6512.023196520512, 5447.809326673548, 5707.400722924116, 5711.971440142815, 5744.224529688522, 5747.252857128547, 24936.0, 25197.748022519907, 25431.61852572213, 25920.0, 26049.479010419687, 2194.1004188282886, 2461.052494789501, 2651.2178907222224, 2709.498742732581, 3090.211995941043, 14194.0, 14563.70872582553, 14746.115233085942, 14841.183734894577, 15408.3836646534, 1689.9746503802453, 1754.1054062428254, 1757.6295297622373, 1811.1306572845108, 1813.718873574598, 102510.0, 107583.0, 108469.45765271202, 114638.0, 118727.99999999914, 9830.672859164064, 11265.26775759573, 11381.203315767816, 11395.943020284845, 11485.885141148648, 14963.102213866985, 15106.169160696047, 15252.466163684217, 15260.542183734506, 15266.542003739905, 6933.4106600939485, 8672.523011234316, 8679.913200868037, 8799.736007919773, 8802.779930501789, 6141.662208578482, 8508.957455212685, 8536.658533658709, 8626.223639872316, 8635.6977505787, 4559.156556037144, 4588.908221835544, 4613.423322084739, 4619.076184762994, 4636.466806317249, 1643.6712657468315, 1900.5818719881604, 1952.384998725397, 1953.8729982551088, 1959.892205928659, 884.5002573545926, 918.669279059538, 941.2658126661215, 948.0803620488116, 1046.4035499765062, 16475.258613362428, 19151.52121196981, 20163.043749906257, 20328.390148295573, 20714.0, 967.5210770668424, 980.9705708828747, 987.8073775613686, 1001.8948010458797, 1024.8052869954686, 8963.148500892405, 9599.712008639752, 11104.333739975627, 11118.0, 11152.888471115184, 509817.0, 517374.0, 518283.0, 545964.0, 586657.0, 127949.0, 136519.0, 136739.0, 137332.0, 140567.0, 437.9737215767064, 458.7064278861531, 460.1349463009521, 461.12156342168225, 461.3172504693006, 7714.4599878008, 9812.675288835915, 9851.901480985385, 11081.778364432828, 11362.14783891228, 36668.81665591655, 45868.0, 47358.0, 48088.75955620199, 49415.0, 65446.345536544024, 66419.33580664324, 67456.6627166861, 68346.0, 68643.97034044394, 8041.155678653658, 8047.356211502949, 8101.432899696964, 8315.376346773895, 8344.749657510285, 11169.776604468028, 12291.32397718134, 12469.376531173224, 12673.746525069262, 12691.428885699981, 9873.160781333667, 10553.472326383497, 10700.304480209074, 10846.24076314682, 10998.835017474585, 9908.058734420218, 10271.537780800032, 10410.063094321547, 10525.842112368167, 10903.890961090288, 10631.8936810634, 10882.727931801768, 11221.326720396803, 11447.656570302905, 11490.195686301879, 8144.429889907649, 8147.551884646165, 8274.544900030556, 8323.167683231628, 8537.31701463869, 9539.76150596213, 10970.286931349438, 11025.117990560575, 11025.944870275598, 11071.50178241965], "value": 9156.534393830247, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1410.027081313894, 1578.7868637733907, 1612.4275882061868, 1827.132112246683, 1959.8922059286742, 7025.402840758536, 7906.92093079069, 8756.343274254425, 8768.254698350647, 8773.912260877381, 8371.91628083719, 8618.827623447527, 8621.439606425578, 8625.26685231756, 8641.611127499262, 2143.67844823277, 2386.737458879522, 2434.756524347564, 2452.877356132195, 2460.4709987352717, 2452.2275483222816, 2472.171822439485, 2478.7893029092547, 2479.5536803375385, 2479.6404521344393, 2004.1983206717284, 2355.199232261031, 2401.327628264089, 2401.7238017628024, 2402.3873912152376, 2127.957440851182, 2344.1326709117734, 2419.4677171022345, 2421.128393778238, 2430.222328854767, 2360.2683168217736, 2386.737458879522, 2388.9522209555885, 2393.5452264069945, 2394.988025059881, 8558.315334773204, 8625.913740862574, 8637.222649961534, 8637.39538232324, 8639.39524233304, 5108.897822043576, 5191.792328306863, 5278.736063196825, 5287.920681189786, 5311.521963023347, 2853.857307134656, 3401.693847553732, 3470.4273794823825, 3475.6176820549717, 3482.2687235680537, 1000.3447741729179, 1000.5547531348553, 1013.083159740436, 1014.7463134216446, 1019.1744686803713, 11633.6509904703, 11657.591984280509, 11703.356315402649, 11735.295882247092, 11737.0, 4387.890302742393, 4616.169089563844, 4618.95381046192, 4815.374001379798, 4860.902781944412, 9783.36408133469, 9845.261605379625, 9855.26085543587, 9873.358231714916, 9896.653617123366, 5100.413452453015, 5106.131957567148, 5114.667546609458, 5123.205903085028, 5136.768845401966, 4366.781660916941, 4536.228841097021, 4684.203685373494, 4860.708357498491, 4877.561019508261, 3912.6087391260644, 3933.7246392752804, 4026.0, 4040.252553277653, 4057.8435145983253, 1301.1607513154152, 1326.5025615394227, 1333.0735139078442, 1334.6463187255385, 1338.8393392792927, 755.9055118110236, 878.8593824987971, 917.3761841947539, 917.9678711245074, 947.488356287597, 5777.133429985536, 5782.450667186695, 5824.767009319579, 6096.908546371808, 6109.450149486479, 887.9689210877589, 910.6266430763355, 917.8531434970373, 937.4328531238502, 949.0888746803147, 3767.9811600942367, 3810.466534685146, 3885.941710874339, 3895.5325360956867, 3961.5840336764227, 8715.38992270535, 10497.212709046851, 10551.261411701107, 10560.947195263974, 10728.195385346131, 10644.574217031231, 10653.893461065445, 10656.20078494116, 10670.199735019905, 10670.839937400946, 8056.959715201387, 8108.310793582494, 8189.50862948225, 8300.04549476818, 8311.044229913516, 5618.915716264341, 5797.565182611237, 5817.738201780845, 5839.416058394127, 5848.824535263949, 9775.804483910424, 9805.068518490732, 9989.100980911753, 10008.299419040597, 10015.549300281358, 10032.046955539212, 10054.0, 10179.796404071729, 10317.226208034577, 10324.174066074846, 6758.121444212221, 6959.304069593203, 7043.084399028094, 7234.74678386254, 7339.889901651372, 8140.470869393471, 8151.062627797879, 8220.917790822015, 8225.547594882339, 8230.135835737161, 6993.580385176906, 7109.680064397218, 7130.108736407949, 7240.855182896418, 7260.382867456326, 7295.2340004298785, 7367.846870971026, 7369.336759691653, 7377.114746230487, 7414.888776668462, 6864.347886950732, 6902.206246281742, 6958.443324533924, 6962.477814163856, 6966.895496567454, 3966.9206615868097, 4813.687110337817, 4891.90216195667, 4960.70235785854, 5068.949310506995, 4813.687110337817, 4836.419629644465, 4838.637102217418, 4896.436909755424, 5056.988602279485], "value": 4537.871000998901, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.3467201540756, 316.11487834064616, 319.39155907995263, 324.7629230661617, 329.49587131688526, 5706.429357064291, 5765.7981970631035, 5778.133280008001, 5779.971100144493, 5791.7972870949525, 4747.3353730477675, 5621.353544342402, 5650.316099852568, 5667.433256674331, 5677.233573467581, 3528.9294214115703, 4016.49793775778, 4062.2078694654406, 4151.529839745362, 4189.308764053927, 4183.477065366829, 4233.788310584474, 4264.360345948117, 4293.29160688486, 4295.291276939317, 3546.556680414948, 4265.552117027699, 4278.957210427902, 4282.972086699201, 4310.245707001278, 4027.2750904837117, 4070.715049946505, 4276.5295817460055, 4298.978505107454, 4306.590873866978, 3418.9658103418897, 3687.1888184599347, 3702.685271751904, 3704.1480459494196, 3719.5722491913234, 4723.433188017426, 4817.5080408334525, 5407.621466497347, 5455.0, 5462.481064298885, 3658.2623253954157, 4485.439320084989, 4860.878478038042, 4873.902521949542, 4938.259261110827, 5366.302380690524, 5413.079776437976, 5678.318601767773, 5937.495312898409, 5971.761129554812, 3355.3792548378383, 4011.509986311898, 4022.7184097113213, 4034.3141665916864, 4042.3734321180264, 6038.0, 6198.845028874314, 6232.75068997235, 6308.804644911174, 6345.143405640226, 3710.5176327077847, 3797.411401232813, 4051.3261247576456, 4074.246264441088, 4091.2384140704903, 4124.443200167999, 4149.460570125864, 4154.459920210414, 4158.563350848178, 4169.10364271683, 4704.388429504143, 4868.902621947612, 4878.195097808893, 4959.479254678206, 4966.379202599675, 5428.941356435457, 5958.851028724316, 5997.551407940452, 6110.388961103854, 6129.601575897553, 1472.9337179826935, 1497.7229212595705, 1505.510709019573, 1507.9246037698072, 1508.8566586174295, 880.8592872230477, 935.8455854784021, 953.580424613168, 998.5306905754284, 1027.409239687183, 4172.415861779354, 5169.741512924339, 5410.78356865721, 5560.805371812048, 5634.830955071355, 6265.216847894013, 6369.426751592379, 6371.808845734636, 6377.457916077093, 6382.648954307558, 4701.741404222732, 5679.460451257124, 5680.147977803363, 5690.260266165372, 5696.829095127153, 3160.9683903161135, 3299.3896129216173, 3303.785253958485, 3311.2053107254087, 3345.749068819848, 5752.827415177551, 6234.563580549318, 6580.8354791130605, 6626.370494802986, 6628.8674226515195, 6482.708278127496, 6496.902546461807, 6504.447121994589, 6515.543911926215, 6537.477001839841, 5427.701476418756, 5495.642783219078, 5739.598228124075, 6473.676316184172, 6604.207495100619, 6022.608530445507, 6104.969475152596, 6190.41191086846, 6227.813165605039, 6335.588186767845, 4886.389201349832, 5154.742262886915, 5413.941123265343, 5958.136070269873, 6116.776644670995, 6460.0, 6464.46536182092, 6552.921485848506, 6597.769078082244, 6618.536702430976, 3739.1773809761808, 4033.153037862082, 4059.817308221078, 4069.8575549855614, 4073.3889916512762, 5261.89476210466, 6177.2587289525545, 6265.906011409741, 6308.747650093945, 6353.301136875032, 4582.266837306015, 5584.274044374205, 5876.294844618673, 6023.187623942916, 6122.357152499102, 5352.277442545206, 5851.377411844765, 6085.148079268817, 6085.604435711664, 6102.267727872683, 4630.665920537208, 5979.790707325223, 5982.46157845796, 5992.221011268507, 5998.1105951625095, 5506.669599824023, 5901.793437229677, 5938.2280303560265, 6045.581767293118, 6073.665948372882, 4687.695299805502, 5310.867228319168, 5605.215269862141, 5964.9105263420215, 5972.104184372379], "value": 4373.070940388444, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [672.7107343842148, 717.9856402871945, 749.2239114861101, 755.8790593505037, 807.047683733195, 15539.456119035836, 15567.143807090606, 15587.298571564279, 15599.22003899806, 15609.843901560995, 14534.200618965953, 14583.0, 14630.195339256337, 14650.120992740443, 14667.633309167277, 711.1501755402296, 731.2869951796982, 872.8777971084053, 908.7682640926571, 921.7004473546091, 904.8235594059161, 908.3051465628766, 909.0273407454027, 909.2135302962922, 909.5361365703505, 953.7424895278306, 975.9609615615367, 976.5947131940236, 979.8138353712808, 980.6665733650557, 753.3220101908299, 929.1359036096428, 959.2613687460686, 966.5457235099492, 967.9661211857587, 724.1635910523354, 724.4675163754636, 726.8982342472058, 727.752564128199, 728.8505856299446, 14883.33025013877, 14918.850811491855, 14979.0, 14979.850201497955, 15001.774973375408, 12605.30670813105, 12689.365531723377, 12897.613071607866, 12917.160384574972, 13037.348132593332, 8143.592820358958, 9925.002872974535, 10173.440460774655, 10291.382517048925, 10733.034026937614, 3507.018034950218, 3552.5559305086863, 3558.3417067842274, 3660.158163622355, 3660.9816950915074, 78781.60609196975, 79517.0, 81379.5931020347, 81775.0, 82063.58968205121, 9489.810203796023, 9502.524873756285, 9674.854877176847, 9834.901650983398, 10209.846852297222, 22123.778762212492, 22267.77732222657, 22283.442913926956, 22297.44256393603, 22332.33003009912, 7575.886361704579, 7625.961870190614, 7830.0, 7861.842763144705, 7966.243206895336, 4054.5134583850127, 4132.483439570054, 4134.855280065183, 4139.027328577782, 4144.730592511477, 3500.8774692885627, 3613.5483064616924, 3615.5480564929385, 3616.9276614467562, 3618.3667858124722, 615.3876892491999, 628.6039794929256, 631.8799428108645, 646.2987658390605, 654.2051407539861, 493.767929073335, 533.6797921247221, 568.6957477749385, 578.4013545979891, 581.0702875399412, 5800.448957349129, 7417.109946806418, 7491.3632341251605, 7526.0, 7978.84042319162, 481.3573878871745, 491.2287708297938, 503.5266849161776, 533.8692020455013, 536.4983740202845, 3630.419132938717, 3671.3391589514144, 3731.2910546995986, 3762.360398732222, 3779.0, 71110.0, 76738.61630691923, 77080.22919770842, 77329.0, 80219.59890200512, 68537.65731171412, 71127.0, 71281.2871871285, 71734.0, 72233.0, 62107.0, 62122.0, 62545.68727156335, 62629.68685156636, 62897.0, 7283.817904552428, 7333.779986600411, 7338.96330518344, 7359.77920662381, 7430.0, 38428.71987530488, 38569.228615428096, 38585.614143858205, 40419.0, 40987.38518922278, 54424.72787636037, 54543.454565455424, 56170.15744763913, 56628.30115096553, 58509.70745146247, 9414.53924880716, 9519.428834269966, 9529.714108576754, 9546.284028697737, 9880.604775808888, 10189.643362482277, 10276.640317588848, 10414.479276036016, 10504.579816807547, 10796.028357447867, 9893.406395616286, 9912.454814985245, 9946.204303655546, 9962.50187490608, 10011.699649010541, 9622.807543849223, 9626.759331016501, 9907.554160062671, 9927.900720992697, 9986.850197246902, 9650.372725772802, 9742.415455072718, 9743.0, 10045.748856278651, 10102.242331824995, 8219.671213151647, 8329.458585191944, 8469.195426434479, 8660.653573856975, 8680.826383472422, 7919.574476594268, 8230.588470576327, 8356.7910802228, 8531.53076580794, 8652.56737163152], "value": 6518.057959760305, "unit": "score"}], "name": "dromaeo_css", "value": 7160.745255500684, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 110.0, 112.0, 112.0, 114.0, 114.0, 119.0, 114.0, 115.0, 164.0], "value": 118.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 120.0, 159.0, 190.0, 120.0, 146.0, 165.0, 146.0, 198.0, 120.0], "value": 152.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 187.0, 186.0, 186.0, 182.0, 183.0, 178.0, 183.0, 186.0, 185.0], "value": 184.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 78.0, 87.0, 92.0, 56.0, 57.0, 61.0, 80.0, 86.0, 54.0], "value": 72.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 96.0, 146.0, 78.0, 77.0, 77.0, 127.0, 78.0, 76.0, 115.0], "value": 95.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 88.0, 85.0, 86.0, 84.0, 89.0, 84.0, 86.0, 84.0], "value": 85.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 93.0, 93.0, 93.0, 92.0, 93.0, 94.0, 94.0, 93.0, 94.0], "value": 93.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 87.0, 85.0, 87.0, 85.0, 84.0, 88.0, 86.0, 88.0], "value": 86.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 60.0, 58.0, 57.0, 79.0, 87.0, 85.0, 95.0, 56.0, 57.0], "value": 69.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 85.0, 111.0, 107.0, 86.0, 69.0, 70.0, 71.0, 71.0], "value": 80.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 84.0, 84.0, 84.0, 85.0, 85.0, 86.0, 86.0, 86.0], "value": 85.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 144.0, 144.0, 144.0, 165.0, 161.0, 144.0, 138.0, 214.0, 147.0], "value": 154.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 170.0, 169.0, 171.0, 169.0, 171.0, 168.0, 169.0, 172.0, 167.0], "value": 169.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 71.0, 77.0, 100.0, 94.0, 101.0, 76.0, 69.0, 68.0], "value": 79.2, "unit": "score"}], "name": "kraken", "value": 1526.9999999999998, "alertThreshold": 2.0}]} 04:04:42 INFO - Return code: 0 04:04:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:04:42 ERROR - # TBPL SUCCESS # 04:04:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:04:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:04:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:04:42 INFO - 2016-04-15 04:04:42.878 screenresolution[7158:133018] starting screenresolution argv=screenresolution get 04:04:42 INFO - 2016-04-15 04:04:42.880 screenresolution[7158:133018] Display 0: 1600x1200x32@60 04:04:42 INFO - 2016-04-15 04:04:42.886 screenresolution[7159:133021] starting screenresolution argv=screenresolution list 04:04:42 INFO - Available Modes on Display 0 04:04:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:04:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:04:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:04:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:04:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:04:43 INFO - Intel Iris: 04:04:43 INFO - Chipset Model: Intel Iris 04:04:43 INFO - Type: GPU 04:04:43 INFO - Bus: Built-In 04:04:43 INFO - VRAM (Dynamic, Max): 1536 MB 04:04:43 INFO - Vendor: Intel (0x8086) 04:04:43 INFO - Device ID: 0x0a2e 04:04:43 INFO - Revision ID: 0x0009 04:04:43 INFO - Displays: 04:04:43 INFO - Display: 04:04:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:04:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:04:43 INFO - Display Serial Number: 1600x1200 60 04:04:43 INFO - Main Display: Yes 04:04:43 INFO - Mirror: Off 04:04:43 INFO - Online: Yes 04:04:43 INFO - Rotation: Supported 04:04:43 INFO - Return code: 0 04:04:43 INFO - Running post-action listener: _resource_record_post_action 04:04:43 INFO - Running post-run listener: _resource_record_post_run 04:04:44 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 1335296; Write bytes: 694814720; Read time: 19; Write time: 1911 04:04:44 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 394816000; Write bytes: 397063680; Read time: 29362; Write time: 703 04:04:44 INFO - run-tests - Wall time: 1176s; CPU: 53.0%; Read bytes: 1335296; Write bytes: 296903168; Read time: 19; Write time: 1205 04:04:44 INFO - Running post-run listener: _upload_blobber_files 04:04:44 INFO - Blob upload gear active. 04:04:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:04:44 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 04:04:44 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'] 04:04:44 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 04:04:44 INFO - (blobuploader) - INFO - Open directory for files ... 04:04:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:04:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:04:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:04:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:04:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:04:45 INFO - (blobuploader) - INFO - Done attempting. 04:04:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:04:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:04:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:04:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:04:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:04:46 INFO - (blobuploader) - INFO - Done attempting. 04:04:46 INFO - (blobuploader) - INFO - Iteration through files over. 04:04:46 INFO - Return code: 0 04:04:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:04:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:04:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/159dc5d85ba6d0cd13ad249ceced75165c15a50ce2ba37dd5cdf2ffc501d2b8b3f4608d285ac114005ce88c8a80366e4f58f7066b18202c40153920071b560be", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/04603fb90326e4e8a55cac33cbc21233a4e060507852483b3eb6c120f1e4fa6fd879372f14f150d4d3f15700a13c821a2acb2a9504591a8e6e8ecf592377d3f1"} 04:04:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:04:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:04:46 INFO - Contents: 04:04:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/159dc5d85ba6d0cd13ad249ceced75165c15a50ce2ba37dd5cdf2ffc501d2b8b3f4608d285ac114005ce88c8a80366e4f58f7066b18202c40153920071b560be", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/04603fb90326e4e8a55cac33cbc21233a4e060507852483b3eb6c120f1e4fa6fd879372f14f150d4d3f15700a13c821a2acb2a9504591a8e6e8ecf592377d3f1"} 04:04:46 INFO - Running post-run listener: copy_logs_to_upload_dir 04:04:46 INFO - Copying logs to upload dir... 04:04:46 INFO - mkdir: /builds/slave/test/build/upload/logs 04:04:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.065654 ========= master_lag: 23.15 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 30 secs) (at 2016-04-15 04:05:09.952530) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 04:05:09.956635) ========= 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.hRW2vyMvDd/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.jAOh8sckQl/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/159dc5d85ba6d0cd13ad249ceced75165c15a50ce2ba37dd5cdf2ffc501d2b8b3f4608d285ac114005ce88c8a80366e4f58f7066b18202c40153920071b560be", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/04603fb90326e4e8a55cac33cbc21233a4e060507852483b3eb6c120f1e4fa6fd879372f14f150d4d3f15700a13c821a2acb2a9504591a8e6e8ecf592377d3f1"} build_url:https://queue.taskcluster.net/v1/task/PlPF6wH1SqurAMmEVhKS_g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011427 build_url: 'https://queue.taskcluster.net/v1/task/PlPF6wH1SqurAMmEVhKS_g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/159dc5d85ba6d0cd13ad249ceced75165c15a50ce2ba37dd5cdf2ffc501d2b8b3f4608d285ac114005ce88c8a80366e4f58f7066b18202c40153920071b560be", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/04603fb90326e4e8a55cac33cbc21233a4e060507852483b3eb6c120f1e4fa6fd879372f14f150d4d3f15700a13c821a2acb2a9504591a8e6e8ecf592377d3f1"}' ========= master_lag: 0.11 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 04:05:10.080335) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 04:05:10.080665) ========= 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.hRW2vyMvDd/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.jAOh8sckQl/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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.005376 ========= master_lag: 0.03 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 04:05:10.117155) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 04:05:10.117469) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 04:05:10.123952) ========= ========= Total master_lag: 23.36 =========